{"level":"warn","ts":"2026-05-24T09:56:59.532461Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-24T09:56:59.532549Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19: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.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-24T09:56:59.532612Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-24T09:56:59.532625Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-05-24T09:56:59.532646Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-24T09:56:59.533346Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]} {"level":"info","ts":"2026-05-24T09:56:59.533425Z","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.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-24T09:56:59.538291Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.65235ms"} {"level":"info","ts":"2026-05-24T09:56:59.544911Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"} {"level":"info","ts":"2026-05-24T09:56:59.544988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"} {"level":"info","ts":"2026-05-24T09:56:59.545012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"} {"level":"info","ts":"2026-05-24T09:56:59.545031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-24T09:56:59.54504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"} {"level":"info","ts":"2026-05-24T09:56:59.545082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"warn","ts":"2026-05-24T09:56:59.554357Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-24T09:56:59.555781Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-24T09:56:59.556931Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-24T09:56:59.560715Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-24T09:56:59.564901Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-24T09:56:59.565009Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-24T09:56:59.56502Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-24T09:56:59.565142Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-24T09:56:59.56628Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-24T09:56:59.566989Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-24T09:56:59.567026Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-24T09:56:59.56724Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-05-24T09:56:59.567267Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-05-24T09:56:59.570719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"info","ts":"2026-05-24T09:56:59.570826Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-05-24T09:57:00.14617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"} {"level":"info","ts":"2026-05-24T09:57:00.146257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-24T09:57:00.146495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"} {"level":"info","ts":"2026-05-24T09:57:00.146548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"} {"level":"info","ts":"2026-05-24T09:57:00.146585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-05-24T09:57:00.146647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"} {"level":"info","ts":"2026-05-24T09:57:00.146669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-05-24T09:57:00.149355Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-24T09:57:00.149336Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-24T09:57:00.149783Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-24T09:57:00.150767Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"} {"level":"info","ts":"2026-05-24T09:57:00.150913Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-24T09:57:00.150945Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-24T09:57:00.152019Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-24T09:57:00.149293Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"} {"level":"info","ts":"2026-05-24T09:57:00.153001Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"} {"level":"info","ts":"2026-05-24T09:57:00.153496Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-24T09:57:00.153519Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-24T09:57:10.807607Z","caller":"traceutil/trace.go:171","msg":"trace[1205374846] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"115.239194ms","start":"2026-05-24T09:57:10.692338Z","end":"2026-05-24T09:57:10.807577Z","steps":["trace[1205374846] 'process raft request' (duration: 115.030976ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:10.807748Z","caller":"traceutil/trace.go:171","msg":"trace[1397738658] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"116.650931ms","start":"2026-05-24T09:57:10.691056Z","end":"2026-05-24T09:57:10.807707Z","steps":["trace[1397738658] 'process raft request' (duration: 76.056285ms)","trace[1397738658] 'compare' (duration: 40.054015ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T09:57:10.808188Z","caller":"traceutil/trace.go:171","msg":"trace[1532148908] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"113.586547ms","start":"2026-05-24T09:57:10.694565Z","end":"2026-05-24T09:57:10.808151Z","steps":["trace[1532148908] 'process raft request' (duration: 112.91293ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:10.978453Z","caller":"traceutil/trace.go:171","msg":"trace[882023063] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"116.802897ms","start":"2026-05-24T09:57:10.861612Z","end":"2026-05-24T09:57:10.978414Z","steps":["trace[882023063] 'process raft request' (duration: 47.770985ms)","trace[882023063] 'compare' (duration: 68.794843ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T09:57:10.978721Z","caller":"traceutil/trace.go:171","msg":"trace[1587382176] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"115.471654ms","start":"2026-05-24T09:57:10.863222Z","end":"2026-05-24T09:57:10.978694Z","steps":["trace[1587382176] 'process raft request' (duration: 115.11822ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:12.140207Z","caller":"traceutil/trace.go:171","msg":"trace[1753791484] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"125.640484ms","start":"2026-05-24T09:57:12.014532Z","end":"2026-05-24T09:57:12.140172Z","steps":["trace[1753791484] 'process raft request' (duration: 78.962156ms)","trace[1753791484] 'compare' (duration: 46.552192ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T09:57:24.962006Z","caller":"traceutil/trace.go:171","msg":"trace[97372780] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"546.135591ms","start":"2026-05-24T09:57:24.415845Z","end":"2026-05-24T09:57:24.96198Z","steps":["trace[97372780] 'process raft request' (duration: 545.58745ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:24.962589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:24.415833Z","time spent":"546.243216ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T09:57:25.265949Z","caller":"traceutil/trace.go:171","msg":"trace[2096010175] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"299.655008ms","start":"2026-05-24T09:57:24.966266Z","end":"2026-05-24T09:57:25.265921Z","steps":["trace[2096010175] 'process raft request' (duration: 298.878727ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:28.034716Z","caller":"traceutil/trace.go:171","msg":"trace[897421864] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"121.328442ms","start":"2026-05-24T09:57:27.913366Z","end":"2026-05-24T09:57:28.034694Z","steps":["trace[897421864] 'process raft request' (duration: 121.194427ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:34.164822Z","caller":"traceutil/trace.go:171","msg":"trace[375307471] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"106.189965ms","start":"2026-05-24T09:57:34.058611Z","end":"2026-05-24T09:57:34.164801Z","steps":["trace[375307471] 'process raft request' (duration: 106.07209ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:37.720355Z","caller":"traceutil/trace.go:171","msg":"trace[1554492482] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"319.273134ms","start":"2026-05-24T09:57:37.401058Z","end":"2026-05-24T09:57:37.720331Z","steps":["trace[1554492482] 'process raft request' (duration: 319.120508ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:37.720781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:37.40104Z","time spent":"319.41046ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T09:57:37.727895Z","caller":"traceutil/trace.go:171","msg":"trace[813010103] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"206.518596ms","start":"2026-05-24T09:57:37.52136Z","end":"2026-05-24T09:57:37.727878Z","steps":["trace[813010103] 'process raft request' (duration: 206.38321ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:37.727885Z","caller":"traceutil/trace.go:171","msg":"trace[248008011] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"209.591488ms","start":"2026-05-24T09:57:37.518265Z","end":"2026-05-24T09:57:37.727856Z","steps":["trace[248008011] 'process raft request' (duration: 209.371509ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:37.728046Z","caller":"traceutil/trace.go:171","msg":"trace[2070625194] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"198.247909ms","start":"2026-05-24T09:57:37.529788Z","end":"2026-05-24T09:57:37.728036Z","steps":["trace[2070625194] 'process raft request' (duration: 198.034551ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:37.728057Z","caller":"traceutil/trace.go:171","msg":"trace[595915486] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"202.549139ms","start":"2026-05-24T09:57:37.525492Z","end":"2026-05-24T09:57:37.728042Z","steps":["trace[595915486] 'process raft request' (duration: 202.290889ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:37.728174Z","caller":"traceutil/trace.go:171","msg":"trace[1778359369] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"194.111916ms","start":"2026-05-24T09:57:37.53405Z","end":"2026-05-24T09:57:37.728162Z","steps":["trace[1778359369] 'process raft request' (duration: 193.853716ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:37.728196Z","caller":"traceutil/trace.go:171","msg":"trace[298550224] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"191.283934ms","start":"2026-05-24T09:57:37.536901Z","end":"2026-05-24T09:57:37.728185Z","steps":["trace[298550224] 'process raft request' (duration: 191.108387ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:37.728247Z","caller":"traceutil/trace.go:171","msg":"trace[198213670] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"194.851465ms","start":"2026-05-24T09:57:37.533384Z","end":"2026-05-24T09:57:37.728235Z","steps":["trace[198213670] 'process raft request' (duration: 194.48337ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:37.728258Z","caller":"traceutil/trace.go:171","msg":"trace[1156696404] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"182.689793ms","start":"2026-05-24T09:57:37.545561Z","end":"2026-05-24T09:57:37.728251Z","steps":["trace[1156696404] 'process raft request' (duration: 182.556998ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:37.728297Z","caller":"traceutil/trace.go:171","msg":"trace[2035415578] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"189.208492ms","start":"2026-05-24T09:57:37.539083Z","end":"2026-05-24T09:57:37.728291Z","steps":["trace[2035415578] 'process raft request' (duration: 188.959082ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:37.728373Z","caller":"traceutil/trace.go:171","msg":"trace[926421158] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"162.532197ms","start":"2026-05-24T09:57:37.565834Z","end":"2026-05-24T09:57:37.728367Z","steps":["trace[926421158] 'process raft request' (duration: 162.376671ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:37.728363Z","caller":"traceutil/trace.go:171","msg":"trace[1038325448] linearizableReadLoop","detail":"{readStateIndex:548; appliedIndex:539; }","duration":"180.847011ms","start":"2026-05-24T09:57:37.54749Z","end":"2026-05-24T09:57:37.728337Z","steps":["trace[1038325448] 'read index received' (duration: 173.038682ms)","trace[1038325448] 'applied index is now lower than readState.Index' (duration: 7.807409ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T09:57:37.728411Z","caller":"traceutil/trace.go:171","msg":"trace[734950542] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"169.622348ms","start":"2026-05-24T09:57:37.558784Z","end":"2026-05-24T09:57:37.728406Z","steps":["trace[734950542] 'process raft request' (duration: 169.377138ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:37.7285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.990196ms","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-05-24T09:57:37.728558Z","caller":"traceutil/trace.go:171","msg":"trace[1679548085] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:537; }","duration":"181.096631ms","start":"2026-05-24T09:57:37.547451Z","end":"2026-05-24T09:57:37.728548Z","steps":["trace[1679548085] 'agreement among raft nodes before linearized reading' (duration: 180.969726ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:38.160209Z","caller":"traceutil/trace.go:171","msg":"trace[1332203122] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"334.523714ms","start":"2026-05-24T09:57:37.825645Z","end":"2026-05-24T09:57:38.160169Z","steps":["trace[1332203122] 'process raft request' (duration: 334.082917ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:38.160264Z","caller":"traceutil/trace.go:171","msg":"trace[1965072809] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"333.270935ms","start":"2026-05-24T09:57:37.826967Z","end":"2026-05-24T09:57:38.160238Z","steps":["trace[1965072809] 'process raft request' (duration: 332.851508ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:38.160363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:37.825626Z","time spent":"334.65871ms","remote":"127.0.0.1:41252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T09:57:38.160427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:37.826962Z","time spent":"333.379649ms","remote":"127.0.0.1:41252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31102,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T09:57:38.16055Z","caller":"traceutil/trace.go:171","msg":"trace[2109723117] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"338.000422ms","start":"2026-05-24T09:57:37.822538Z","end":"2026-05-24T09:57:38.160538Z","steps":["trace[2109723117] 'process raft request' (duration: 333.280785ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:38.160612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:37.822517Z","time spent":"338.065744ms","remote":"127.0.0.1:41252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T09:57:38.160692Z","caller":"traceutil/trace.go:171","msg":"trace[308327673] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"296.528532ms","start":"2026-05-24T09:57:37.863996Z","end":"2026-05-24T09:57:38.160524Z","steps":["trace[308327673] 'process raft request' (duration: 295.895047ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:38.160677Z","caller":"traceutil/trace.go:171","msg":"trace[1802039536] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"334.965422ms","start":"2026-05-24T09:57:37.825699Z","end":"2026-05-24T09:57:38.160664Z","steps":["trace[1802039536] 'process raft request' (duration: 334.080517ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:38.160884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:37.825695Z","time spent":"335.107757ms","remote":"127.0.0.1:41252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-24T09:57:44.658682Z","caller":"traceutil/trace.go:171","msg":"trace[196345785] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"448.082048ms","start":"2026-05-24T09:57:44.21057Z","end":"2026-05-24T09:57:44.658652Z","steps":["trace[196345785] 'read index received' (duration: 447.962953ms)","trace[196345785] 'applied index is now lower than readState.Index' (duration: 118.205µs)"],"step_count":2} {"level":"info","ts":"2026-05-24T09:57:44.658746Z","caller":"traceutil/trace.go:171","msg":"trace[1312248320] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"633.638484ms","start":"2026-05-24T09:57:44.025068Z","end":"2026-05-24T09:57:44.658706Z","steps":["trace[1312248320] 'process raft request' (duration: 633.348032ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:44.658888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.294756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-24T09:57:44.658934Z","caller":"traceutil/trace.go:171","msg":"trace[1547129555] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:635; }","duration":"448.39875ms","start":"2026-05-24T09:57:44.210521Z","end":"2026-05-24T09:57:44.65892Z","steps":["trace[1547129555] 'agreement among raft nodes before linearized reading' (duration: 448.238634ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:44.658978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:44.210497Z","time spent":"448.471393ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-24T09:57:44.658997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:44.025036Z","time spent":"633.79719ms","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T09:57:44.948983Z","caller":"traceutil/trace.go:171","msg":"trace[200420645] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"665.369176ms","start":"2026-05-24T09:57:44.28359Z","end":"2026-05-24T09:57:44.948959Z","steps":["trace[200420645] 'process raft request' (duration: 664.851555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:44.949141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:44.283556Z","time spent":"665.502691ms","remote":"127.0.0.1:41284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T09:57:44.957998Z","caller":"traceutil/trace.go:171","msg":"trace[1760003305] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"294.865367ms","start":"2026-05-24T09:57:44.663109Z","end":"2026-05-24T09:57:44.957974Z","steps":["trace[1760003305] 'process raft request' (duration: 294.667999ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:45.601717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.492187ms","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-05-24T09:57:45.601862Z","caller":"traceutil/trace.go:171","msg":"trace[5453635] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:637; }","duration":"312.639503ms","start":"2026-05-24T09:57:45.289194Z","end":"2026-05-24T09:57:45.601833Z","steps":["trace[5453635] 'range keys from in-memory index tree' (duration: 312.476706ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:45.654994Z","caller":"traceutil/trace.go:171","msg":"trace[1484820015] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:659; }","duration":"498.330631ms","start":"2026-05-24T09:57:45.15664Z","end":"2026-05-24T09:57:45.654971Z","steps":["trace[1484820015] 'read index received' (duration: 498.202036ms)","trace[1484820015] 'applied index is now lower than readState.Index' (duration: 127.055µs)"],"step_count":2} {"level":"info","ts":"2026-05-24T09:57:45.655031Z","caller":"traceutil/trace.go:171","msg":"trace[1310391298] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"648.358125ms","start":"2026-05-24T09:57:45.006642Z","end":"2026-05-24T09:57:45.655Z","steps":["trace[1310391298] 'process raft request' (duration: 648.183239ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:45.655329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:45.006612Z","time spent":"648.640216ms","remote":"127.0.0.1:41416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-24T09:57:45.655467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.79096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-24T09:57:45.655585Z","caller":"traceutil/trace.go:171","msg":"trace[117393393] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:638; }","duration":"498.969867ms","start":"2026-05-24T09:57:45.156588Z","end":"2026-05-24T09:57:45.655558Z","steps":["trace[117393393] 'agreement among raft nodes before linearized reading' (duration: 498.512899ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:45.655644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:45.156564Z","time spent":"499.07084ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-24T09:57:45.682975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.643847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T09:57:45.683068Z","caller":"traceutil/trace.go:171","msg":"trace[2141032410] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"460.744541ms","start":"2026-05-24T09:57:45.222301Z","end":"2026-05-24T09:57:45.683046Z","steps":["trace[2141032410] 'agreement among raft nodes before linearized reading' (duration: 460.544543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:45.683111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:45.22224Z","time spent":"460.863335ms","remote":"127.0.0.1:41188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-24T09:57:47.684122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000115952s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-24T09:57:47.684256Z","caller":"traceutil/trace.go:171","msg":"trace[628082446] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000306841s","start":"2026-05-24T09:57:45.683926Z","end":"2026-05-24T09:57:47.684233Z","steps":["trace[628082446] 'agreement among raft nodes before linearized reading' (duration: 2.000140204s)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:47.684315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:45.683912Z","time spent":"2.000387533s","remote":"127.0.0.1:41204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-24T09:57:48.143744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.435582203s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-24T09:57:48.144102Z","caller":"traceutil/trace.go:171","msg":"trace[2077816696] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"2.484154898s","start":"2026-05-24T09:57:45.659926Z","end":"2026-05-24T09:57:48.144081Z","steps":["trace[2077816696] 'process raft request' (duration: 48.030134ms)","trace[2077816696] 'compare' (duration: 2.434965999s)"],"step_count":2} {"level":"warn","ts":"2026-05-24T09:57:48.144175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:45.659901Z","time spent":"2.484240162s","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T09:57:48.144452Z","caller":"traceutil/trace.go:171","msg":"trace[2018459400] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"456.733509ms","start":"2026-05-24T09:57:47.68767Z","end":"2026-05-24T09:57:48.144403Z","steps":["trace[2018459400] 'process raft request' (duration: 456.164466ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:48.144624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:47.687637Z","time spent":"456.902235ms","remote":"127.0.0.1:41268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-24T09:57:48.14499Z","caller":"traceutil/trace.go:171","msg":"trace[1656006398] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"2.461588708s","start":"2026-05-24T09:57:45.682819Z","end":"2026-05-24T09:57:48.144408Z","steps":["trace[1656006398] 'read index received' (duration: 25.11414ms)","trace[1656006398] 'applied index is now lower than readState.Index' (duration: 2.436471098s)"],"step_count":2} {"level":"warn","ts":"2026-05-24T09:57:48.153255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.403480828s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-24T09:57:48.153279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.793428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T09:57:48.153302Z","caller":"traceutil/trace.go:171","msg":"trace[1426085916] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:641; }","duration":"2.403548871s","start":"2026-05-24T09:57:45.749739Z","end":"2026-05-24T09:57:48.153288Z","steps":["trace[1426085916] 'agreement among raft nodes before linearized reading' (duration: 2.403464867s)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:57:48.153332Z","caller":"traceutil/trace.go:171","msg":"trace[1639703627] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"462.881741ms","start":"2026-05-24T09:57:47.69044Z","end":"2026-05-24T09:57:48.153322Z","steps":["trace[1639703627] 'agreement among raft nodes before linearized reading' (duration: 462.792108ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:48.153349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:45.749725Z","time spent":"2.403617253s","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-24T09:57:48.153371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:47.690413Z","time spent":"462.953074ms","remote":"127.0.0.1:41188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-24T09:57:48.153454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.493971104s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-24T09:57:48.153527Z","caller":"traceutil/trace.go:171","msg":"trace[1810636335] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:641; }","duration":"2.49410991s","start":"2026-05-24T09:57:45.6594Z","end":"2026-05-24T09:57:48.15351Z","steps":["trace[1810636335] 'agreement among raft nodes before linearized reading' (duration: 2.485537412s)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:48.153574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:45.659377Z","time spent":"2.494187453s","remote":"127.0.0.1:41378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-05-24T09:57:48.153583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.374763636s","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-05-24T09:57:48.153627Z","caller":"traceutil/trace.go:171","msg":"trace[1443230677] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:641; }","duration":"2.374849069s","start":"2026-05-24T09:57:45.778767Z","end":"2026-05-24T09:57:48.153616Z","steps":["trace[1443230677] 'agreement among raft nodes before linearized reading' (duration: 2.374684032s)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:48.153614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.188853625s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-24T09:57:48.153662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:45.778753Z","time spent":"2.374902111s","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-24T09:57:48.153689Z","caller":"traceutil/trace.go:171","msg":"trace[1197998885] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:641; }","duration":"1.188982171s","start":"2026-05-24T09:57:46.964688Z","end":"2026-05-24T09:57:48.15367Z","steps":["trace[1197998885] 'agreement among raft nodes before linearized reading' (duration: 1.188733461s)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:48.153748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:46.964661Z","time spent":"1.189076695s","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-24T09:57:49.541123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.092011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T09:57:49.541203Z","caller":"traceutil/trace.go:171","msg":"trace[715642036] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:653; }","duration":"318.228367ms","start":"2026-05-24T09:57:49.222956Z","end":"2026-05-24T09:57:49.541185Z","steps":["trace[715642036] 'range keys from in-memory index tree' (duration: 317.978068ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:57:49.541248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:57:49.222912Z","time spent":"318.327641ms","remote":"127.0.0.1:41188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-24T09:58:04.553982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.521619522s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-05-24T09:58:04.554003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.827063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-24T09:58:04.554075Z","caller":"traceutil/trace.go:171","msg":"trace[1703424924] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:800; }","duration":"1.521786388s","start":"2026-05-24T09:58:03.032271Z","end":"2026-05-24T09:58:04.554057Z","steps":["trace[1703424924] 'range keys from in-memory index tree' (duration: 1.521392203s)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:04.554121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:03.032249Z","time spent":"1.521862971s","remote":"127.0.0.1:41242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.19\" "} {"level":"info","ts":"2026-05-24T09:58:04.554141Z","caller":"traceutil/trace.go:171","msg":"trace[259011550] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:800; }","duration":"473.013921ms","start":"2026-05-24T09:58:04.081086Z","end":"2026-05-24T09:58:04.5541Z","steps":["trace[259011550] 'count revisions from in-memory index tree' (duration: 472.73587ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:04.554209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:04.081066Z","time spent":"473.130636ms","remote":"127.0.0.1:41614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":2,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-05-24T09:58:04.554409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.695851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-24T09:58:04.55444Z","caller":"traceutil/trace.go:171","msg":"trace[1768779178] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:800; }","duration":"277.738543ms","start":"2026-05-24T09:58:04.276693Z","end":"2026-05-24T09:58:04.554431Z","steps":["trace[1768779178] 'range keys from in-memory index tree' (duration: 277.622848ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:04.554752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.528942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-24T09:58:04.554911Z","caller":"traceutil/trace.go:171","msg":"trace[2111294361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:800; }","duration":"293.723709ms","start":"2026-05-24T09:58:04.261169Z","end":"2026-05-24T09:58:04.554893Z","steps":["trace[2111294361] 'range keys from in-memory index tree' (duration: 293.367015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:04.554413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.253851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-24T09:58:04.555202Z","caller":"traceutil/trace.go:171","msg":"trace[1089385702] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:800; }","duration":"307.036491ms","start":"2026-05-24T09:58:04.248095Z","end":"2026-05-24T09:58:04.555131Z","steps":["trace[1089385702] 'range keys from in-memory index tree' (duration: 306.036972ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:04.555343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:04.248083Z","time spent":"307.212839ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-24T09:58:04.554455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.444352911s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-s4x4d\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-05-24T09:58:04.55585Z","caller":"traceutil/trace.go:171","msg":"trace[245530322] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-s4x4d; range_end:; response_count:1; response_revision:800; }","duration":"1.445833559s","start":"2026-05-24T09:58:03.11Z","end":"2026-05-24T09:58:04.555834Z","steps":["trace[245530322] 'range keys from in-memory index tree' (duration: 1.444081161s)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:04.555894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:03.109969Z","time spent":"1.445912003s","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-s4x4d\" "} {"level":"warn","ts":"2026-05-24T09:58:04.554483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.712424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-24T09:58:04.556045Z","caller":"traceutil/trace.go:171","msg":"trace[1783347390] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:800; }","duration":"288.288056ms","start":"2026-05-24T09:58:04.267734Z","end":"2026-05-24T09:58:04.556022Z","steps":["trace[1783347390] 'range keys from in-memory index tree' (duration: 286.583119ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:04.554523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.331919751s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T09:58:04.556215Z","caller":"traceutil/trace.go:171","msg":"trace[1239041684] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:800; }","duration":"1.333650899s","start":"2026-05-24T09:58:03.222549Z","end":"2026-05-24T09:58:04.5562Z","steps":["trace[1239041684] 'range keys from in-memory index tree' (duration: 1.331833688s)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:04.55627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:03.222521Z","time spent":"1.333733402s","remote":"127.0.0.1:41188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-24T09:58:04.554741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.018685ms","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-05-24T09:58:04.556397Z","caller":"traceutil/trace.go:171","msg":"trace[1897421192] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:800; }","duration":"675.707721ms","start":"2026-05-24T09:58:03.880677Z","end":"2026-05-24T09:58:04.556385Z","steps":["trace[1897421192] 'range keys from in-memory index tree' (duration: 673.91156ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:04.556442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:03.880656Z","time spent":"675.774523ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-24T09:58:23.145566Z","caller":"traceutil/trace.go:171","msg":"trace[524505460] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"100.375457ms","start":"2026-05-24T09:58:23.045166Z","end":"2026-05-24T09:58:23.145542Z","steps":["trace[524505460] 'process raft request' (duration: 93.213589ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:33.325732Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151275132297869,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-24T09:58:33.826154Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151275132297869,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-24T09:58:34.292384Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.468501273s","expected-duration":"1s"} {"level":"info","ts":"2026-05-24T09:58:34.292801Z","caller":"traceutil/trace.go:171","msg":"trace[1832655956] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"1.469019393s","start":"2026-05-24T09:58:32.823757Z","end":"2026-05-24T09:58:34.292776Z","steps":["trace[1832655956] 'process raft request' (duration: 1.46887119s)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:34.29295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:32.823729Z","time spent":"1.469146436s","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T09:58:34.304886Z","caller":"traceutil/trace.go:171","msg":"trace[964213196] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"1.480485052s","start":"2026-05-24T09:58:32.824363Z","end":"2026-05-24T09:58:34.304848Z","steps":["trace[964213196] 'process raft request' (duration: 1.480312538s)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:34.305054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:32.824352Z","time spent":"1.480597084s","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T09:58:34.305083Z","caller":"traceutil/trace.go:171","msg":"trace[1667208079] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"1.480337819s","start":"2026-05-24T09:58:32.824726Z","end":"2026-05-24T09:58:34.305064Z","steps":["trace[1667208079] 'process raft request' (duration: 1.480085994s)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:34.305203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:32.824702Z","time spent":"1.480435171s","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T09:58:34.305401Z","caller":"traceutil/trace.go:171","msg":"trace[617140502] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"1.479620164s","start":"2026-05-24T09:58:32.825773Z","end":"2026-05-24T09:58:34.305393Z","steps":["trace[617140502] 'process raft request' (duration: 1.479228016s)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:34.305446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:32.825759Z","time spent":"1.479663966s","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T09:58:34.305554Z","caller":"traceutil/trace.go:171","msg":"trace[140742599] linearizableReadLoop","detail":"{readStateIndex:1234; appliedIndex:1228; }","duration":"1.4808743s","start":"2026-05-24T09:58:32.82467Z","end":"2026-05-24T09:58:34.305545Z","steps":["trace[140742599] 'read index received' (duration: 1.468003553s)","trace[140742599] 'applied index is now lower than readState.Index' (duration: 12.870207ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T09:58:34.30565Z","caller":"traceutil/trace.go:171","msg":"trace[367161787] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"1.036912234s","start":"2026-05-24T09:58:33.268732Z","end":"2026-05-24T09:58:34.305644Z","steps":["trace[367161787] 'process raft request' (duration: 1.036635089s)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:34.305689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:33.268707Z","time spent":"1.036959006s","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T09:58:34.305744Z","caller":"traceutil/trace.go:171","msg":"trace[1375906382] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"724.099565ms","start":"2026-05-24T09:58:33.581638Z","end":"2026-05-24T09:58:34.305738Z","steps":["trace[1375906382] 'process raft request' (duration: 723.877311ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:34.305778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:33.581615Z","time spent":"724.145317ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T09:58:34.305947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.481290899s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-24T09:58:34.305973Z","caller":"traceutil/trace.go:171","msg":"trace[338553548] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1200; }","duration":"1.481337s","start":"2026-05-24T09:58:32.824629Z","end":"2026-05-24T09:58:34.305966Z","steps":["trace[338553548] 'agreement among raft nodes before linearized reading' (duration: 1.481208787s)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:34.305992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:32.824619Z","time spent":"1.481369251s","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-24T09:58:34.306002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.272215355s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-24T09:58:34.306061Z","caller":"traceutil/trace.go:171","msg":"trace[1260350234] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:1200; }","duration":"1.272328677s","start":"2026-05-24T09:58:33.033719Z","end":"2026-05-24T09:58:34.306048Z","steps":["trace[1260350234] 'agreement among raft nodes before linearized reading' (duration: 1.272069951s)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:34.3061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:33.033677Z","time spent":"1.272409839s","remote":"127.0.0.1:41242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.19\" "} {"level":"info","ts":"2026-05-24T09:58:50.856048Z","caller":"traceutil/trace.go:171","msg":"trace[1161815322] linearizableReadLoop","detail":"{readStateIndex:1376; appliedIndex:1375; }","duration":"499.854548ms","start":"2026-05-24T09:58:50.356168Z","end":"2026-05-24T09:58:50.856023Z","steps":["trace[1161815322] 'read index received' (duration: 499.765576ms)","trace[1161815322] 'applied index is now lower than readState.Index' (duration: 87.582µs)"],"step_count":2} {"level":"info","ts":"2026-05-24T09:58:50.856088Z","caller":"traceutil/trace.go:171","msg":"trace[1472001832] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"524.498787ms","start":"2026-05-24T09:58:50.331561Z","end":"2026-05-24T09:58:50.85606Z","steps":["trace[1472001832] 'process raft request' (duration: 524.319952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:50.856442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:50.331541Z","time spent":"524.818314ms","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4331,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T09:58:50.856545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.173946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-24T09:58:50.856675Z","caller":"traceutil/trace.go:171","msg":"trace[1243768159] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1335; }","duration":"500.460802ms","start":"2026-05-24T09:58:50.356126Z","end":"2026-05-24T09:58:50.856586Z","steps":["trace[1243768159] 'agreement among raft nodes before linearized reading' (duration: 500.021122ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:50.856716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:50.356106Z","time spent":"500.598656ms","remote":"127.0.0.1:41252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":37,"response size":30,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-05-24T09:58:50.861553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.757889ms","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-05-24T09:58:50.861679Z","caller":"traceutil/trace.go:171","msg":"trace[85506479] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1336; }","duration":"488.881802ms","start":"2026-05-24T09:58:50.372777Z","end":"2026-05-24T09:58:50.861659Z","steps":["trace[85506479] 'agreement among raft nodes before linearized reading' (duration: 488.624015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:50.861774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:50.372723Z","time spent":"489.033296ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-24T09:58:50.86181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.592097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-24T09:58:50.86189Z","caller":"traceutil/trace.go:171","msg":"trace[231627905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1336; }","duration":"479.696329ms","start":"2026-05-24T09:58:50.382179Z","end":"2026-05-24T09:58:50.861875Z","steps":["trace[231627905] 'agreement among raft nodes before linearized reading' (duration: 479.500174ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:50.861943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:50.382165Z","time spent":"479.769731ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-24T09:58:50.86214Z","caller":"traceutil/trace.go:171","msg":"trace[1025220490] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"502.757929ms","start":"2026-05-24T09:58:50.359372Z","end":"2026-05-24T09:58:50.86213Z","steps":["trace[1025220490] 'process raft request' (duration: 501.878468ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:50.862232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:50.359356Z","time spent":"502.8068ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T09:58:50.862409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.443895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-24T09:58:50.862434Z","caller":"traceutil/trace.go:171","msg":"trace[180704765] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1336; }","duration":"482.501577ms","start":"2026-05-24T09:58:50.379925Z","end":"2026-05-24T09:58:50.862427Z","steps":["trace[180704765] 'agreement among raft nodes before linearized reading' (duration: 482.413535ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:50.862471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:50.379906Z","time spent":"482.558709ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-24T09:58:50.862518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.506036ms","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-05-24T09:58:50.862592Z","caller":"traceutil/trace.go:171","msg":"trace[1257983883] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1336; }","duration":"484.691571ms","start":"2026-05-24T09:58:50.377886Z","end":"2026-05-24T09:58:50.862578Z","steps":["trace[1257983883] 'agreement among raft nodes before linearized reading' (duration: 484.455025ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:50.862675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:50.37787Z","time spent":"484.788903ms","remote":"127.0.0.1:41432","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-05-24T09:58:50.862837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.523039ms","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-05-24T09:58:50.862921Z","caller":"traceutil/trace.go:171","msg":"trace[1033312732] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1336; }","duration":"480.681983ms","start":"2026-05-24T09:58:50.382221Z","end":"2026-05-24T09:58:50.862903Z","steps":["trace[1033312732] 'agreement among raft nodes before linearized reading' (duration: 480.107109ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:50.862973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:50.38221Z","time spent":"480.743155ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-24T09:58:59.446635Z","caller":"traceutil/trace.go:171","msg":"trace[1118279051] transaction","detail":"{read_only:false; response_revision:1465; number_of_response:1; }","duration":"487.420915ms","start":"2026-05-24T09:58:58.959178Z","end":"2026-05-24T09:58:59.446599Z","steps":["trace[1118279051] 'process raft request' (duration: 462.453519ms)","trace[1118279051] 'compare' (duration: 24.654658ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T09:58:59.446708Z","caller":"traceutil/trace.go:171","msg":"trace[1618730239] linearizableReadLoop","detail":"{readStateIndex:1512; appliedIndex:1508; }","duration":"331.339194ms","start":"2026-05-24T09:58:59.115336Z","end":"2026-05-24T09:58:59.446675Z","steps":["trace[1618730239] 'read index received' (duration: 306.263455ms)","trace[1618730239] 'applied index is now lower than readState.Index' (duration: 25.074719ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T09:58:59.446842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:58.959132Z","time spent":"487.577149ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T09:58:59.446829Z","caller":"traceutil/trace.go:171","msg":"trace[619918913] transaction","detail":"{read_only:false; response_revision:1468; number_of_response:1; }","duration":"486.593854ms","start":"2026-05-24T09:58:58.960212Z","end":"2026-05-24T09:58:59.446805Z","steps":["trace[619918913] 'process raft request' (duration: 486.422479ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:59.446891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.525229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T09:58:59.446944Z","caller":"traceutil/trace.go:171","msg":"trace[312327460] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1468; }","duration":"331.600671ms","start":"2026-05-24T09:58:59.115329Z","end":"2026-05-24T09:58:59.44693Z","steps":["trace[312327460] 'agreement among raft nodes before linearized reading' (duration: 331.496688ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:59.446982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:59.115271Z","time spent":"331.701903ms","remote":"127.0.0.1:57788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"warn","ts":"2026-05-24T09:58:59.447017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:58.960203Z","time spent":"486.716717ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T09:58:59.447041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.710469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T09:58:59.447125Z","caller":"traceutil/trace.go:171","msg":"trace[1302297818] transaction","detail":"{read_only:false; response_revision:1466; number_of_response:1; }","duration":"487.699863ms","start":"2026-05-24T09:58:58.959382Z","end":"2026-05-24T09:58:59.447081Z","steps":["trace[1302297818] 'process raft request' (duration: 487.101857ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:58:59.44715Z","caller":"traceutil/trace.go:171","msg":"trace[606970958] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1468; }","duration":"223.870223ms","start":"2026-05-24T09:58:59.223251Z","end":"2026-05-24T09:58:59.447121Z","steps":["trace[606970958] 'agreement among raft nodes before linearized reading' (duration: 223.682258ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:59.447274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:58.959372Z","time spent":"487.826316ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T09:58:59.448003Z","caller":"traceutil/trace.go:171","msg":"trace[701070280] transaction","detail":"{read_only:false; response_revision:1467; number_of_response:1; }","duration":"488.307118ms","start":"2026-05-24T09:58:58.959677Z","end":"2026-05-24T09:58:59.447984Z","steps":["trace[701070280] 'process raft request' (duration: 486.918072ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:58:59.448088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:58:58.959666Z","time spent":"488.38088ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T09:58:59.875799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.394304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-24T09:58:59.875915Z","caller":"traceutil/trace.go:171","msg":"trace[1203695697] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1468; }","duration":"164.571259ms","start":"2026-05-24T09:58:59.711321Z","end":"2026-05-24T09:58:59.875892Z","steps":["trace[1203695697] 'count revisions from in-memory index tree' (duration: 164.285432ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:23.50616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.544002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-24T09:59:23.506245Z","caller":"traceutil/trace.go:171","msg":"trace[1258913294] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:1874; }","duration":"471.663665ms","start":"2026-05-24T09:59:23.034561Z","end":"2026-05-24T09:59:23.506224Z","steps":["trace[1258913294] 'range keys from in-memory index tree' (duration: 471.376807ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:23.506236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.078135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-82c88b4c-2dec-48b6-a55b-610ee2af4de1\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-05-24T09:59:23.506362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.506048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-24T09:59:23.506354Z","caller":"traceutil/trace.go:171","msg":"trace[150266578] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-82c88b4c-2dec-48b6-a55b-610ee2af4de1; range_end:; response_count:1; response_revision:1874; }","duration":"610.23857ms","start":"2026-05-24T09:59:22.896094Z","end":"2026-05-24T09:59:23.506333Z","steps":["trace[150266578] 'range keys from in-memory index tree' (duration: 609.907111ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:59:23.506397Z","caller":"traceutil/trace.go:171","msg":"trace[1115308573] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1874; }","duration":"450.560119ms","start":"2026-05-24T09:59:23.055827Z","end":"2026-05-24T09:59:23.506387Z","steps":["trace[1115308573] 'range keys from in-memory index tree' (duration: 450.390914ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:23.506424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:59:23.055812Z","time spent":"450.6055ms","remote":"127.0.0.1:42790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-24T09:59:23.506431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:59:22.896072Z","time spent":"610.347992ms","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-82c88b4c-2dec-48b6-a55b-610ee2af4de1\" "} {"level":"warn","ts":"2026-05-24T09:59:23.506287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:59:23.034546Z","time spent":"471.730987ms","remote":"127.0.0.1:41242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.19\" "} {"level":"info","ts":"2026-05-24T09:59:23.507126Z","caller":"traceutil/trace.go:171","msg":"trace[1645763119] linearizableReadLoop","detail":"{readStateIndex:1946; appliedIndex:1945; }","duration":"351.569868ms","start":"2026-05-24T09:59:23.155543Z","end":"2026-05-24T09:59:23.507113Z","steps":["trace[1645763119] 'read index received' (duration: 351.503586ms)","trace[1645763119] 'applied index is now lower than readState.Index' (duration: 65.192µs)"],"step_count":2} {"level":"warn","ts":"2026-05-24T09:59:23.507341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.798234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-24T09:59:23.507354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.641653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T09:59:23.507396Z","caller":"traceutil/trace.go:171","msg":"trace[529296384] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1875; }","duration":"351.893178ms","start":"2026-05-24T09:59:23.155488Z","end":"2026-05-24T09:59:23.507382Z","steps":["trace[529296384] 'agreement among raft nodes before linearized reading' (duration: 351.767274ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:23.507429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:59:23.155464Z","time spent":"351.956989ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-24T09:59:23.507414Z","caller":"traceutil/trace.go:171","msg":"trace[620839406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1875; }","duration":"284.732735ms","start":"2026-05-24T09:59:23.222672Z","end":"2026-05-24T09:59:23.507405Z","steps":["trace[620839406] 'agreement among raft nodes before linearized reading' (duration: 284.648523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:23.5077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.113833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T09:59:23.507766Z","caller":"traceutil/trace.go:171","msg":"trace[1192250802] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1875; }","duration":"226.196177ms","start":"2026-05-24T09:59:23.28156Z","end":"2026-05-24T09:59:23.507756Z","steps":["trace[1192250802] 'agreement among raft nodes before linearized reading' (duration: 226.106774ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:59:23.50822Z","caller":"traceutil/trace.go:171","msg":"trace[67051995] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"442.975758ms","start":"2026-05-24T09:59:23.064165Z","end":"2026-05-24T09:59:23.50714Z","steps":["trace[67051995] 'process raft request' (duration: 442.853784ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:23.508463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:59:23.064138Z","time spent":"444.198193ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T09:59:24.061393Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151275132299241,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-24T09:59:24.108484Z","caller":"traceutil/trace.go:171","msg":"trace[1448856111] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"596.698518ms","start":"2026-05-24T09:59:23.511757Z","end":"2026-05-24T09:59:24.108455Z","steps":["trace[1448856111] 'process raft request' (duration: 596.567214ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:24.108701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:59:23.511738Z","time spent":"596.79714ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T09:59:24.108715Z","caller":"traceutil/trace.go:171","msg":"trace[1762088352] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"594.70419ms","start":"2026-05-24T09:59:23.513985Z","end":"2026-05-24T09:59:24.108689Z","steps":["trace[1762088352] 'process raft request' (duration: 594.436792ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:24.108859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:59:23.513972Z","time spent":"594.801992ms","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T09:59:24.595058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.12324ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-24T09:59:24.595341Z","caller":"traceutil/trace.go:171","msg":"trace[1215108566] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"1.042693128s","start":"2026-05-24T09:59:23.552616Z","end":"2026-05-24T09:59:24.595309Z","steps":["trace[1215108566] 'process raft request' (duration: 890.233938ms)","trace[1215108566] 'compare' (duration: 151.883813ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T09:59:24.595418Z","caller":"traceutil/trace.go:171","msg":"trace[758768488] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"719.103038ms","start":"2026-05-24T09:59:23.87625Z","end":"2026-05-24T09:59:24.595353Z","steps":["trace[758768488] 'process raft request' (duration: 718.898112ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:59:24.59545Z","caller":"traceutil/trace.go:171","msg":"trace[21962942] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"635.777504ms","start":"2026-05-24T09:59:23.959642Z","end":"2026-05-24T09:59:24.59542Z","steps":["trace[21962942] 'process raft request' (duration: 635.565268ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:24.595491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:59:23.5526Z","time spent":"1.042811502s","remote":"127.0.0.1:41242","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T09:59:24.595536Z","caller":"traceutil/trace.go:171","msg":"trace[914634588] linearizableReadLoop","detail":"{readStateIndex:1952; appliedIndex:1948; }","duration":"1.03488255s","start":"2026-05-24T09:59:23.560641Z","end":"2026-05-24T09:59:24.595501Z","steps":["trace[914634588] 'read index received' (duration: 547.779009ms)","trace[914634588] 'applied index is now lower than readState.Index' (duration: 487.079631ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T09:59:24.595424Z","caller":"traceutil/trace.go:171","msg":"trace[931131198] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"385.609706ms","start":"2026-05-24T09:59:24.209796Z","end":"2026-05-24T09:59:24.595406Z","steps":["trace[931131198] 'process raft request' (duration: 385.561414ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:24.59561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:59:23.959609Z","time spent":"635.911418ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T09:59:24.595635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:59:23.876211Z","time spent":"719.299104ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T09:59:24.59577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:59:24.209771Z","time spent":"385.878903ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T09:59:24.595823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.034992734s","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-05-24T09:59:24.595857Z","caller":"traceutil/trace.go:171","msg":"trace[943404213] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1881; }","duration":"1.035055546s","start":"2026-05-24T09:59:23.560792Z","end":"2026-05-24T09:59:24.595847Z","steps":["trace[943404213] 'agreement among raft nodes before linearized reading' (duration: 1.034919562s)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:24.59587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.03521361s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-24T09:59:24.595942Z","caller":"traceutil/trace.go:171","msg":"trace[25331392] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1881; }","duration":"1.035319163s","start":"2026-05-24T09:59:23.560606Z","end":"2026-05-24T09:59:24.595925Z","steps":["trace[25331392] 'agreement among raft nodes before linearized reading' (duration: 1.035063976s)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:24.596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:59:23.560592Z","time spent":"1.035397315s","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-24T09:59:24.595927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:59:23.560769Z","time spent":"1.035148808s","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-24T09:59:24.596217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.032400578s","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-05-24T09:59:24.596266Z","caller":"traceutil/trace.go:171","msg":"trace[794539930] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1881; }","duration":"1.03246687s","start":"2026-05-24T09:59:23.563788Z","end":"2026-05-24T09:59:24.596254Z","steps":["trace[794539930] 'agreement among raft nodes before linearized reading' (duration: 1.032362317s)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:24.596295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:59:23.563778Z","time spent":"1.032510521s","remote":"127.0.0.1:41432","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-05-24T09:59:24.596319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.017197504s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-24T09:59:24.596387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.377247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"} {"level":"info","ts":"2026-05-24T09:59:24.598478Z","caller":"traceutil/trace.go:171","msg":"trace[832888900] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1881; }","duration":"462.494229ms","start":"2026-05-24T09:59:24.135962Z","end":"2026-05-24T09:59:24.598456Z","steps":["trace[832888900] 'agreement among raft nodes before linearized reading' (duration: 460.203762ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:24.598586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:59:24.135938Z","time spent":"462.630864ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":551,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-05-24T09:59:24.596433Z","caller":"traceutil/trace.go:171","msg":"trace[1113561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1881; }","duration":"1.017331107s","start":"2026-05-24T09:59:23.579084Z","end":"2026-05-24T09:59:24.596415Z","steps":["trace[1113561] 'agreement among raft nodes before linearized reading' (duration: 1.016987477s)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:24.59902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:59:23.579075Z","time spent":"1.019923494s","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-24T09:59:30.246364Z","caller":"traceutil/trace.go:171","msg":"trace[2034468354] transaction","detail":"{read_only:false; response_revision:1943; number_of_response:1; }","duration":"108.710047ms","start":"2026-05-24T09:59:30.137613Z","end":"2026-05-24T09:59:30.246323Z","steps":["trace[2034468354] 'process raft request' (duration: 108.222883ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:59:36.724385Z","caller":"traceutil/trace.go:171","msg":"trace[920789023] linearizableReadLoop","detail":"{readStateIndex:2054; appliedIndex:2053; }","duration":"299.982934ms","start":"2026-05-24T09:59:36.424384Z","end":"2026-05-24T09:59:36.724367Z","steps":["trace[920789023] 'read index received' (duration: 299.953533ms)","trace[920789023] 'applied index is now lower than readState.Index' (duration: 28.551µs)"],"step_count":2} {"level":"info","ts":"2026-05-24T09:59:36.724492Z","caller":"traceutil/trace.go:171","msg":"trace[1451719445] transaction","detail":"{read_only:false; response_revision:1979; number_of_response:1; }","duration":"453.588287ms","start":"2026-05-24T09:59:36.270869Z","end":"2026-05-24T09:59:36.724458Z","steps":["trace[1451719445] 'process raft request' (duration: 453.387981ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:36.724538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.136369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T09:59:36.72457Z","caller":"traceutil/trace.go:171","msg":"trace[88985683] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1979; }","duration":"300.18541ms","start":"2026-05-24T09:59:36.424374Z","end":"2026-05-24T09:59:36.72456Z","steps":["trace[88985683] 'agreement among raft nodes before linearized reading' (duration: 300.101587ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:36.724597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:59:36.424328Z","time spent":"300.261483ms","remote":"127.0.0.1:53602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-05-24T09:59:36.72465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T09:59:36.270847Z","time spent":"453.71623ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T09:59:36.892797Z","caller":"traceutil/trace.go:171","msg":"trace[1091451481] transaction","detail":"{read_only:false; response_revision:1980; number_of_response:1; }","duration":"233.937466ms","start":"2026-05-24T09:59:36.65883Z","end":"2026-05-24T09:59:36.892767Z","steps":["trace[1091451481] 'process raft request' (duration: 159.786771ms)","trace[1091451481] 'compare' (duration: 73.888507ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T09:59:36.893035Z","caller":"traceutil/trace.go:171","msg":"trace[122698229] transaction","detail":"{read_only:false; response_revision:1981; number_of_response:1; }","duration":"233.09948ms","start":"2026-05-24T09:59:36.6599Z","end":"2026-05-24T09:59:36.892999Z","steps":["trace[122698229] 'process raft request' (duration: 232.800351ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:59:36.893066Z","caller":"traceutil/trace.go:171","msg":"trace[1693314138] linearizableReadLoop","detail":"{readStateIndex:2057; appliedIndex:2054; }","duration":"168.57894ms","start":"2026-05-24T09:59:36.724456Z","end":"2026-05-24T09:59:36.893035Z","steps":["trace[1693314138] 'read index received' (duration: 94.084194ms)","trace[1693314138] 'applied index is now lower than readState.Index' (duration: 74.493696ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T09:59:36.893219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.807276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-24T09:59:36.893251Z","caller":"traceutil/trace.go:171","msg":"trace[1613630394] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1982; }","duration":"221.862088ms","start":"2026-05-24T09:59:36.671378Z","end":"2026-05-24T09:59:36.89324Z","steps":["trace[1613630394] 'agreement among raft nodes before linearized reading' (duration: 221.753054ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:59:36.893259Z","caller":"traceutil/trace.go:171","msg":"trace[1425731576] transaction","detail":"{read_only:false; response_revision:1982; number_of_response:1; }","duration":"230.481951ms","start":"2026-05-24T09:59:36.662764Z","end":"2026-05-24T09:59:36.893246Z","steps":["trace[1425731576] 'process raft request' (duration: 230.167611ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:36.893207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.747851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-24T09:59:36.893389Z","caller":"traceutil/trace.go:171","msg":"trace[1551990475] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1982; }","duration":"179.966528ms","start":"2026-05-24T09:59:36.713412Z","end":"2026-05-24T09:59:36.893378Z","steps":["trace[1551990475] 'agreement among raft nodes before linearized reading' (duration: 179.628078ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:36.893437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.91529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-24T09:59:36.893423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.436224ms","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-05-24T09:59:36.893468Z","caller":"traceutil/trace.go:171","msg":"trace[1906055981] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1982; }","duration":"221.983991ms","start":"2026-05-24T09:59:36.671475Z","end":"2026-05-24T09:59:36.893459Z","steps":["trace[1906055981] 'agreement among raft nodes before linearized reading' (duration: 221.897099ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:59:36.8935Z","caller":"traceutil/trace.go:171","msg":"trace[1722127774] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1982; }","duration":"221.530138ms","start":"2026-05-24T09:59:36.671949Z","end":"2026-05-24T09:59:36.89348Z","steps":["trace[1722127774] 'agreement among raft nodes before linearized reading' (duration: 221.298581ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T09:59:36.893663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.424681ms","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-05-24T09:59:36.893688Z","caller":"traceutil/trace.go:171","msg":"trace[648339450] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1982; }","duration":"217.456863ms","start":"2026-05-24T09:59:36.676223Z","end":"2026-05-24T09:59:36.89368Z","steps":["trace[648339450] 'agreement among raft nodes before linearized reading' (duration: 217.382521ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:59:58.289544Z","caller":"traceutil/trace.go:171","msg":"trace[1113157897] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"128.2717ms","start":"2026-05-24T09:59:58.161241Z","end":"2026-05-24T09:59:58.289513Z","steps":["trace[1113157897] 'process raft request' (duration: 128.053463ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:59:58.400319Z","caller":"traceutil/trace.go:171","msg":"trace[1667449264] linearizableReadLoop","detail":"{readStateIndex:2197; appliedIndex:2196; }","duration":"109.241916ms","start":"2026-05-24T09:59:58.29105Z","end":"2026-05-24T09:59:58.400292Z","steps":["trace[1667449264] 'read index received' (duration: 18.501067ms)","trace[1667449264] 'applied index is now lower than readState.Index' (duration: 90.739179ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T09:59:58.400456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.37935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T09:59:58.40051Z","caller":"traceutil/trace.go:171","msg":"trace[96239136] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2117; }","duration":"109.469083ms","start":"2026-05-24T09:59:58.291015Z","end":"2026-05-24T09:59:58.400484Z","steps":["trace[96239136] 'agreement among raft nodes before linearized reading' (duration: 109.37908ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:59:59.013362Z","caller":"traceutil/trace.go:171","msg":"trace[1564543346] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"183.929908ms","start":"2026-05-24T09:59:58.829412Z","end":"2026-05-24T09:59:59.013342Z","steps":["trace[1564543346] 'process raft request' (duration: 183.769922ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:59:59.175973Z","caller":"traceutil/trace.go:171","msg":"trace[870694098] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"114.515394ms","start":"2026-05-24T09:59:59.06143Z","end":"2026-05-24T09:59:59.175946Z","steps":["trace[870694098] 'process raft request' (duration: 97.638098ms)","trace[870694098] 'compare' (duration: 16.650378ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T09:59:59.176284Z","caller":"traceutil/trace.go:171","msg":"trace[1924598802] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"114.351939ms","start":"2026-05-24T09:59:59.061904Z","end":"2026-05-24T09:59:59.176256Z","steps":["trace[1924598802] 'process raft request' (duration: 113.998557ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T09:59:59.17643Z","caller":"traceutil/trace.go:171","msg":"trace[857425448] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"112.967333ms","start":"2026-05-24T09:59:59.063376Z","end":"2026-05-24T09:59:59.176343Z","steps":["trace[857425448] 'process raft request' (duration: 112.784048ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:00:01.367703Z","caller":"traceutil/trace.go:171","msg":"trace[2039286029] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"347.639479ms","start":"2026-05-24T10:00:01.020041Z","end":"2026-05-24T10:00:01.36768Z","steps":["trace[2039286029] 'process raft request' (duration: 347.497574ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:00:01.368086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.020023Z","time spent":"347.784713ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T10:00:01.801461Z","caller":"traceutil/trace.go:171","msg":"trace[1650405712] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"739.495972ms","start":"2026-05-24T10:00:01.061943Z","end":"2026-05-24T10:00:01.801439Z","steps":["trace[1650405712] 'process raft request' (duration: 733.312702ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:00:01.801654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.061925Z","time spent":"739.608026ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T10:00:01.802085Z","caller":"traceutil/trace.go:171","msg":"trace[831812105] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"739.504652ms","start":"2026-05-24T10:00:01.062548Z","end":"2026-05-24T10:00:01.802053Z","steps":["trace[831812105] 'process raft request' (duration: 739.378668ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:00:01.802111Z","caller":"traceutil/trace.go:171","msg":"trace[116217248] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"740.022049ms","start":"2026-05-24T10:00:01.062058Z","end":"2026-05-24T10:00:01.80208Z","steps":["trace[116217248] 'process raft request' (duration: 739.339087ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:00:01.802152Z","caller":"traceutil/trace.go:171","msg":"trace[198430590] linearizableReadLoop","detail":"{readStateIndex:2210; appliedIndex:2206; }","duration":"735.587105ms","start":"2026-05-24T10:00:01.066551Z","end":"2026-05-24T10:00:01.802138Z","steps":["trace[198430590] 'read index received' (duration: 301.052075ms)","trace[198430590] 'applied index is now lower than readState.Index' (duration: 434.53388ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T10:00:01.802284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.062539Z","time spent":"739.646148ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T10:00:01.802315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.062037Z","time spent":"740.167464ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T10:00:01.802452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.896776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b2780aec1b63a5\" ","response":"range_response_count:1 size:846"} {"level":"warn","ts":"2026-05-24T10:00:01.802489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.76865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-24T10:00:01.802511Z","caller":"traceutil/trace.go:171","msg":"trace[1079334808] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18b2780aec1b63a5; range_end:; response_count:1; response_revision:2131; }","duration":"735.977428ms","start":"2026-05-24T10:00:01.066517Z","end":"2026-05-24T10:00:01.802494Z","steps":["trace[1079334808] 'agreement among raft nodes before linearized reading' (duration: 735.789102ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:00:01.802536Z","caller":"traceutil/trace.go:171","msg":"trace[476276364] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2131; }","duration":"621.847233ms","start":"2026-05-24T10:00:01.180675Z","end":"2026-05-24T10:00:01.802522Z","steps":["trace[476276364] 'agreement among raft nodes before linearized reading' (duration: 621.719748ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:00:01.802552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.066509Z","time spent":"736.03465ms","remote":"127.0.0.1:41268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":869,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b2780aec1b63a5\" "} {"level":"warn","ts":"2026-05-24T10:00:01.802577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.180661Z","time spent":"621.905464ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-24T10:00:01.802613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.377909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-24T10:00:01.802621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.619845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12385"} {"level":"info","ts":"2026-05-24T10:00:01.80267Z","caller":"traceutil/trace.go:171","msg":"trace[1510037099] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:2131; }","duration":"104.478713ms","start":"2026-05-24T10:00:01.698178Z","end":"2026-05-24T10:00:01.802657Z","steps":["trace[1510037099] 'agreement among raft nodes before linearized reading' (duration: 104.39501ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:00:01.802683Z","caller":"traceutil/trace.go:171","msg":"trace[1087536455] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2131; }","duration":"528.724018ms","start":"2026-05-24T10:00:01.273943Z","end":"2026-05-24T10:00:01.802667Z","steps":["trace[1087536455] 'agreement among raft nodes before linearized reading' (duration: 528.536102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:00:01.80273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.273898Z","time spent":"528.820452ms","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12408,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-05-24T10:00:01.802588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"724.576468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-05-24T10:00:01.80275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.585964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-24T10:00:01.802812Z","caller":"traceutil/trace.go:171","msg":"trace[1663952527] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2131; }","duration":"621.685827ms","start":"2026-05-24T10:00:01.181112Z","end":"2026-05-24T10:00:01.802798Z","steps":["trace[1663952527] 'agreement among raft nodes before linearized reading' (duration: 621.548363ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:00:01.802853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.181092Z","time spent":"621.748819ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-24T10:00:01.802909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.423821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-24T10:00:01.802529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.096763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:123563"} {"level":"info","ts":"2026-05-24T10:00:01.802949Z","caller":"traceutil/trace.go:171","msg":"trace[266399191] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2131; }","duration":"622.514294ms","start":"2026-05-24T10:00:01.180425Z","end":"2026-05-24T10:00:01.80294Z","steps":["trace[266399191] 'agreement among raft nodes before linearized reading' (duration: 622.416521ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:00:01.80296Z","caller":"traceutil/trace.go:171","msg":"trace[521671461] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2131; }","duration":"457.569708ms","start":"2026-05-24T10:00:01.345377Z","end":"2026-05-24T10:00:01.802947Z","steps":["trace[521671461] 'agreement among raft nodes before linearized reading' (duration: 456.99561ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:00:01.802979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.18041Z","time spent":"622.562445ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-24T10:00:01.803004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.345355Z","time spent":"457.635961ms","remote":"127.0.0.1:41256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":123586,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"info","ts":"2026-05-24T10:00:01.803028Z","caller":"traceutil/trace.go:171","msg":"trace[1835955781] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2131; }","duration":"724.825876ms","start":"2026-05-24T10:00:01.077941Z","end":"2026-05-24T10:00:01.802767Z","steps":["trace[1835955781] 'agreement among raft nodes before linearized reading' (duration: 724.406483ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:00:01.803295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.07792Z","time spent":"725.361133ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-24T10:00:01.802944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.993583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-24T10:00:01.80342Z","caller":"traceutil/trace.go:171","msg":"trace[2105389568] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2131; }","duration":"260.506789ms","start":"2026-05-24T10:00:01.542887Z","end":"2026-05-24T10:00:01.803394Z","steps":["trace[2105389568] 'agreement among raft nodes before linearized reading' (duration: 259.750764ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:00:01.803098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.097468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-24T10:00:01.803606Z","caller":"traceutil/trace.go:171","msg":"trace[1541853246] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2131; }","duration":"722.611574ms","start":"2026-05-24T10:00:01.080972Z","end":"2026-05-24T10:00:01.803584Z","steps":["trace[1541853246] 'agreement among raft nodes before linearized reading' (duration: 722.072196ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:00:01.802913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.022818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"warn","ts":"2026-05-24T10:00:01.803687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.080961Z","time spent":"722.709348ms","remote":"127.0.0.1:42790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-24T10:00:01.803695Z","caller":"traceutil/trace.go:171","msg":"trace[854421220] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2131; }","duration":"456.844174ms","start":"2026-05-24T10:00:01.346836Z","end":"2026-05-24T10:00:01.80368Z","steps":["trace[854421220] 'agreement among raft nodes before linearized reading' (duration: 456.025908ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:00:01.80386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.346815Z","time spent":"456.977849ms","remote":"127.0.0.1:41258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":141,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-05-24T10:00:02.141965Z","caller":"traceutil/trace.go:171","msg":"trace[2064604021] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"332.105493ms","start":"2026-05-24T10:00:01.809837Z","end":"2026-05-24T10:00:02.141943Z","steps":["trace[2064604021] 'process raft request' (duration: 311.070908ms)","trace[2064604021] 'compare' (duration: 20.744705ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T10:00:02.142107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.809815Z","time spent":"332.209616ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T10:00:02.142198Z","caller":"traceutil/trace.go:171","msg":"trace[1145213643] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"332.058761ms","start":"2026-05-24T10:00:01.81011Z","end":"2026-05-24T10:00:02.142169Z","steps":["trace[1145213643] 'process raft request' (duration: 331.755591ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:00:02.14234Z","caller":"traceutil/trace.go:171","msg":"trace[1690341184] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"331.351848ms","start":"2026-05-24T10:00:01.810978Z","end":"2026-05-24T10:00:02.14233Z","steps":["trace[1690341184] 'process raft request' (duration: 331.10504ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:00:02.142404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.810966Z","time spent":"331.40832ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T10:00:02.142379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.810101Z","time spent":"332.177875ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T10:00:02.142929Z","caller":"traceutil/trace.go:171","msg":"trace[1031205922] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"330.48186ms","start":"2026-05-24T10:00:01.812431Z","end":"2026-05-24T10:00:02.142912Z","steps":["trace[1031205922] 'process raft request' (duration: 329.86069ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:00:02.143154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.81242Z","time spent":"330.572783ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T10:00:02.142926Z","caller":"traceutil/trace.go:171","msg":"trace[84706470] linearizableReadLoop","detail":"{readStateIndex:2214; appliedIndex:2212; }","duration":"332.02308ms","start":"2026-05-24T10:00:01.810883Z","end":"2026-05-24T10:00:02.142906Z","steps":["trace[84706470] 'read index received' (duration: 310.020304ms)","trace[84706470] 'applied index is now lower than readState.Index' (duration: 22.001456ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T10:00:02.143405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.88386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T10:00:02.143495Z","caller":"traceutil/trace.go:171","msg":"trace[257724377] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:2136; }","duration":"188.028024ms","start":"2026-05-24T10:00:01.955447Z","end":"2026-05-24T10:00:02.143475Z","steps":["trace[257724377] 'agreement among raft nodes before linearized reading' (duration: 187.878929ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:00:02.143478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.384174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-24T10:00:02.143815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.460004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-05-24T10:00:02.143876Z","caller":"traceutil/trace.go:171","msg":"trace[92105571] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:2136; }","duration":"332.994071ms","start":"2026-05-24T10:00:01.810867Z","end":"2026-05-24T10:00:02.143861Z","steps":["trace[92105571] 'agreement among raft nodes before linearized reading' (duration: 332.447293ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:00:02.143934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.810851Z","time spent":"333.069674ms","remote":"127.0.0.1:41258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":141,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"warn","ts":"2026-05-24T10:00:02.144271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.359903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:123563"} {"level":"info","ts":"2026-05-24T10:00:02.144434Z","caller":"traceutil/trace.go:171","msg":"trace[270793561] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2136; }","duration":"333.555079ms","start":"2026-05-24T10:00:01.810865Z","end":"2026-05-24T10:00:02.14442Z","steps":["trace[270793561] 'agreement among raft nodes before linearized reading' (duration: 332.095582ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:00:02.1445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.810857Z","time spent":"333.630092ms","remote":"127.0.0.1:41256","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":123586,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"info","ts":"2026-05-24T10:00:02.143678Z","caller":"traceutil/trace.go:171","msg":"trace[1494971650] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2136; }","duration":"329.591291ms","start":"2026-05-24T10:00:01.814057Z","end":"2026-05-24T10:00:02.143648Z","steps":["trace[1494971650] 'agreement among raft nodes before linearized reading' (duration: 329.367524ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:00:02.144562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:00:01.81405Z","time spent":"330.49363ms","remote":"127.0.0.1:41614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-05-24T10:00:58.042164Z","caller":"traceutil/trace.go:171","msg":"trace[126442137] transaction","detail":"{read_only:false; response_revision:2480; number_of_response:1; }","duration":"133.239709ms","start":"2026-05-24T10:00:57.908897Z","end":"2026-05-24T10:00:58.042137Z","steps":["trace[126442137] 'process raft request' (duration: 133.045182ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:01:39.973817Z","caller":"traceutil/trace.go:171","msg":"trace[1579849309] linearizableReadLoop","detail":"{readStateIndex:2867; appliedIndex:2866; }","duration":"283.303927ms","start":"2026-05-24T10:01:39.690495Z","end":"2026-05-24T10:01:39.973799Z","steps":["trace[1579849309] 'read index received' (duration: 283.188513ms)","trace[1579849309] 'applied index is now lower than readState.Index' (duration: 114.344µs)"],"step_count":2} {"level":"info","ts":"2026-05-24T10:01:39.973948Z","caller":"traceutil/trace.go:171","msg":"trace[47841112] transaction","detail":"{read_only:false; response_revision:2764; number_of_response:1; }","duration":"398.650983ms","start":"2026-05-24T10:01:39.575179Z","end":"2026-05-24T10:01:39.97383Z","steps":["trace[47841112] 'process raft request' (duration: 398.505308ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:01:39.974023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.510704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-05-24T10:01:39.974058Z","caller":"traceutil/trace.go:171","msg":"trace[136582411] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2764; }","duration":"283.600587ms","start":"2026-05-24T10:01:39.690448Z","end":"2026-05-24T10:01:39.974048Z","steps":["trace[136582411] 'agreement among raft nodes before linearized reading' (duration: 283.451171ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:01:39.974154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:01:39.575159Z","time spent":"398.880241ms","remote":"127.0.0.1:41354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9268,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T10:01:40.695377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.948129ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-24T10:01:40.695836Z","caller":"traceutil/trace.go:171","msg":"trace[23531835] transaction","detail":"{read_only:false; response_revision:2765; number_of_response:1; }","duration":"921.52322ms","start":"2026-05-24T10:01:39.774285Z","end":"2026-05-24T10:01:40.695808Z","steps":["trace[23531835] 'process raft request' (duration: 450.940399ms)","trace[23531835] 'compare' (duration: 469.334567ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T10:01:40.696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:01:39.774258Z","time spent":"921.642095ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T10:01:40.696096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.114091ms","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-05-24T10:01:40.6962Z","caller":"traceutil/trace.go:171","msg":"trace[247695009] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2765; }","duration":"854.253796ms","start":"2026-05-24T10:01:39.841925Z","end":"2026-05-24T10:01:40.696178Z","steps":["trace[247695009] 'agreement among raft nodes before linearized reading' (duration: 853.992636ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:01:40.696257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:01:39.841908Z","time spent":"854.337379ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-24T10:01:40.696411Z","caller":"traceutil/trace.go:171","msg":"trace[1716737884] transaction","detail":"{read_only:false; response_revision:2766; number_of_response:1; }","duration":"717.495306ms","start":"2026-05-24T10:01:39.978899Z","end":"2026-05-24T10:01:40.696394Z","steps":["trace[1716737884] 'process raft request' (duration: 717.135753ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:01:40.696508Z","caller":"traceutil/trace.go:171","msg":"trace[1882397594] transaction","detail":"{read_only:false; response_revision:2767; number_of_response:1; }","duration":"475.013879ms","start":"2026-05-24T10:01:40.221482Z","end":"2026-05-24T10:01:40.696496Z","steps":["trace[1882397594] 'process raft request' (duration: 474.735219ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:01:40.69582Z","caller":"traceutil/trace.go:171","msg":"trace[1797882880] linearizableReadLoop","detail":"{readStateIndex:2868; appliedIndex:2867; }","duration":"721.918973ms","start":"2026-05-24T10:01:39.973882Z","end":"2026-05-24T10:01:40.695801Z","steps":["trace[1797882880] 'read index received' (duration: 251.355503ms)","trace[1797882880] 'applied index is now lower than readState.Index' (duration: 470.56207ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T10:01:40.696698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:01:40.221463Z","time spent":"475.116893ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T10:01:40.696529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:01:39.97887Z","time spent":"717.585709ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T10:01:40.696621Z","caller":"traceutil/trace.go:171","msg":"trace[1169051482] transaction","detail":"{read_only:false; response_revision:2769; number_of_response:1; }","duration":"471.807095ms","start":"2026-05-24T10:01:40.224799Z","end":"2026-05-24T10:01:40.696606Z","steps":["trace[1169051482] 'process raft request' (duration: 471.588527ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:01:40.696958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:01:40.224785Z","time spent":"472.121016ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T10:01:40.696439Z","caller":"traceutil/trace.go:171","msg":"trace[754131812] transaction","detail":"{read_only:false; response_revision:2768; number_of_response:1; }","duration":"474.140488ms","start":"2026-05-24T10:01:40.222278Z","end":"2026-05-24T10:01:40.696419Z","steps":["trace[754131812] 'process raft request' (duration: 474.062665ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:01:40.697398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:01:40.222267Z","time spent":"475.090071ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T10:01:40.697426Z","caller":"traceutil/trace.go:171","msg":"trace[1594523694] transaction","detail":"{read_only:false; response_revision:2771; number_of_response:1; }","duration":"234.580246ms","start":"2026-05-24T10:01:40.462835Z","end":"2026-05-24T10:01:40.697415Z","steps":["trace[1594523694] 'process raft request' (duration: 234.311176ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:01:40.697242Z","caller":"traceutil/trace.go:171","msg":"trace[1998576454] transaction","detail":"{read_only:false; response_revision:2770; number_of_response:1; }","duration":"470.985486ms","start":"2026-05-24T10:01:40.226238Z","end":"2026-05-24T10:01:40.697223Z","steps":["trace[1998576454] 'process raft request' (duration: 470.81386ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:01:40.697413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.16304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-24T10:01:40.697633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:01:40.226224Z","time spent":"471.331998ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T10:01:40.697689Z","caller":"traceutil/trace.go:171","msg":"trace[589397352] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2771; }","duration":"476.453131ms","start":"2026-05-24T10:01:40.221192Z","end":"2026-05-24T10:01:40.697645Z","steps":["trace[589397352] 'agreement among raft nodes before linearized reading' (duration: 476.15752ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:01:40.69776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:01:40.221172Z","time spent":"476.576934ms","remote":"127.0.0.1:41188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-24T10:05:14.342258Z","caller":"traceutil/trace.go:171","msg":"trace[1854434754] transaction","detail":"{read_only:false; response_revision:4533; number_of_response:1; }","duration":"305.838697ms","start":"2026-05-24T10:05:14.036385Z","end":"2026-05-24T10:05:14.342224Z","steps":["trace[1854434754] 'process raft request' (duration: 305.671962ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:05:14.342521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:05:14.036368Z","time spent":"305.9654ms","remote":"127.0.0.1:41360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4061,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T10:05:14.342852Z","caller":"traceutil/trace.go:171","msg":"trace[2142460596] transaction","detail":"{read_only:false; response_revision:4534; number_of_response:1; }","duration":"275.075117ms","start":"2026-05-24T10:05:14.06775Z","end":"2026-05-24T10:05:14.342825Z","steps":["trace[2142460596] 'process raft request' (duration: 274.942633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:05:15.738825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.070118ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-24T10:05:15.739028Z","caller":"traceutil/trace.go:171","msg":"trace[144501667] transaction","detail":"{read_only:false; response_revision:4540; number_of_response:1; }","duration":"206.2351ms","start":"2026-05-24T10:05:15.532776Z","end":"2026-05-24T10:05:15.739011Z","steps":["trace[144501667] 'process raft request' (duration: 206.193668ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:15.739139Z","caller":"traceutil/trace.go:171","msg":"trace[1645023813] transaction","detail":"{read_only:false; response_revision:4538; number_of_response:1; }","duration":"208.263672ms","start":"2026-05-24T10:05:15.530853Z","end":"2026-05-24T10:05:15.739117Z","steps":["trace[1645023813] 'process raft request' (duration: 99.818522ms)","trace[1645023813] 'compare' (duration: 107.946544ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T10:05:15.739159Z","caller":"traceutil/trace.go:171","msg":"trace[1210894609] transaction","detail":"{read_only:false; response_revision:4539; number_of_response:1; }","duration":"207.441947ms","start":"2026-05-24T10:05:15.531708Z","end":"2026-05-24T10:05:15.73915Z","steps":["trace[1210894609] 'process raft request' (duration: 207.21535ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:19.22212Z","caller":"traceutil/trace.go:171","msg":"trace[1221263149] transaction","detail":"{read_only:false; response_revision:4595; number_of_response:1; }","duration":"138.508175ms","start":"2026-05-24T10:05:19.083588Z","end":"2026-05-24T10:05:19.222096Z","steps":["trace[1221263149] 'process raft request' (duration: 138.35484ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:05:21.222731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.35077ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-24T10:05:21.222817Z","caller":"traceutil/trace.go:171","msg":"trace[629140367] linearizableReadLoop","detail":"{readStateIndex:4842; appliedIndex:4841; }","duration":"138.993827ms","start":"2026-05-24T10:05:21.083811Z","end":"2026-05-24T10:05:21.222805Z","steps":["trace[629140367] 'read index received' (duration: 36.241µs)","trace[629140367] 'applied index is now lower than readState.Index' (duration: 138.956826ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T10:05:21.222965Z","caller":"traceutil/trace.go:171","msg":"trace[121821385] transaction","detail":"{read_only:false; response_revision:4668; number_of_response:1; }","duration":"291.592086ms","start":"2026-05-24T10:05:20.931363Z","end":"2026-05-24T10:05:21.222956Z","steps":["trace[121821385] 'process raft request' (duration: 122.933577ms)","trace[121821385] 'compare' (duration: 168.251186ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T10:05:21.223197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.35982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-24T10:05:21.223286Z","caller":"traceutil/trace.go:171","msg":"trace[625829064] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:4668; }","duration":"139.460413ms","start":"2026-05-24T10:05:21.083805Z","end":"2026-05-24T10:05:21.223266Z","steps":["trace[625829064] 'agreement among raft nodes before linearized reading' (duration: 139.292207ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:21.85767Z","caller":"traceutil/trace.go:171","msg":"trace[1321561348] transaction","detail":"{read_only:false; response_revision:4678; number_of_response:1; }","duration":"268.312804ms","start":"2026-05-24T10:05:21.589332Z","end":"2026-05-24T10:05:21.857645Z","steps":["trace[1321561348] 'process raft request' (duration: 174.872272ms)","trace[1321561348] 'compare' (duration: 93.324529ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T10:05:21.868369Z","caller":"traceutil/trace.go:171","msg":"trace[1771849780] linearizableReadLoop","detail":"{readStateIndex:4854; appliedIndex:4852; }","duration":"236.63013ms","start":"2026-05-24T10:05:21.63171Z","end":"2026-05-24T10:05:21.86834Z","steps":["trace[1771849780] 'read index received' (duration: 132.504615ms)","trace[1771849780] 'applied index is now lower than readState.Index' (duration: 104.124405ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T10:05:21.868544Z","caller":"traceutil/trace.go:171","msg":"trace[1452136107] transaction","detail":"{read_only:false; response_revision:4679; number_of_response:1; }","duration":"231.433849ms","start":"2026-05-24T10:05:21.637098Z","end":"2026-05-24T10:05:21.868532Z","steps":["trace[1452136107] 'process raft request' (duration: 230.932843ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:05:21.868626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.902078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4848"} {"level":"warn","ts":"2026-05-24T10:05:21.869583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.465398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-24T10:05:21.869621Z","caller":"traceutil/trace.go:171","msg":"trace[337153597] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4682; }","duration":"237.9194ms","start":"2026-05-24T10:05:21.631686Z","end":"2026-05-24T10:05:21.869605Z","steps":["trace[337153597] 'agreement among raft nodes before linearized reading' (duration: 236.810766ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:21.869639Z","caller":"traceutil/trace.go:171","msg":"trace[1395995451] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4682; }","duration":"126.570272ms","start":"2026-05-24T10:05:21.743056Z","end":"2026-05-24T10:05:21.869626Z","steps":["trace[1395995451] 'agreement among raft nodes before linearized reading' (duration: 126.449608ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:21.868521Z","caller":"traceutil/trace.go:171","msg":"trace[856067019] transaction","detail":"{read_only:false; response_revision:4680; number_of_response:1; }","duration":"114.683763ms","start":"2026-05-24T10:05:21.753785Z","end":"2026-05-24T10:05:21.868469Z","steps":["trace[856067019] 'process raft request' (duration: 114.396364ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:21.868562Z","caller":"traceutil/trace.go:171","msg":"trace[1319703458] transaction","detail":"{read_only:false; response_revision:4681; number_of_response:1; }","duration":"113.244948ms","start":"2026-05-24T10:05:21.755287Z","end":"2026-05-24T10:05:21.868532Z","steps":["trace[1319703458] 'process raft request' (duration: 112.960489ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:21.869293Z","caller":"traceutil/trace.go:171","msg":"trace[444917485] transaction","detail":"{read_only:false; response_revision:4682; number_of_response:1; }","duration":"113.027191ms","start":"2026-05-24T10:05:21.755465Z","end":"2026-05-24T10:05:21.868493Z","steps":["trace[444917485] 'process raft request' (duration: 112.829935ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:05:21.870467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.144185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206966"} {"level":"info","ts":"2026-05-24T10:05:21.870543Z","caller":"traceutil/trace.go:171","msg":"trace[1545758718] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4682; }","duration":"188.262638ms","start":"2026-05-24T10:05:21.68226Z","end":"2026-05-24T10:05:21.870523Z","steps":["trace[1545758718] 'agreement among raft nodes before linearized reading' (duration: 186.482533ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:22.109008Z","caller":"traceutil/trace.go:171","msg":"trace[628925475] transaction","detail":"{read_only:false; response_revision:4684; number_of_response:1; }","duration":"239.522224ms","start":"2026-05-24T10:05:21.869453Z","end":"2026-05-24T10:05:22.108975Z","steps":["trace[628925475] 'process raft request' (duration: 166.116131ms)","trace[628925475] 'compare' (duration: 73.168085ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T10:05:22.109405Z","caller":"traceutil/trace.go:171","msg":"trace[1698150460] transaction","detail":"{read_only:false; response_revision:4686; number_of_response:1; }","duration":"239.875325ms","start":"2026-05-24T10:05:21.869511Z","end":"2026-05-24T10:05:22.109386Z","steps":["trace[1698150460] 'process raft request' (duration: 239.436981ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:22.109461Z","caller":"traceutil/trace.go:171","msg":"trace[2064414456] transaction","detail":"{read_only:false; response_revision:4689; number_of_response:1; }","duration":"235.20122ms","start":"2026-05-24T10:05:21.874251Z","end":"2026-05-24T10:05:22.109453Z","steps":["trace[2064414456] 'process raft request' (duration: 234.783917ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:22.109576Z","caller":"traceutil/trace.go:171","msg":"trace[1637723931] transaction","detail":"{read_only:false; response_revision:4693; number_of_response:1; }","duration":"230.968618ms","start":"2026-05-24T10:05:21.878598Z","end":"2026-05-24T10:05:22.109566Z","steps":["trace[1637723931] 'process raft request' (duration: 230.731481ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:22.10963Z","caller":"traceutil/trace.go:171","msg":"trace[260174415] transaction","detail":"{read_only:false; response_revision:4685; number_of_response:1; }","duration":"240.148613ms","start":"2026-05-24T10:05:21.869466Z","end":"2026-05-24T10:05:22.109614Z","steps":["trace[260174415] 'process raft request' (duration: 239.444721ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:22.109636Z","caller":"traceutil/trace.go:171","msg":"trace[1652058218] transaction","detail":"{read_only:false; response_revision:4688; number_of_response:1; }","duration":"240.026659ms","start":"2026-05-24T10:05:21.869579Z","end":"2026-05-24T10:05:22.109606Z","steps":["trace[1652058218] 'process raft request' (duration: 239.423201ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:22.109652Z","caller":"traceutil/trace.go:171","msg":"trace[8302883] linearizableReadLoop","detail":"{readStateIndex:4871; appliedIndex:4858; }","duration":"212.03852ms","start":"2026-05-24T10:05:21.897588Z","end":"2026-05-24T10:05:22.109627Z","steps":["trace[8302883] 'read index received' (duration: 2.857369ms)","trace[8302883] 'applied index is now lower than readState.Index' (duration: 209.180081ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T10:05:22.109732Z","caller":"traceutil/trace.go:171","msg":"trace[952404401] transaction","detail":"{read_only:false; response_revision:4690; number_of_response:1; }","duration":"234.754596ms","start":"2026-05-24T10:05:21.874967Z","end":"2026-05-24T10:05:22.109722Z","steps":["trace[952404401] 'process raft request' (duration: 234.23641ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:22.109424Z","caller":"traceutil/trace.go:171","msg":"trace[415463190] transaction","detail":"{read_only:false; response_revision:4691; number_of_response:1; }","duration":"234.357973ms","start":"2026-05-24T10:05:21.875051Z","end":"2026-05-24T10:05:22.109409Z","steps":["trace[415463190] 'process raft request' (duration: 234.194398ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:05:22.109845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.242416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-05-24T10:05:22.109891Z","caller":"traceutil/trace.go:171","msg":"trace[1689892821] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4695; }","duration":"212.330289ms","start":"2026-05-24T10:05:21.897548Z","end":"2026-05-24T10:05:22.109879Z","steps":["trace[1689892821] 'agreement among raft nodes before linearized reading' (duration: 212.165614ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:22.109937Z","caller":"traceutil/trace.go:171","msg":"trace[896533432] transaction","detail":"{read_only:false; response_revision:4695; number_of_response:1; }","duration":"223.047441ms","start":"2026-05-24T10:05:21.88688Z","end":"2026-05-24T10:05:22.109928Z","steps":["trace[896533432] 'process raft request' (duration: 222.506285ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:22.110073Z","caller":"traceutil/trace.go:171","msg":"trace[1458742366] transaction","detail":"{read_only:false; response_revision:4694; number_of_response:1; }","duration":"231.36579ms","start":"2026-05-24T10:05:21.87869Z","end":"2026-05-24T10:05:22.110055Z","steps":["trace[1458742366] 'process raft request' (duration: 230.668249ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:22.109979Z","caller":"traceutil/trace.go:171","msg":"trace[193157608] transaction","detail":"{read_only:false; response_revision:4687; number_of_response:1; }","duration":"240.325059ms","start":"2026-05-24T10:05:21.869548Z","end":"2026-05-24T10:05:22.109873Z","steps":["trace[193157608] 'process raft request' (duration: 239.423631ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:22.110267Z","caller":"traceutil/trace.go:171","msg":"trace[1596614718] transaction","detail":"{read_only:false; response_revision:4692; number_of_response:1; }","duration":"230.931016ms","start":"2026-05-24T10:05:21.878512Z","end":"2026-05-24T10:05:22.109443Z","steps":["trace[1596614718] 'process raft request' (duration: 230.767111ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:22.308845Z","caller":"traceutil/trace.go:171","msg":"trace[574831330] linearizableReadLoop","detail":"{readStateIndex:4874; appliedIndex:4873; }","duration":"104.8462ms","start":"2026-05-24T10:05:22.20399Z","end":"2026-05-24T10:05:22.308836Z","steps":["trace[574831330] 'read index received' (duration: 12.098877ms)","trace[574831330] 'applied index is now lower than readState.Index' (duration: 92.746413ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T10:05:22.309103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.100398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-05-24T10:05:22.30914Z","caller":"traceutil/trace.go:171","msg":"trace[713905946] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4700; }","duration":"105.17263ms","start":"2026-05-24T10:05:22.203958Z","end":"2026-05-24T10:05:22.309131Z","steps":["trace[713905946] 'agreement among raft nodes before linearized reading' (duration: 104.959714ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:22.309279Z","caller":"traceutil/trace.go:171","msg":"trace[703934201] transaction","detail":"{read_only:false; response_revision:4699; number_of_response:1; }","duration":"100.04868ms","start":"2026-05-24T10:05:22.209211Z","end":"2026-05-24T10:05:22.309259Z","steps":["trace[703934201] 'process raft request' (duration: 99.576766ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:22.308805Z","caller":"traceutil/trace.go:171","msg":"trace[1911109401] transaction","detail":"{read_only:false; response_revision:4698; number_of_response:1; }","duration":"105.564212ms","start":"2026-05-24T10:05:22.203214Z","end":"2026-05-24T10:05:22.308778Z","steps":["trace[1911109401] 'process raft request' (duration: 13.50353ms)","trace[1911109401] 'compare' (duration: 91.892127ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T10:05:22.309489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.213302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-05-24T10:05:22.309921Z","caller":"traceutil/trace.go:171","msg":"trace[1280633098] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4700; }","duration":"105.646025ms","start":"2026-05-24T10:05:22.204228Z","end":"2026-05-24T10:05:22.309874Z","steps":["trace[1280633098] 'agreement among raft nodes before linearized reading' (duration: 105.073177ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:05:22.559161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.182607ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-24T10:05:22.559407Z","caller":"traceutil/trace.go:171","msg":"trace[799690499] linearizableReadLoop","detail":"{readStateIndex:4879; appliedIndex:4877; }","duration":"241.353824ms","start":"2026-05-24T10:05:22.317982Z","end":"2026-05-24T10:05:22.559335Z","steps":["trace[799690499] 'read index received' (duration: 34.607406ms)","trace[799690499] 'applied index is now lower than readState.Index' (duration: 206.745408ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T10:05:22.55963Z","caller":"traceutil/trace.go:171","msg":"trace[911508933] transaction","detail":"{read_only:false; response_revision:4702; number_of_response:1; }","duration":"242.364356ms","start":"2026-05-24T10:05:22.317233Z","end":"2026-05-24T10:05:22.559597Z","steps":["trace[911508933] 'process raft request' (duration: 121.669034ms)","trace[911508933] 'compare' (duration: 119.580138ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T10:05:22.559718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.721345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-05-24T10:05:22.559794Z","caller":"traceutil/trace.go:171","msg":"trace[2066928188] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4703; }","duration":"241.795048ms","start":"2026-05-24T10:05:22.317958Z","end":"2026-05-24T10:05:22.559753Z","steps":["trace[2066928188] 'agreement among raft nodes before linearized reading' (duration: 241.565731ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:22.559802Z","caller":"traceutil/trace.go:171","msg":"trace[1051139381] transaction","detail":"{read_only:false; response_revision:4703; number_of_response:1; }","duration":"235.235304ms","start":"2026-05-24T10:05:22.324524Z","end":"2026-05-24T10:05:22.55976Z","steps":["trace[1051139381] 'process raft request' (duration: 234.737769ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:22.56512Z","caller":"traceutil/trace.go:171","msg":"trace[2144366040] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4703; }","duration":"200.835754ms","start":"2026-05-24T10:05:22.364264Z","end":"2026-05-24T10:05:22.5651Z","steps":["trace[2144366040] 'process raft request' (duration: 200.719051ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:05:22.565222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.718831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-05-24T10:05:22.565364Z","caller":"traceutil/trace.go:171","msg":"trace[809008691] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4703; }","duration":"245.885125ms","start":"2026-05-24T10:05:22.31946Z","end":"2026-05-24T10:05:22.565345Z","steps":["trace[809008691] 'agreement among raft nodes before linearized reading' (duration: 245.639067ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:23.023499Z","caller":"traceutil/trace.go:171","msg":"trace[628464889] linearizableReadLoop","detail":"{readStateIndex:4884; appliedIndex:4883; }","duration":"305.642835ms","start":"2026-05-24T10:05:22.717834Z","end":"2026-05-24T10:05:23.023477Z","steps":["trace[628464889] 'read index received' (duration: 305.401577ms)","trace[628464889] 'applied index is now lower than readState.Index' (duration: 240.318µs)"],"step_count":2} {"level":"info","ts":"2026-05-24T10:05:23.023795Z","caller":"traceutil/trace.go:171","msg":"trace[335199135] transaction","detail":"{read_only:false; response_revision:4706; number_of_response:1; }","duration":"306.972785ms","start":"2026-05-24T10:05:22.71681Z","end":"2026-05-24T10:05:23.023783Z","steps":["trace[335199135] 'process raft request' (duration: 306.524441ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:05:23.023898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:05:22.716796Z","time spent":"307.033988ms","remote":"127.0.0.1:49654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7566,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T10:05:23.024138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.294235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"warn","ts":"2026-05-24T10:05:23.02414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.599906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4848"} {"level":"info","ts":"2026-05-24T10:05:23.024189Z","caller":"traceutil/trace.go:171","msg":"trace[520595322] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4706; }","duration":"306.354786ms","start":"2026-05-24T10:05:22.717823Z","end":"2026-05-24T10:05:23.024177Z","steps":["trace[520595322] 'agreement among raft nodes before linearized reading' (duration: 306.193351ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:23.02426Z","caller":"traceutil/trace.go:171","msg":"trace[1424894078] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4706; }","duration":"299.745221ms","start":"2026-05-24T10:05:22.724493Z","end":"2026-05-24T10:05:23.024238Z","steps":["trace[1424894078] 'agreement among raft nodes before linearized reading' (duration: 299.423631ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:05:23.024393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:05:22.717817Z","time spent":"306.534782ms","remote":"127.0.0.1:41284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3981,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" "} {"level":"info","ts":"2026-05-24T10:05:30.204437Z","caller":"traceutil/trace.go:171","msg":"trace[2102331087] transaction","detail":"{read_only:false; response_revision:4832; number_of_response:1; }","duration":"241.033416ms","start":"2026-05-24T10:05:29.963378Z","end":"2026-05-24T10:05:30.204411Z","steps":["trace[2102331087] 'process raft request' (duration: 240.661985ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:30.210752Z","caller":"traceutil/trace.go:171","msg":"trace[768938071] transaction","detail":"{read_only:false; response_revision:4833; number_of_response:1; }","duration":"246.674364ms","start":"2026-05-24T10:05:29.964062Z","end":"2026-05-24T10:05:30.210736Z","steps":["trace[768938071] 'process raft request' (duration: 246.55138ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:30.211034Z","caller":"traceutil/trace.go:171","msg":"trace[482141283] transaction","detail":"{read_only:false; response_revision:4834; number_of_response:1; }","duration":"246.412175ms","start":"2026-05-24T10:05:29.964606Z","end":"2026-05-24T10:05:30.211018Z","steps":["trace[482141283] 'process raft request' (duration: 246.092585ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:30.211041Z","caller":"traceutil/trace.go:171","msg":"trace[72058807] linearizableReadLoop","detail":"{readStateIndex:5019; appliedIndex:5015; }","duration":"105.532235ms","start":"2026-05-24T10:05:30.105487Z","end":"2026-05-24T10:05:30.21102Z","steps":["trace[72058807] 'read index received' (duration: 98.841056ms)","trace[72058807] 'applied index is now lower than readState.Index' (duration: 6.690439ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T10:05:30.211151Z","caller":"traceutil/trace.go:171","msg":"trace[2036971624] transaction","detail":"{read_only:false; response_revision:4835; number_of_response:1; }","duration":"245.981751ms","start":"2026-05-24T10:05:29.965133Z","end":"2026-05-24T10:05:30.211115Z","steps":["trace[2036971624] 'process raft request' (duration: 245.783965ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:05:30.211223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.719051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T10:05:30.211488Z","caller":"traceutil/trace.go:171","msg":"trace[727539048] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:4835; }","duration":"106.01567ms","start":"2026-05-24T10:05:30.105429Z","end":"2026-05-24T10:05:30.211445Z","steps":["trace[727539048] 'agreement among raft nodes before linearized reading' (duration: 105.7045ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:36.602195Z","caller":"traceutil/trace.go:171","msg":"trace[329939157] transaction","detail":"{read_only:false; response_revision:4881; number_of_response:1; }","duration":"352.175844ms","start":"2026-05-24T10:05:36.24999Z","end":"2026-05-24T10:05:36.602165Z","steps":["trace[329939157] 'process raft request' (duration: 333.635971ms)","trace[329939157] 'compare' (duration: 18.087639ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T10:05:36.602306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:05:36.249971Z","time spent":"352.278318ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T10:05:36.603204Z","caller":"traceutil/trace.go:171","msg":"trace[342754058] transaction","detail":"{read_only:false; response_revision:4882; number_of_response:1; }","duration":"352.899878ms","start":"2026-05-24T10:05:36.250287Z","end":"2026-05-24T10:05:36.603187Z","steps":["trace[342754058] 'process raft request' (duration: 352.051301ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:05:36.603311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:05:36.250272Z","time spent":"352.98325ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T10:05:36.603528Z","caller":"traceutil/trace.go:171","msg":"trace[931216313] transaction","detail":"{read_only:false; response_revision:4885; number_of_response:1; }","duration":"351.70952ms","start":"2026-05-24T10:05:36.251807Z","end":"2026-05-24T10:05:36.603517Z","steps":["trace[931216313] 'process raft request' (duration: 351.679669ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:05:36.603551Z","caller":"traceutil/trace.go:171","msg":"trace[770375282] transaction","detail":"{read_only:false; response_revision:4883; number_of_response:1; }","duration":"353.180536ms","start":"2026-05-24T10:05:36.250345Z","end":"2026-05-24T10:05:36.603526Z","steps":["trace[770375282] 'process raft request' (duration: 352.763863ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:05:36.603589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:05:36.251793Z","time spent":"351.766441ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T10:05:36.603833Z","caller":"traceutil/trace.go:171","msg":"trace[586438734] transaction","detail":"{read_only:false; response_revision:4884; number_of_response:1; }","duration":"352.063891ms","start":"2026-05-24T10:05:36.25176Z","end":"2026-05-24T10:05:36.603824Z","steps":["trace[586438734] 'process raft request' (duration: 351.621487ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:05:36.603888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:05:36.251749Z","time spent":"352.114813ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T10:05:36.604239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:05:36.25034Z","time spent":"353.273149ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T10:06:27.427816Z","caller":"traceutil/trace.go:171","msg":"trace[1496014086] transaction","detail":"{read_only:false; response_revision:5300; number_of_response:1; }","duration":"191.36753ms","start":"2026-05-24T10:06:27.236421Z","end":"2026-05-24T10:06:27.427788Z","steps":["trace[1496014086] 'process raft request' (duration: 191.197044ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:07:00.190502Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2872} {"level":"info","ts":"2026-05-24T10:07:00.280748Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2872,"took":"88.828177ms","hash":446372612,"current-db-size-bytes":54198272,"current-db-size":"54 MB","current-db-size-in-use-bytes":29122560,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-24T10:07:00.280804Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":446372612,"revision":2872,"compact-revision":-1} {"level":"info","ts":"2026-05-24T10:09:28.011993Z","caller":"traceutil/trace.go:171","msg":"trace[584893500] transaction","detail":"{read_only:false; response_revision:6554; number_of_response:1; }","duration":"139.288286ms","start":"2026-05-24T10:09:27.87268Z","end":"2026-05-24T10:09:28.011969Z","steps":["trace[584893500] 'process raft request' (duration: 139.246095ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:09:28.012054Z","caller":"traceutil/trace.go:171","msg":"trace[1275689382] linearizableReadLoop","detail":"{readStateIndex:6791; appliedIndex:6790; }","duration":"141.044546ms","start":"2026-05-24T10:09:27.87098Z","end":"2026-05-24T10:09:28.012025Z","steps":["trace[1275689382] 'read index received' (duration: 50.357013ms)","trace[1275689382] 'applied index is now lower than readState.Index' (duration: 90.684723ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T10:09:28.012295Z","caller":"traceutil/trace.go:171","msg":"trace[291889258] transaction","detail":"{read_only:false; response_revision:6551; number_of_response:1; }","duration":"141.430079ms","start":"2026-05-24T10:09:27.870838Z","end":"2026-05-24T10:09:28.012268Z","steps":["trace[291889258] 'process raft request' (duration: 50.489468ms)","trace[291889258] 'compare' (duration: 90.144124ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T10:09:28.012392Z","caller":"traceutil/trace.go:171","msg":"trace[831998153] transaction","detail":"{read_only:false; response_revision:6552; number_of_response:1; }","duration":"141.261613ms","start":"2026-05-24T10:09:27.871121Z","end":"2026-05-24T10:09:28.012382Z","steps":["trace[831998153] 'process raft request' (duration: 140.639692ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:09:28.01244Z","caller":"traceutil/trace.go:171","msg":"trace[1651292055] transaction","detail":"{read_only:false; response_revision:6553; number_of_response:1; }","duration":"140.009961ms","start":"2026-05-24T10:09:27.872422Z","end":"2026-05-24T10:09:28.012432Z","steps":["trace[1651292055] 'process raft request' (duration: 139.423051ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:09:28.013553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.18401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-24T10:09:28.012437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.425159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/horizon-db-sync-lvvcl\" ","response":"range_response_count:1 size:6544"} {"level":"info","ts":"2026-05-24T10:09:28.013641Z","caller":"traceutil/trace.go:171","msg":"trace[553520840] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6554; }","duration":"103.305555ms","start":"2026-05-24T10:09:27.91029Z","end":"2026-05-24T10:09:28.013595Z","steps":["trace[553520840] 'agreement among raft nodes before linearized reading' (duration: 103.17939ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:09:28.013643Z","caller":"traceutil/trace.go:171","msg":"trace[994437656] range","detail":"{range_begin:/registry/pods/openstack/horizon-db-sync-lvvcl; range_end:; response_count:1; response_revision:6554; }","duration":"142.718674ms","start":"2026-05-24T10:09:27.870905Z","end":"2026-05-24T10:09:28.013624Z","steps":["trace[994437656] 'agreement among raft nodes before linearized reading' (duration: 141.219742ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:09:33.402565Z","caller":"traceutil/trace.go:171","msg":"trace[1863717127] transaction","detail":"{read_only:false; response_revision:6577; number_of_response:1; }","duration":"105.327616ms","start":"2026-05-24T10:09:33.297211Z","end":"2026-05-24T10:09:33.402539Z","steps":["trace[1863717127] 'process raft request' (duration: 105.14542ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:09:33.412952Z","caller":"traceutil/trace.go:171","msg":"trace[1048133302] transaction","detail":"{read_only:false; response_revision:6579; number_of_response:1; }","duration":"108.586478ms","start":"2026-05-24T10:09:33.304342Z","end":"2026-05-24T10:09:33.412929Z","steps":["trace[1048133302] 'process raft request' (duration: 108.472414ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:09:33.412985Z","caller":"traceutil/trace.go:171","msg":"trace[1617812647] transaction","detail":"{read_only:false; response_revision:6578; number_of_response:1; }","duration":"111.574491ms","start":"2026-05-24T10:09:33.301384Z","end":"2026-05-24T10:09:33.412958Z","steps":["trace[1617812647] 'process raft request' (duration: 111.25817ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:09:33.413151Z","caller":"traceutil/trace.go:171","msg":"trace[984546801] transaction","detail":"{read_only:false; response_revision:6580; number_of_response:1; }","duration":"108.316929ms","start":"2026-05-24T10:09:33.304807Z","end":"2026-05-24T10:09:33.413124Z","steps":["trace[984546801] 'process raft request' (duration: 108.079721ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:09:33.707585Z","caller":"traceutil/trace.go:171","msg":"trace[1448376949] transaction","detail":"{read_only:false; response_revision:6581; number_of_response:1; }","duration":"101.699192ms","start":"2026-05-24T10:09:33.605848Z","end":"2026-05-24T10:09:33.707547Z","steps":["trace[1448376949] 'process raft request' (duration: 101.430783ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:09:57.68653Z","caller":"traceutil/trace.go:171","msg":"trace[1328992926] transaction","detail":"{read_only:false; response_revision:6753; number_of_response:1; }","duration":"102.097384ms","start":"2026-05-24T10:09:57.584407Z","end":"2026-05-24T10:09:57.686504Z","steps":["trace[1328992926] 'process raft request' (duration: 101.943829ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T10:09:57.912113Z","caller":"traceutil/trace.go:171","msg":"trace[519762520] transaction","detail":"{read_only:false; response_revision:6754; number_of_response:1; }","duration":"315.693097ms","start":"2026-05-24T10:09:57.596382Z","end":"2026-05-24T10:09:57.912075Z","steps":["trace[519762520] 'process raft request' (duration: 215.385693ms)","trace[519762520] 'compare' (duration: 99.763115ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T10:09:57.912216Z","caller":"traceutil/trace.go:171","msg":"trace[1030235796] transaction","detail":"{read_only:false; response_revision:6755; number_of_response:1; }","duration":"310.043853ms","start":"2026-05-24T10:09:57.602153Z","end":"2026-05-24T10:09:57.912197Z","steps":["trace[1030235796] 'process raft request' (duration: 309.523645ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:09:57.912326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:09:57.602134Z","time spent":"310.124836ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T10:09:57.912331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:09:57.59636Z","time spent":"315.873133ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T10:09:57.912496Z","caller":"traceutil/trace.go:171","msg":"trace[1243853936] transaction","detail":"{read_only:false; response_revision:6756; number_of_response:1; }","duration":"309.37079ms","start":"2026-05-24T10:09:57.603108Z","end":"2026-05-24T10:09:57.912479Z","steps":["trace[1243853936] 'process raft request' (duration: 308.647896ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T10:09:57.912615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T10:09:57.6031Z","time spent":"309.468344ms","remote":"127.0.0.1:41432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T10:12:00.195161Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5547} {"level":"info","ts":"2026-05-24T10:12:00.270174Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5547,"took":"73.900209ms","hash":2506679419,"current-db-size-bytes":54198272,"current-db-size":"54 MB","current-db-size-in-use-bytes":18223104,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-24T10:12:00.270235Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2506679419,"revision":5547,"compact-revision":2872}