{"level":"warn","ts":"2026-04-13T21:10:58.160993Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T21:10:58.16108Z","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-04-13T21:10:58.161148Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T21:10:58.161157Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-04-13T21:10:58.161173Z","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-04-13T21:10:58.161831Z","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-04-13T21:10:58.161898Z","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":16,"max-cpu-available":16,"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-04-13T21:10:58.168475Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.50831ms"} {"level":"info","ts":"2026-04-13T21:10:58.177405Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"} {"level":"info","ts":"2026-04-13T21:10:58.177599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T21:10:58.177644Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"} {"level":"info","ts":"2026-04-13T21:10:58.177667Z","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-04-13T21:10:58.177681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"} {"level":"info","ts":"2026-04-13T21:10:58.177745Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"warn","ts":"2026-04-13T21:10:58.190587Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T21:10:58.193586Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T21:10:58.194989Z","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-04-13T21:10:58.197895Z","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-04-13T21:10:58.198306Z","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-04-13T21:10:58.198406Z","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-04-13T21:10:58.198417Z","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-04-13T21:10:58.198418Z","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-04-13T21:10:58.200067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"info","ts":"2026-04-13T21:10:58.200261Z","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-04-13T21:10:58.202669Z","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-04-13T21:10:58.202851Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-04-13T21:10:58.202901Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-04-13T21:10:58.202908Z","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-04-13T21:10:58.202954Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T21:10:59.078282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T21:10:59.078362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T21:10:59.078418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"} {"level":"info","ts":"2026-04-13T21:10:59.07844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"} {"level":"info","ts":"2026-04-13T21:10:59.078452Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-04-13T21:10:59.07847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"} {"level":"info","ts":"2026-04-13T21:10:59.078483Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-04-13T21:10:59.079291Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:10:59.080035Z","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-04-13T21:10:59.080313Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T21:10:59.080656Z","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-04-13T21:10:59.080744Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:10:59.080768Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T21:10:59.080817Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T21:10:59.080831Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T21:10:59.080842Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T21:10:59.083894Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-13T21:10:59.083901Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"} {"level":"info","ts":"2026-04-13T21:11:18.654967Z","caller":"traceutil/trace.go:171","msg":"trace[1796116144] linearizableReadLoop","detail":"{readStateIndex:462; appliedIndex:461; }","duration":"147.97234ms","start":"2026-04-13T21:11:18.506969Z","end":"2026-04-13T21:11:18.654942Z","steps":["trace[1796116144] 'read index received' (duration: 147.720953ms)","trace[1796116144] 'applied index is now lower than readState.Index' (duration: 250.286µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:11:18.655091Z","caller":"traceutil/trace.go:171","msg":"trace[792721569] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"198.234962ms","start":"2026-04-13T21:11:18.456813Z","end":"2026-04-13T21:11:18.655048Z","steps":["trace[792721569] 'process raft request' (duration: 197.954805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:11:18.655189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.212485ms","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-04-13T21:11:18.655278Z","caller":"traceutil/trace.go:171","msg":"trace[438247630] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:447; }","duration":"148.336199ms","start":"2026-04-13T21:11:18.506925Z","end":"2026-04-13T21:11:18.655262Z","steps":["trace[438247630] 'agreement among raft nodes before linearized reading' (duration: 148.125363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:11:18.65525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.750186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:11:18.655347Z","caller":"traceutil/trace.go:171","msg":"trace[1486902427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:447; }","duration":"110.89896ms","start":"2026-04-13T21:11:18.544423Z","end":"2026-04-13T21:11:18.655322Z","steps":["trace[1486902427] 'agreement among raft nodes before linearized reading' (duration: 110.721726ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:11:18.909465Z","caller":"traceutil/trace.go:171","msg":"trace[1582497688] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"250.658181ms","start":"2026-04-13T21:11:18.65876Z","end":"2026-04-13T21:11:18.909418Z","steps":["trace[1582497688] 'process raft request' (duration: 205.494237ms)","trace[1582497688] 'compare' (duration: 45.055801ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:11:18.910218Z","caller":"traceutil/trace.go:171","msg":"trace[1633657452] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"250.884646ms","start":"2026-04-13T21:11:18.659295Z","end":"2026-04-13T21:11:18.91018Z","steps":["trace[1633657452] 'process raft request' (duration: 250.757063ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:11:28.47348Z","caller":"traceutil/trace.go:171","msg":"trace[1588049093] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"180.595806ms","start":"2026-04-13T21:11:28.292851Z","end":"2026-04-13T21:11:28.473447Z","steps":["trace[1588049093] 'process raft request' (duration: 180.454962ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:11:28.480089Z","caller":"traceutil/trace.go:171","msg":"trace[1998013929] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"169.025862ms","start":"2026-04-13T21:11:28.311032Z","end":"2026-04-13T21:11:28.480058Z","steps":["trace[1998013929] 'process raft request' (duration: 168.638473ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:11:28.480254Z","caller":"traceutil/trace.go:171","msg":"trace[346596457] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"169.151566ms","start":"2026-04-13T21:11:28.311074Z","end":"2026-04-13T21:11:28.480226Z","steps":["trace[346596457] 'process raft request' (duration: 168.839948ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:11:28.480445Z","caller":"traceutil/trace.go:171","msg":"trace[1823846119] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"158.162088ms","start":"2026-04-13T21:11:28.32227Z","end":"2026-04-13T21:11:28.480432Z","steps":["trace[1823846119] 'process raft request' (duration: 157.909131ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:11:28.480462Z","caller":"traceutil/trace.go:171","msg":"trace[1514501877] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"158.204669ms","start":"2026-04-13T21:11:28.322173Z","end":"2026-04-13T21:11:28.480377Z","steps":["trace[1514501877] 'process raft request' (duration: 157.897691ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:11:28.480606Z","caller":"traceutil/trace.go:171","msg":"trace[1967773176] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"156.876585ms","start":"2026-04-13T21:11:28.323691Z","end":"2026-04-13T21:11:28.480567Z","steps":["trace[1967773176] 'process raft request' (duration: 156.67941ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:11:28.480753Z","caller":"traceutil/trace.go:171","msg":"trace[356878080] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"156.404874ms","start":"2026-04-13T21:11:28.32433Z","end":"2026-04-13T21:11:28.480735Z","steps":["trace[356878080] 'process raft request' (duration: 156.158567ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:11:28.480894Z","caller":"traceutil/trace.go:171","msg":"trace[1277857981] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"152.872273ms","start":"2026-04-13T21:11:28.32801Z","end":"2026-04-13T21:11:28.480882Z","steps":["trace[1277857981] 'process raft request' (duration: 152.630597ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:11:28.481102Z","caller":"traceutil/trace.go:171","msg":"trace[678100471] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"152.301549ms","start":"2026-04-13T21:11:28.328779Z","end":"2026-04-13T21:11:28.481081Z","steps":["trace[678100471] 'process raft request' (duration: 152.023412ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:11:28.481324Z","caller":"traceutil/trace.go:171","msg":"trace[1801845399] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"148.198185ms","start":"2026-04-13T21:11:28.333114Z","end":"2026-04-13T21:11:28.481313Z","steps":["trace[1801845399] 'process raft request' (duration: 147.897828ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:11:28.481474Z","caller":"traceutil/trace.go:171","msg":"trace[661165616] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"133.976645ms","start":"2026-04-13T21:11:28.347486Z","end":"2026-04-13T21:11:28.481462Z","steps":["trace[661165616] 'process raft request' (duration: 133.78926ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:11:34.619205Z","caller":"traceutil/trace.go:171","msg":"trace[1802932436] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"310.678976ms","start":"2026-04-13T21:11:34.308469Z","end":"2026-04-13T21:11:34.619148Z","steps":["trace[1802932436] 'process raft request' (duration: 309.493425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:11:34.619986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:11:34.308428Z","time spent":"310.998054ms","remote":"127.0.0.1:54522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:11:35.546556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.818505ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:11:35.546693Z","caller":"traceutil/trace.go:171","msg":"trace[1417305502] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"806.69266ms","start":"2026-04-13T21:11:34.739982Z","end":"2026-04-13T21:11:35.546674Z","steps":["trace[1417305502] 'read index received' (duration: 78.051359ms)","trace[1417305502] 'applied index is now lower than readState.Index' (duration: 728.639761ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:11:35.546967Z","caller":"traceutil/trace.go:171","msg":"trace[727548209] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"813.442335ms","start":"2026-04-13T21:11:34.733489Z","end":"2026-04-13T21:11:35.546931Z","steps":["trace[727548209] 'process raft request' (duration: 83.967823ms)","trace[727548209] 'compare' (duration: 728.62567ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:11:35.547155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"807.152192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-13T21:11:35.5473Z","caller":"traceutil/trace.go:171","msg":"trace[465317967] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:613; }","duration":"807.295186ms","start":"2026-04-13T21:11:34.739948Z","end":"2026-04-13T21:11:35.547243Z","steps":["trace[465317967] 'agreement among raft nodes before linearized reading' (duration: 807.003068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:11:35.547343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:11:34.739936Z","time spent":"807.399608ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-13T21:11:35.547168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:11:34.733449Z","time spent":"813.6148ms","remote":"127.0.0.1:54608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:11:35.553411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"547.590425ms","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-04-13T21:11:35.55353Z","caller":"traceutil/trace.go:171","msg":"trace[1760680141] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:614; }","duration":"547.767449ms","start":"2026-04-13T21:11:35.005734Z","end":"2026-04-13T21:11:35.553502Z","steps":["trace[1760680141] 'agreement among raft nodes before linearized reading' (duration: 547.364709ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:11:35.553549Z","caller":"traceutil/trace.go:171","msg":"trace[702606419] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"426.22563ms","start":"2026-04-13T21:11:35.127274Z","end":"2026-04-13T21:11:35.5535Z","steps":["trace[702606419] 'process raft request' (duration: 422.429462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:11:35.553685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.496948ms","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-04-13T21:11:35.553716Z","caller":"traceutil/trace.go:171","msg":"trace[971288498] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:614; }","duration":"543.55113ms","start":"2026-04-13T21:11:35.010156Z","end":"2026-04-13T21:11:35.553707Z","steps":["trace[971288498] 'agreement among raft nodes before linearized reading' (duration: 543.457657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:11:35.55373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:11:35.127241Z","time spent":"426.389195ms","remote":"127.0.0.1:54522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:11:35.553747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:11:35.010144Z","time spent":"543.59616ms","remote":"127.0.0.1:54676","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-04-13T21:11:35.553586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:11:35.005712Z","time spent":"547.863711ms","remote":"127.0.0.1:54676","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-04-13T21:11:50.064078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.732916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-94wdh\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-13T21:11:50.064203Z","caller":"traceutil/trace.go:171","msg":"trace[1349032505] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-94wdh; range_end:; response_count:1; response_revision:769; }","duration":"293.911661ms","start":"2026-04-13T21:11:49.770265Z","end":"2026-04-13T21:11:50.064177Z","steps":["trace[1349032505] 'range keys from in-memory index tree' (duration: 293.541261ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:11:50.27332Z","caller":"traceutil/trace.go:171","msg":"trace[1968575535] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"200.452641ms","start":"2026-04-13T21:11:50.072843Z","end":"2026-04-13T21:11:50.273296Z","steps":["trace[1968575535] 'process raft request' (duration: 200.257276ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:12:37.227353Z","caller":"traceutil/trace.go:171","msg":"trace[2122203013] transaction","detail":"{read_only:false; response_revision:1414; number_of_response:1; }","duration":"166.778197ms","start":"2026-04-13T21:12:37.06055Z","end":"2026-04-13T21:12:37.227329Z","steps":["trace[2122203013] 'process raft request' (duration: 166.648724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:01.667184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.287647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:13:01.667295Z","caller":"traceutil/trace.go:171","msg":"trace[177787803] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1815; }","duration":"685.490222ms","start":"2026-04-13T21:13:00.981786Z","end":"2026-04-13T21:13:01.667276Z","steps":["trace[177787803] 'count revisions from in-memory index tree' (duration: 685.063941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:01.667341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:13:00.981752Z","time spent":"685.576854ms","remote":"127.0.0.1:47488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:13:01.667661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.204496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a095f6cc-e9b1-41b5-9b28-0e6007b34dad\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-13T21:13:01.667759Z","caller":"traceutil/trace.go:171","msg":"trace[1030252765] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a095f6cc-e9b1-41b5-9b28-0e6007b34dad; range_end:; response_count:1; response_revision:1815; }","duration":"525.388531ms","start":"2026-04-13T21:13:01.142352Z","end":"2026-04-13T21:13:01.66774Z","steps":["trace[1030252765] 'range keys from in-memory index tree' (duration: 525.011731ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:01.667799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:13:01.142322Z","time spent":"525.466183ms","remote":"127.0.0.1:54608","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-a095f6cc-e9b1-41b5-9b28-0e6007b34dad\" "} {"level":"info","ts":"2026-04-13T21:13:01.667815Z","caller":"traceutil/trace.go:171","msg":"trace[1056944621] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"323.618724ms","start":"2026-04-13T21:13:01.34417Z","end":"2026-04-13T21:13:01.667788Z","steps":["trace[1056944621] 'process raft request' (duration: 280.964455ms)","trace[1056944621] 'compare' (duration: 42.483155ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:13:01.668015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:13:01.344145Z","time spent":"323.768378ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:13:01.667534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.031962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:13:01.667812Z","caller":"traceutil/trace.go:171","msg":"trace[988218727] linearizableReadLoop","detail":"{readStateIndex:1885; appliedIndex:1884; }","duration":"209.5372ms","start":"2026-04-13T21:13:01.458225Z","end":"2026-04-13T21:13:01.667762Z","steps":["trace[988218727] 'read index received' (duration: 166.818679ms)","trace[988218727] 'applied index is now lower than readState.Index' (duration: 42.717081ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:13:01.668152Z","caller":"traceutil/trace.go:171","msg":"trace[1626745749] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1815; }","duration":"333.695589ms","start":"2026-04-13T21:13:01.334437Z","end":"2026-04-13T21:13:01.668132Z","steps":["trace[1626745749] 'count revisions from in-memory index tree' (duration: 332.926679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:01.668219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:13:01.334411Z","time spent":"333.787091ms","remote":"127.0.0.1:54512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:13:01.668081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.856128ms","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-04-13T21:13:01.668293Z","caller":"traceutil/trace.go:171","msg":"trace[1969643149] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1816; }","duration":"210.135726ms","start":"2026-04-13T21:13:01.458144Z","end":"2026-04-13T21:13:01.66828Z","steps":["trace[1969643149] 'agreement among raft nodes before linearized reading' (duration: 209.742816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:01.726687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.727402ms","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-04-13T21:13:01.726775Z","caller":"traceutil/trace.go:171","msg":"trace[1102935980] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1817; }","duration":"239.849336ms","start":"2026-04-13T21:13:01.486906Z","end":"2026-04-13T21:13:01.726755Z","steps":["trace[1102935980] 'agreement among raft nodes before linearized reading' (duration: 239.600849ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:13:01.964539Z","caller":"traceutil/trace.go:171","msg":"trace[756973423] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"290.329891ms","start":"2026-04-13T21:13:01.674186Z","end":"2026-04-13T21:13:01.964516Z","steps":["trace[756973423] 'process raft request' (duration: 290.180487ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:13:02.27159Z","caller":"traceutil/trace.go:171","msg":"trace[273491367] linearizableReadLoop","detail":"{readStateIndex:1888; appliedIndex:1886; }","duration":"384.04947ms","start":"2026-04-13T21:13:01.887475Z","end":"2026-04-13T21:13:02.271525Z","steps":["trace[273491367] 'read index received' (duration: 76.902808ms)","trace[273491367] 'applied index is now lower than readState.Index' (duration: 307.145602ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:13:02.271632Z","caller":"traceutil/trace.go:171","msg":"trace[1579992799] transaction","detail":"{read_only:false; response_revision:1819; number_of_response:1; }","duration":"539.256745ms","start":"2026-04-13T21:13:01.732296Z","end":"2026-04-13T21:13:02.271553Z","steps":["trace[1579992799] 'process raft request' (duration: 496.452181ms)","trace[1579992799] 'compare' (duration: 42.64982ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:13:02.271865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.351539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a095f6cc-e9b1-41b5-9b28-0e6007b34dad\" ","response":"range_response_count:1 size:3746"} {"level":"warn","ts":"2026-04-13T21:13:02.271936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:13:01.73226Z","time spent":"539.495381ms","remote":"127.0.0.1:54676","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-04-13T21:13:02.271954Z","caller":"traceutil/trace.go:171","msg":"trace[991250978] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a095f6cc-e9b1-41b5-9b28-0e6007b34dad; range_end:; response_count:1; response_revision:1819; }","duration":"384.472602ms","start":"2026-04-13T21:13:01.88746Z","end":"2026-04-13T21:13:02.271932Z","steps":["trace[991250978] 'agreement among raft nodes before linearized reading' (duration: 384.208205ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:02.272096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:13:01.887397Z","time spent":"384.668406ms","remote":"127.0.0.1:54608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3769,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a095f6cc-e9b1-41b5-9b28-0e6007b34dad\" "} {"level":"warn","ts":"2026-04-13T21:13:02.293021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.975295ms","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-04-13T21:13:02.293135Z","caller":"traceutil/trace.go:171","msg":"trace[2072360789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1820; }","duration":"241.108649ms","start":"2026-04-13T21:13:02.052008Z","end":"2026-04-13T21:13:02.293116Z","steps":["trace[2072360789] 'agreement among raft nodes before linearized reading' (duration: 240.860522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:02.293104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.242862ms","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-04-13T21:13:02.293253Z","caller":"traceutil/trace.go:171","msg":"trace[382755437] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1820; }","duration":"241.452067ms","start":"2026-04-13T21:13:02.051781Z","end":"2026-04-13T21:13:02.293233Z","steps":["trace[382755437] 'agreement among raft nodes before linearized reading' (duration: 241.126299ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:02.293525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.38291ms","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-04-13T21:13:02.293601Z","caller":"traceutil/trace.go:171","msg":"trace[318932130] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:1820; }","duration":"341.501854ms","start":"2026-04-13T21:13:01.95208Z","end":"2026-04-13T21:13:02.293582Z","steps":["trace[318932130] 'agreement among raft nodes before linearized reading' (duration: 341.296529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:02.293635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.112042ms","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-04-13T21:13:02.293693Z","caller":"traceutil/trace.go:171","msg":"trace[1146328359] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1820; }","duration":"248.193955ms","start":"2026-04-13T21:13:02.045486Z","end":"2026-04-13T21:13:02.29368Z","steps":["trace[1146328359] 'agreement among raft nodes before linearized reading' (duration: 248.084092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:02.29372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.801487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10667"} {"level":"warn","ts":"2026-04-13T21:13:02.293649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:13:01.952061Z","time spent":"341.578596ms","remote":"127.0.0.1:54454","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-04-13T21:13:02.29378Z","caller":"traceutil/trace.go:171","msg":"trace[1587370235] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1820; }","duration":"321.894429ms","start":"2026-04-13T21:13:01.971871Z","end":"2026-04-13T21:13:02.293766Z","steps":["trace[1587370235] 'agreement among raft nodes before linearized reading' (duration: 321.765106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:02.293598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.690277ms","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-04-13T21:13:02.293829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:13:01.971828Z","time spent":"321.989921ms","remote":"127.0.0.1:54608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":10690,"request content":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" "} {"level":"info","ts":"2026-04-13T21:13:02.293845Z","caller":"traceutil/trace.go:171","msg":"trace[1134205594] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1820; }","duration":"240.976655ms","start":"2026-04-13T21:13:02.052859Z","end":"2026-04-13T21:13:02.293836Z","steps":["trace[1134205594] 'agreement among raft nodes before linearized reading' (duration: 240.656817ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:13:13.872987Z","caller":"traceutil/trace.go:171","msg":"trace[131531464] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"107.06149ms","start":"2026-04-13T21:13:13.765894Z","end":"2026-04-13T21:13:13.872955Z","steps":["trace[131531464] 'process raft request' (duration: 49.398967ms)","trace[131531464] 'compare' (duration: 57.52058ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:13:18.001406Z","caller":"traceutil/trace.go:171","msg":"trace[887755237] linearizableReadLoop","detail":"{readStateIndex:2029; appliedIndex:2028; }","duration":"215.561598ms","start":"2026-04-13T21:13:17.78582Z","end":"2026-04-13T21:13:18.001381Z","steps":["trace[887755237] 'read index received' (duration: 215.446985ms)","trace[887755237] 'applied index is now lower than readState.Index' (duration: 113.653µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:13:18.00151Z","caller":"traceutil/trace.go:171","msg":"trace[415283627] transaction","detail":"{read_only:false; response_revision:1955; number_of_response:1; }","duration":"247.962219ms","start":"2026-04-13T21:13:17.753516Z","end":"2026-04-13T21:13:18.001478Z","steps":["trace[415283627] 'process raft request' (duration: 247.690362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:18.001581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.747643ms","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-04-13T21:13:18.001615Z","caller":"traceutil/trace.go:171","msg":"trace[1527858601] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1955; }","duration":"215.794254ms","start":"2026-04-13T21:13:17.785809Z","end":"2026-04-13T21:13:18.001603Z","steps":["trace[1527858601] 'agreement among raft nodes before linearized reading' (duration: 215.65931ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:13:18.110347Z","caller":"traceutil/trace.go:171","msg":"trace[1901307928] transaction","detail":"{read_only:false; response_revision:1956; number_of_response:1; }","duration":"284.400935ms","start":"2026-04-13T21:13:17.825927Z","end":"2026-04-13T21:13:18.110327Z","steps":["trace[1901307928] 'process raft request' (duration: 269.305239ms)","trace[1901307928] 'compare' (duration: 14.944912ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:13:18.110754Z","caller":"traceutil/trace.go:171","msg":"trace[156830306] transaction","detail":"{read_only:false; response_revision:1957; number_of_response:1; }","duration":"226.404043ms","start":"2026-04-13T21:13:17.884314Z","end":"2026-04-13T21:13:18.110718Z","steps":["trace[156830306] 'process raft request' (duration: 225.982222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:56.565407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.014722ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:13:56.56552Z","caller":"traceutil/trace.go:171","msg":"trace[1325948477] linearizableReadLoop","detail":"{readStateIndex:2247; appliedIndex:2246; }","duration":"234.142643ms","start":"2026-04-13T21:13:56.331361Z","end":"2026-04-13T21:13:56.565504Z","steps":["trace[1325948477] 'read index received' (duration: 26.928295ms)","trace[1325948477] 'applied index is now lower than readState.Index' (duration: 207.211438ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:13:56.56565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.294487ms","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-04-13T21:13:56.565679Z","caller":"traceutil/trace.go:171","msg":"trace[649778653] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2166; }","duration":"234.358058ms","start":"2026-04-13T21:13:56.331313Z","end":"2026-04-13T21:13:56.565671Z","steps":["trace[649778653] 'agreement among raft nodes before linearized reading' (duration: 234.246595ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:13:56.56581Z","caller":"traceutil/trace.go:171","msg":"trace[1943751244] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"264.187392ms","start":"2026-04-13T21:13:56.301578Z","end":"2026-04-13T21:13:56.565766Z","steps":["trace[1943751244] 'process raft request' (duration: 56.726608ms)","trace[1943751244] 'compare' (duration: 206.791686ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:13:56.961603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.665676ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:13:56.961843Z","caller":"traceutil/trace.go:171","msg":"trace[290997662] linearizableReadLoop","detail":"{readStateIndex:2249; appliedIndex:2247; }","duration":"345.872602ms","start":"2026-04-13T21:13:56.615948Z","end":"2026-04-13T21:13:56.96182Z","steps":["trace[290997662] 'read index received' (duration: 81.958679ms)","trace[290997662] 'applied index is now lower than readState.Index' (duration: 263.912803ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:13:56.961932Z","caller":"traceutil/trace.go:171","msg":"trace[34213544] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"451.440556ms","start":"2026-04-13T21:13:56.510441Z","end":"2026-04-13T21:13:56.961881Z","steps":["trace[34213544] 'process raft request' (duration: 187.3972ms)","trace[34213544] 'compare' (duration: 263.477941ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:13:56.961967Z","caller":"traceutil/trace.go:171","msg":"trace[49936978] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"354.874771ms","start":"2026-04-13T21:13:56.607066Z","end":"2026-04-13T21:13:56.96194Z","steps":["trace[49936978] 'process raft request' (duration: 354.652255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:56.962078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:13:56.510413Z","time spent":"451.58536ms","remote":"127.0.0.1:54676","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-04-13T21:13:56.962083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:13:56.607043Z","time spent":"354.983123ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:13:56.9621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.141579ms","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":"warn","ts":"2026-04-13T21:13:56.962156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.509746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-13T21:13:56.962224Z","caller":"traceutil/trace.go:171","msg":"trace[406754671] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2168; }","duration":"297.578058ms","start":"2026-04-13T21:13:56.664635Z","end":"2026-04-13T21:13:56.962213Z","steps":["trace[406754671] 'agreement among raft nodes before linearized reading' (duration: 297.464275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:56.962228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.440305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-13T21:13:56.962152Z","caller":"traceutil/trace.go:171","msg":"trace[1250135195] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2168; }","duration":"346.234261ms","start":"2026-04-13T21:13:56.6159Z","end":"2026-04-13T21:13:56.962135Z","steps":["trace[1250135195] 'agreement among raft nodes before linearized reading' (duration: 346.048326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:56.962302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:13:56.615881Z","time spent":"346.415075ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-13T21:13:56.962295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.082621ms","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-04-13T21:13:56.962306Z","caller":"traceutil/trace.go:171","msg":"trace[945154769] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2168; }","duration":"332.565168ms","start":"2026-04-13T21:13:56.629718Z","end":"2026-04-13T21:13:56.962283Z","steps":["trace[945154769] 'agreement among raft nodes before linearized reading' (duration: 332.361473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:56.962359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:13:56.629702Z","time spent":"332.64818ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-13T21:13:56.962357Z","caller":"traceutil/trace.go:171","msg":"trace[2013671217] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2168; }","duration":"301.174163ms","start":"2026-04-13T21:13:56.66116Z","end":"2026-04-13T21:13:56.962334Z","steps":["trace[2013671217] 'agreement among raft nodes before linearized reading' (duration: 301.016009ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:56.962418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:13:56.661139Z","time spent":"301.266046ms","remote":"127.0.0.1:54676","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-04-13T21:13:56.962494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.085862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-13T21:13:56.962517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.269506ms","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-04-13T21:13:56.962656Z","caller":"traceutil/trace.go:171","msg":"trace[1358116144] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2168; }","duration":"301.456491ms","start":"2026-04-13T21:13:56.661177Z","end":"2026-04-13T21:13:56.962633Z","steps":["trace[1358116144] 'agreement among raft nodes before linearized reading' (duration: 300.960958ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:13:56.962582Z","caller":"traceutil/trace.go:171","msg":"trace[1556926454] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2168; }","duration":"301.207684ms","start":"2026-04-13T21:13:56.661353Z","end":"2026-04-13T21:13:56.96256Z","steps":["trace[1556926454] 'agreement among raft nodes before linearized reading' (duration: 300.816514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:56.962712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:13:56.661346Z","time spent":"301.356968ms","remote":"127.0.0.1:54676","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-04-13T21:13:56.963003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:13:56.661157Z","time spent":"301.546343ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-13T21:13:57.23429Z","caller":"traceutil/trace.go:171","msg":"trace[980195150] linearizableReadLoop","detail":"{readStateIndex:2255; appliedIndex:2249; }","duration":"226.16284ms","start":"2026-04-13T21:13:57.008103Z","end":"2026-04-13T21:13:57.234266Z","steps":["trace[980195150] 'read index received' (duration: 38.898613ms)","trace[980195150] 'applied index is now lower than readState.Index' (duration: 187.263197ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:13:57.234313Z","caller":"traceutil/trace.go:171","msg":"trace[627061216] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"267.598391ms","start":"2026-04-13T21:13:56.966672Z","end":"2026-04-13T21:13:57.23427Z","steps":["trace[627061216] 'process raft request' (duration: 267.236801ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:13:57.234382Z","caller":"traceutil/trace.go:171","msg":"trace[1819449284] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"267.369395ms","start":"2026-04-13T21:13:56.966976Z","end":"2026-04-13T21:13:57.234345Z","steps":["trace[1819449284] 'process raft request' (duration: 267.19413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:13:57.234473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.347005ms","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-04-13T21:13:57.234528Z","caller":"traceutil/trace.go:171","msg":"trace[666509234] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2174; }","duration":"226.471858ms","start":"2026-04-13T21:13:57.008042Z","end":"2026-04-13T21:13:57.234514Z","steps":["trace[666509234] 'agreement among raft nodes before linearized reading' (duration: 226.320894ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:13:57.234509Z","caller":"traceutil/trace.go:171","msg":"trace[1053430098] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"267.627652ms","start":"2026-04-13T21:13:56.966844Z","end":"2026-04-13T21:13:57.234472Z","steps":["trace[1053430098] 'process raft request' (duration: 267.273063ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:13:57.234539Z","caller":"traceutil/trace.go:171","msg":"trace[1941032371] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"266.774219ms","start":"2026-04-13T21:13:56.967628Z","end":"2026-04-13T21:13:57.234403Z","steps":["trace[1941032371] 'process raft request' (duration: 266.570134ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:13:57.234528Z","caller":"traceutil/trace.go:171","msg":"trace[648018613] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"266.81472ms","start":"2026-04-13T21:13:56.967655Z","end":"2026-04-13T21:13:57.23447Z","steps":["trace[648018613] 'process raft request' (duration: 266.576444ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:14:31.22106Z","caller":"traceutil/trace.go:171","msg":"trace[1803821755] transaction","detail":"{read_only:false; response_revision:2528; number_of_response:1; }","duration":"151.425674ms","start":"2026-04-13T21:14:31.069614Z","end":"2026-04-13T21:14:31.221039Z","steps":["trace[1803821755] 'process raft request' (duration: 151.118166ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:15:05.437621Z","caller":"traceutil/trace.go:171","msg":"trace[857417746] transaction","detail":"{read_only:false; response_revision:2734; number_of_response:1; }","duration":"110.225085ms","start":"2026-04-13T21:15:05.327357Z","end":"2026-04-13T21:15:05.437582Z","steps":["trace[857417746] 'process raft request' (duration: 109.982389ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:15:05.774345Z","caller":"traceutil/trace.go:171","msg":"trace[192717240] transaction","detail":"{read_only:false; response_revision:2737; number_of_response:1; }","duration":"136.615339ms","start":"2026-04-13T21:15:05.637701Z","end":"2026-04-13T21:15:05.774316Z","steps":["trace[192717240] 'process raft request' (duration: 136.468895ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:15:05.967584Z","caller":"traceutil/trace.go:171","msg":"trace[1677576095] transaction","detail":"{read_only:false; response_revision:2739; number_of_response:1; }","duration":"328.890526ms","start":"2026-04-13T21:15:05.638666Z","end":"2026-04-13T21:15:05.967557Z","steps":["trace[1677576095] 'process raft request' (duration: 328.804654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:15:05.967775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:15:05.638657Z","time spent":"329.011979ms","remote":"127.0.0.1:54676","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-04-13T21:15:05.96787Z","caller":"traceutil/trace.go:171","msg":"trace[2113561485] transaction","detail":"{read_only:false; response_revision:2741; number_of_response:1; }","duration":"325.465234ms","start":"2026-04-13T21:15:05.642363Z","end":"2026-04-13T21:15:05.967829Z","steps":["trace[2113561485] 'process raft request' (duration: 325.348161ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:15:05.967586Z","caller":"traceutil/trace.go:171","msg":"trace[2120844405] transaction","detail":"{read_only:false; response_revision:2738; number_of_response:1; }","duration":"329.089571ms","start":"2026-04-13T21:15:05.638465Z","end":"2026-04-13T21:15:05.967555Z","steps":["trace[2120844405] 'process raft request' (duration: 328.643239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:15:05.96799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:15:05.638424Z","time spent":"329.536433ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:15:05.967996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:15:05.642351Z","time spent":"325.567107ms","remote":"127.0.0.1:54676","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-04-13T21:15:05.968173Z","caller":"traceutil/trace.go:171","msg":"trace[961744771] transaction","detail":"{read_only:false; response_revision:2740; number_of_response:1; }","duration":"328.989908ms","start":"2026-04-13T21:15:05.639062Z","end":"2026-04-13T21:15:05.968052Z","steps":["trace[961744771] 'process raft request' (duration: 328.456994ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:15:05.968404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:15:05.639052Z","time spent":"329.172183ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:17:31.536792Z","caller":"traceutil/trace.go:171","msg":"trace[512320119] transaction","detail":"{read_only:false; response_revision:3707; number_of_response:1; }","duration":"152.186149ms","start":"2026-04-13T21:17:31.384581Z","end":"2026-04-13T21:17:31.536767Z","steps":["trace[512320119] 'process raft request' (duration: 152.024465ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:18:50.713267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.559574ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:18:50.713365Z","caller":"traceutil/trace.go:171","msg":"trace[1977365239] linearizableReadLoop","detail":"{readStateIndex:4822; appliedIndex:4821; }","duration":"171.096128ms","start":"2026-04-13T21:18:50.542254Z","end":"2026-04-13T21:18:50.71335Z","steps":["trace[1977365239] 'read index received' (duration: 59.39128ms)","trace[1977365239] 'applied index is now lower than readState.Index' (duration: 111.703638ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:18:50.713444Z","caller":"traceutil/trace.go:171","msg":"trace[1601180043] transaction","detail":"{read_only:false; response_revision:4641; number_of_response:1; }","duration":"199.166284ms","start":"2026-04-13T21:18:50.514252Z","end":"2026-04-13T21:18:50.713418Z","steps":["trace[1601180043] 'process raft request' (duration: 87.390634ms)","trace[1601180043] 'compare' (duration: 111.254856ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:18:50.713622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.344264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:18:50.713731Z","caller":"traceutil/trace.go:171","msg":"trace[1569495608] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4641; }","duration":"171.493038ms","start":"2026-04-13T21:18:50.54221Z","end":"2026-04-13T21:18:50.713703Z","steps":["trace[1569495608] 'agreement among raft nodes before linearized reading' (duration: 171.233441ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:18:50.714655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.252557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:49 size:1957109"} {"level":"info","ts":"2026-04-13T21:18:50.714696Z","caller":"traceutil/trace.go:171","msg":"trace[289484033] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:49; response_revision:4641; }","duration":"127.332839ms","start":"2026-04-13T21:18:50.587353Z","end":"2026-04-13T21:18:50.714685Z","steps":["trace[289484033] 'agreement among raft nodes before linearized reading' (duration: 126.432375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:18:54.169925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.869886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5650a5ae-ba5b-4f24-8848-b0919901e3ee\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-04-13T21:18:54.170018Z","caller":"traceutil/trace.go:171","msg":"trace[214359906] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5650a5ae-ba5b-4f24-8848-b0919901e3ee; range_end:; response_count:1; response_revision:4837; }","duration":"166.02092ms","start":"2026-04-13T21:18:54.003976Z","end":"2026-04-13T21:18:54.169997Z","steps":["trace[214359906] 'range keys from in-memory index tree' (duration: 165.642701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:18:54.170075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.022121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:18:54.170146Z","caller":"traceutil/trace.go:171","msg":"trace[1657010469] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:4837; }","duration":"153.151024ms","start":"2026-04-13T21:18:54.016977Z","end":"2026-04-13T21:18:54.170128Z","steps":["trace[1657010469] 'count revisions from in-memory index tree' (duration: 152.840125ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:18:55.183203Z","caller":"traceutil/trace.go:171","msg":"trace[2043925996] linearizableReadLoop","detail":"{readStateIndex:5059; appliedIndex:5058; }","duration":"116.892137ms","start":"2026-04-13T21:18:55.066293Z","end":"2026-04-13T21:18:55.183186Z","steps":["trace[2043925996] 'read index received' (duration: 71.994648ms)","trace[2043925996] 'applied index is now lower than readState.Index' (duration: 44.896679ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:18:55.183272Z","caller":"traceutil/trace.go:171","msg":"trace[978057860] transaction","detail":"{read_only:false; response_revision:4873; number_of_response:1; }","duration":"117.203536ms","start":"2026-04-13T21:18:55.066029Z","end":"2026-04-13T21:18:55.183233Z","steps":["trace[978057860] 'process raft request' (duration: 72.166003ms)","trace[978057860] 'compare' (duration: 44.850568ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:18:55.183412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.114423ms","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-04-13T21:18:55.183434Z","caller":"traceutil/trace.go:171","msg":"trace[133537568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4874; }","duration":"114.180825ms","start":"2026-04-13T21:18:55.069248Z","end":"2026-04-13T21:18:55.183429Z","steps":["trace[133537568] 'agreement among raft nodes before linearized reading' (duration: 114.070362ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:18:55.183495Z","caller":"traceutil/trace.go:171","msg":"trace[405556430] transaction","detail":"{read_only:false; response_revision:4874; number_of_response:1; }","duration":"117.159825ms","start":"2026-04-13T21:18:55.066302Z","end":"2026-04-13T21:18:55.183462Z","steps":["trace[405556430] 'process raft request' (duration: 116.857517ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:18:55.183557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.241308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-13T21:18:55.183635Z","caller":"traceutil/trace.go:171","msg":"trace[1046431188] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4874; }","duration":"117.34367ms","start":"2026-04-13T21:18:55.066273Z","end":"2026-04-13T21:18:55.183617Z","steps":["trace[1046431188] 'agreement among raft nodes before linearized reading' (duration: 117.014991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:18:57.166071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.847876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/goldpinger\" ","response":"range_response_count:1 size:799"} {"level":"info","ts":"2026-04-13T21:18:57.166182Z","caller":"traceutil/trace.go:171","msg":"trace[1703925303] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/goldpinger; range_end:; response_count:1; response_revision:4930; }","duration":"127.01208ms","start":"2026-04-13T21:18:57.039144Z","end":"2026-04-13T21:18:57.166156Z","steps":["trace[1703925303] 'range keys from in-memory index tree' (duration: 126.592619ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:18:57.166071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.921918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:1229"} {"level":"info","ts":"2026-04-13T21:18:57.166376Z","caller":"traceutil/trace.go:171","msg":"trace[1714329010] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4930; }","duration":"127.272957ms","start":"2026-04-13T21:18:57.039071Z","end":"2026-04-13T21:18:57.166344Z","steps":["trace[1714329010] 'range keys from in-memory index tree' (duration: 126.63939ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:19:05.468518Z","caller":"traceutil/trace.go:171","msg":"trace[9143524] transaction","detail":"{read_only:false; response_revision:5091; number_of_response:1; }","duration":"190.001188ms","start":"2026-04-13T21:19:05.278496Z","end":"2026-04-13T21:19:05.468497Z","steps":["trace[9143524] 'process raft request' (duration: 166.872652ms)","trace[9143524] 'compare' (duration: 23.025643ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:19:05.468681Z","caller":"traceutil/trace.go:171","msg":"trace[2095681210] transaction","detail":"{read_only:false; response_revision:5092; number_of_response:1; }","duration":"189.985828ms","start":"2026-04-13T21:19:05.278658Z","end":"2026-04-13T21:19:05.468644Z","steps":["trace[2095681210] 'process raft request' (duration: 189.803623ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:19:23.47572Z","caller":"traceutil/trace.go:171","msg":"trace[447252004] linearizableReadLoop","detail":"{readStateIndex:5603; appliedIndex:5602; }","duration":"163.635395ms","start":"2026-04-13T21:19:23.312059Z","end":"2026-04-13T21:19:23.475694Z","steps":["trace[447252004] 'read index received' (duration: 107.196929ms)","trace[447252004] 'applied index is now lower than readState.Index' (duration: 56.437056ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:19:23.475927Z","caller":"traceutil/trace.go:171","msg":"trace[629351264] transaction","detail":"{read_only:false; response_revision:5403; number_of_response:1; }","duration":"220.264886ms","start":"2026-04-13T21:19:23.255641Z","end":"2026-04-13T21:19:23.475906Z","steps":["trace[629351264] 'process raft request' (duration: 163.626915ms)","trace[629351264] 'compare' (duration: 56.149648ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:19:23.476265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.989314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"info","ts":"2026-04-13T21:19:23.476364Z","caller":"traceutil/trace.go:171","msg":"trace[231415717] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5403; }","duration":"164.348654ms","start":"2026-04-13T21:19:23.311998Z","end":"2026-04-13T21:19:23.476346Z","steps":["trace[231415717] 'agreement among raft nodes before linearized reading' (duration: 163.905132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:19:23.809181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.332344ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:19:23.809594Z","caller":"traceutil/trace.go:171","msg":"trace[114484278] transaction","detail":"{read_only:false; response_revision:5409; number_of_response:1; }","duration":"325.385918ms","start":"2026-04-13T21:19:23.484192Z","end":"2026-04-13T21:19:23.809578Z","steps":["trace[114484278] 'process raft request' (duration: 325.340387ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:19:23.809646Z","caller":"traceutil/trace.go:171","msg":"trace[355049808] transaction","detail":"{read_only:false; response_revision:5406; number_of_response:1; }","duration":"326.667454ms","start":"2026-04-13T21:19:23.482967Z","end":"2026-04-13T21:19:23.809634Z","steps":["trace[355049808] 'process raft request' (duration: 326.446338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:19:23.809689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:19:23.484165Z","time spent":"325.483791ms","remote":"127.0.0.1:54602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":951,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:19:23.809719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:19:23.482952Z","time spent":"326.723215ms","remote":"127.0.0.1:54690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1429,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:19:23.809891Z","caller":"traceutil/trace.go:171","msg":"trace[1210998285] transaction","detail":"{read_only:false; response_revision:5405; number_of_response:1; }","duration":"398.29203ms","start":"2026-04-13T21:19:23.411589Z","end":"2026-04-13T21:19:23.809881Z","steps":["trace[1210998285] 'process raft request' (duration: 397.754286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:19:23.809952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:19:23.411566Z","time spent":"398.356042ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:19:23.810066Z","caller":"traceutil/trace.go:171","msg":"trace[1785867676] transaction","detail":"{read_only:false; response_revision:5407; number_of_response:1; }","duration":"327.063584ms","start":"2026-04-13T21:19:23.482991Z","end":"2026-04-13T21:19:23.810054Z","steps":["trace[1785867676] 'process raft request' (duration: 326.465218ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:19:23.810078Z","caller":"traceutil/trace.go:171","msg":"trace[2132459510] linearizableReadLoop","detail":"{readStateIndex:5605; appliedIndex:5603; }","duration":"334.198758ms","start":"2026-04-13T21:19:23.47587Z","end":"2026-04-13T21:19:23.810069Z","steps":["trace[2132459510] 'read index received' (duration: 158.977749ms)","trace[2132459510] 'applied index is now lower than readState.Index' (duration: 175.220009ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:19:23.810126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:19:23.482967Z","time spent":"327.127466ms","remote":"127.0.0.1:54602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:19:23.810254Z","caller":"traceutil/trace.go:171","msg":"trace[720727185] transaction","detail":"{read_only:false; response_revision:5408; number_of_response:1; }","duration":"326.070517ms","start":"2026-04-13T21:19:23.484174Z","end":"2026-04-13T21:19:23.810245Z","steps":["trace[720727185] 'process raft request' (duration: 325.322907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:19:23.810313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:19:23.484161Z","time spent":"326.124468ms","remote":"127.0.0.1:54690","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T21:19:23.80959Z","caller":"traceutil/trace.go:171","msg":"trace[998418154] transaction","detail":"{read_only:false; response_revision:5404; number_of_response:1; }","duration":"491.072219ms","start":"2026-04-13T21:19:23.318489Z","end":"2026-04-13T21:19:23.809562Z","steps":["trace[998418154] 'process raft request' (duration: 316.272962ms)","trace[998418154] 'compare' (duration: 174.198161ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:19:23.810391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.150299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-13T21:19:23.810448Z","caller":"traceutil/trace.go:171","msg":"trace[1828594253] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5409; }","duration":"431.237962ms","start":"2026-04-13T21:19:23.3792Z","end":"2026-04-13T21:19:23.810438Z","steps":["trace[1828594253] 'agreement among raft nodes before linearized reading' (duration: 431.096758ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:19:23.810479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:19:23.379185Z","time spent":"431.287062ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-13T21:19:23.810465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:19:23.31847Z","time spent":"491.921231ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:19:23.810466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.87483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-13T21:19:23.810552Z","caller":"traceutil/trace.go:171","msg":"trace[288217372] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5409; }","duration":"461.982592ms","start":"2026-04-13T21:19:23.348538Z","end":"2026-04-13T21:19:23.81052Z","steps":["trace[288217372] 'agreement among raft nodes before linearized reading' (duration: 461.782856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:19:23.810601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:19:23.348524Z","time spent":"462.069325ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-13T21:19:23.810719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.665978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T21:19:23.810734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.87604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"info","ts":"2026-04-13T21:19:23.810749Z","caller":"traceutil/trace.go:171","msg":"trace[1430370773] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5409; }","duration":"267.73803ms","start":"2026-04-13T21:19:23.543003Z","end":"2026-04-13T21:19:23.810741Z","steps":["trace[1430370773] 'agreement among raft nodes before linearized reading' (duration: 267.689658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:19:23.810746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.070198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-13T21:19:23.810775Z","caller":"traceutil/trace.go:171","msg":"trace[984622203] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5409; }","duration":"329.953942ms","start":"2026-04-13T21:19:23.480809Z","end":"2026-04-13T21:19:23.810763Z","steps":["trace[984622203] 'agreement among raft nodes before linearized reading' (duration: 329.837429ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:19:23.810799Z","caller":"traceutil/trace.go:171","msg":"trace[615744952] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5409; }","duration":"481.149911ms","start":"2026-04-13T21:19:23.329632Z","end":"2026-04-13T21:19:23.810782Z","steps":["trace[615744952] 'agreement among raft nodes before linearized reading' (duration: 480.989576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:19:23.810813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:19:23.480792Z","time spent":"330.014213ms","remote":"127.0.0.1:54608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12234,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-13T21:19:23.810835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.331551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-13T21:19:23.810842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:19:23.329617Z","time spent":"481.213512ms","remote":"127.0.0.1:54592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-04-13T21:19:23.810837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.148794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-13T21:19:23.810882Z","caller":"traceutil/trace.go:171","msg":"trace[1407562000] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5409; }","duration":"256.389983ms","start":"2026-04-13T21:19:23.55448Z","end":"2026-04-13T21:19:23.81087Z","steps":["trace[1407562000] 'agreement among raft nodes before linearized reading' (duration: 256.2757ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:19:23.810908Z","caller":"traceutil/trace.go:171","msg":"trace[713942555] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5409; }","duration":"257.219646ms","start":"2026-04-13T21:19:23.553671Z","end":"2026-04-13T21:19:23.81089Z","steps":["trace[713942555] 'agreement among raft nodes before linearized reading' (duration: 257.01809ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:20:03.867923Z","caller":"traceutil/trace.go:171","msg":"trace[1769391555] transaction","detail":"{read_only:false; response_revision:5766; number_of_response:1; }","duration":"121.281619ms","start":"2026-04-13T21:20:03.7466Z","end":"2026-04-13T21:20:03.867882Z","steps":["trace[1769391555] 'process raft request' (duration: 121.108755ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:20:04.048911Z","caller":"traceutil/trace.go:171","msg":"trace[278948114] transaction","detail":"{read_only:false; response_revision:5767; number_of_response:1; }","duration":"108.443502ms","start":"2026-04-13T21:20:03.94042Z","end":"2026-04-13T21:20:04.048863Z","steps":["trace[278948114] 'process raft request' (duration: 25.682324ms)","trace[278948114] 'compare' (duration: 82.484821ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:20:59.107252Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3030} {"level":"info","ts":"2026-04-13T21:20:59.189577Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3030,"took":"80.747651ms","hash":1298189783,"current-db-size-bytes":59023360,"current-db-size":"59 MB","current-db-size-in-use-bytes":32288768,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-13T21:20:59.189657Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1298189783,"revision":3030,"compact-revision":-1} {"level":"info","ts":"2026-04-13T21:21:08.470882Z","caller":"traceutil/trace.go:171","msg":"trace[708506603] transaction","detail":"{read_only:false; response_revision:6237; number_of_response:1; }","duration":"196.550313ms","start":"2026-04-13T21:21:08.274306Z","end":"2026-04-13T21:21:08.470857Z","steps":["trace[708506603] 'process raft request' (duration: 196.366348ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:21:08.840222Z","caller":"traceutil/trace.go:171","msg":"trace[635800415] linearizableReadLoop","detail":"{readStateIndex:6463; appliedIndex:6462; }","duration":"369.358202ms","start":"2026-04-13T21:21:08.470814Z","end":"2026-04-13T21:21:08.840172Z","steps":["trace[635800415] 'read index received' (duration: 368.779646ms)","trace[635800415] 'applied index is now lower than readState.Index' (duration: 577.096µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:21:08.840279Z","caller":"traceutil/trace.go:171","msg":"trace[1752697871] transaction","detail":"{read_only:false; response_revision:6238; number_of_response:1; }","duration":"444.462199ms","start":"2026-04-13T21:21:08.395775Z","end":"2026-04-13T21:21:08.840238Z","steps":["trace[1752697871] 'process raft request' (duration: 443.836262ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:21:08.84038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.180487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-13T21:21:08.840479Z","caller":"traceutil/trace.go:171","msg":"trace[1430884998] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6238; }","duration":"376.3239ms","start":"2026-04-13T21:21:08.464133Z","end":"2026-04-13T21:21:08.840457Z","steps":["trace[1430884998] 'agreement among raft nodes before linearized reading' (duration: 376.090114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:21:08.84053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:21:08.395739Z","time spent":"444.628414ms","remote":"127.0.0.1:54676","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-04-13T21:21:08.84057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:21:08.464083Z","time spent":"376.480545ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-13T21:21:08.840581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.88857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-13T21:21:08.840551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.552821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-13T21:21:08.840786Z","caller":"traceutil/trace.go:171","msg":"trace[642682791] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6238; }","duration":"371.820339ms","start":"2026-04-13T21:21:08.468944Z","end":"2026-04-13T21:21:08.840764Z","steps":["trace[642682791] 'agreement among raft nodes before linearized reading' (duration: 371.244383ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:21:08.840892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:21:08.46893Z","time spent":"371.923821ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-13T21:21:08.840691Z","caller":"traceutil/trace.go:171","msg":"trace[320264975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6238; }","duration":"438.023285ms","start":"2026-04-13T21:21:08.402631Z","end":"2026-04-13T21:21:08.840654Z","steps":["trace[320264975] 'agreement among raft nodes before linearized reading' (duration: 437.659965ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:21:08.841126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:21:08.402623Z","time spent":"438.462296ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T21:21:08.841226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.868115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:21:08.841308Z","caller":"traceutil/trace.go:171","msg":"trace[1595441236] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6239; }","duration":"296.977468ms","start":"2026-04-13T21:21:08.544302Z","end":"2026-04-13T21:21:08.84128Z","steps":["trace[1595441236] 'agreement among raft nodes before linearized reading' (duration: 296.859744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:21:08.841313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.13495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:21:08.841231Z","caller":"traceutil/trace.go:171","msg":"trace[922478382] transaction","detail":"{read_only:false; response_revision:6239; number_of_response:1; }","duration":"367.033869ms","start":"2026-04-13T21:21:08.47418Z","end":"2026-04-13T21:21:08.841214Z","steps":["trace[922478382] 'process raft request' (duration: 366.859914ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:21:08.841423Z","caller":"traceutil/trace.go:171","msg":"trace[465309474] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:6239; }","duration":"270.249663ms","start":"2026-04-13T21:21:08.571147Z","end":"2026-04-13T21:21:08.841396Z","steps":["trace[465309474] 'agreement among raft nodes before linearized reading' (duration: 270.072048ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:21:08.841517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:21:08.474159Z","time spent":"367.268365ms","remote":"127.0.0.1:54676","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-04-13T21:25:09.158379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.586527ms","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-04-13T21:25:09.158672Z","caller":"traceutil/trace.go:171","msg":"trace[912039395] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8045; }","duration":"339.920236ms","start":"2026-04-13T21:25:08.818723Z","end":"2026-04-13T21:25:09.158643Z","steps":["trace[912039395] 'count revisions from in-memory index tree' (duration: 339.455204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:25:09.158721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:25:08.818709Z","time spent":"339.999658ms","remote":"127.0.0.1:57182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-13T21:25:09.158513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.038374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-13T21:25:09.158763Z","caller":"traceutil/trace.go:171","msg":"trace[1911880827] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8045; }","duration":"399.327701ms","start":"2026-04-13T21:25:08.759421Z","end":"2026-04-13T21:25:09.158748Z","steps":["trace[1911880827] 'range keys from in-memory index tree' (duration: 398.826228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:25:09.158501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.589399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-13T21:25:09.158803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:25:08.759402Z","time spent":"399.390374ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-13T21:25:09.158588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.25195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-65f69bf96-9hs2l.18a607a2d4245ed8\" ","response":"range_response_count:1 size:1131"} {"level":"info","ts":"2026-04-13T21:25:09.158871Z","caller":"traceutil/trace.go:171","msg":"trace[1459309232] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:8045; }","duration":"389.008451ms","start":"2026-04-13T21:25:08.769825Z","end":"2026-04-13T21:25:09.158834Z","steps":["trace[1459309232] 'count revisions from in-memory index tree' (duration: 388.485887ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:25:09.158904Z","caller":"traceutil/trace.go:171","msg":"trace[609711506] range","detail":"{range_begin:/registry/events/openstack/barbican-api-65f69bf96-9hs2l.18a607a2d4245ed8; range_end:; response_count:1; response_revision:8045; }","duration":"206.578259ms","start":"2026-04-13T21:25:08.952285Z","end":"2026-04-13T21:25:09.158864Z","steps":["trace[609711506] 'range keys from in-memory index tree' (duration: 206.084755ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:25:09.158962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:25:08.769805Z","time spent":"389.125704ms","remote":"127.0.0.1:56860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":3,"response size":30,"request content":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true "} {"level":"info","ts":"2026-04-13T21:25:09.294664Z","caller":"traceutil/trace.go:171","msg":"trace[1850770217] transaction","detail":"{read_only:false; response_revision:8046; number_of_response:1; }","duration":"133.674886ms","start":"2026-04-13T21:25:09.160955Z","end":"2026-04-13T21:25:09.29463Z","steps":["trace[1850770217] 'process raft request' (duration: 133.481031ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:25:09.311612Z","caller":"traceutil/trace.go:171","msg":"trace[1868428872] transaction","detail":"{read_only:false; response_revision:8047; number_of_response:1; }","duration":"149.412204ms","start":"2026-04-13T21:25:09.162175Z","end":"2026-04-13T21:25:09.311587Z","steps":["trace[1868428872] 'process raft request' (duration: 149.26351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:25:21.808943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.123125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:25:21.809028Z","caller":"traceutil/trace.go:171","msg":"trace[788258482] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8112; }","duration":"264.252008ms","start":"2026-04-13T21:25:21.544758Z","end":"2026-04-13T21:25:21.80901Z","steps":["trace[788258482] 'range keys from in-memory index tree' (duration: 263.97961ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:25:21.875032Z","caller":"traceutil/trace.go:171","msg":"trace[933133982] transaction","detail":"{read_only:false; response_revision:8113; number_of_response:1; }","duration":"133.257705ms","start":"2026-04-13T21:25:21.741738Z","end":"2026-04-13T21:25:21.874996Z","steps":["trace[933133982] 'process raft request' (duration: 132.979837ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:25:21.903681Z","caller":"traceutil/trace.go:171","msg":"trace[33590365] transaction","detail":"{read_only:false; response_revision:8114; number_of_response:1; }","duration":"159.919728ms","start":"2026-04-13T21:25:21.743732Z","end":"2026-04-13T21:25:21.903652Z","steps":["trace[33590365] 'process raft request' (duration: 159.570959ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:25:49.774655Z","caller":"traceutil/trace.go:171","msg":"trace[943348815] transaction","detail":"{read_only:false; response_revision:8317; number_of_response:1; }","duration":"274.675349ms","start":"2026-04-13T21:25:49.499959Z","end":"2026-04-13T21:25:49.774634Z","steps":["trace[943348815] 'process raft request' (duration: 274.422222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:25:49.774751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.082463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:25:49.774796Z","caller":"traceutil/trace.go:171","msg":"trace[1531927598] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8317; }","duration":"230.178566ms","start":"2026-04-13T21:25:49.544606Z","end":"2026-04-13T21:25:49.774785Z","steps":["trace[1531927598] 'agreement among raft nodes before linearized reading' (duration: 230.093964ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:25:49.774576Z","caller":"traceutil/trace.go:171","msg":"trace[358717774] linearizableReadLoop","detail":"{readStateIndex:8611; appliedIndex:8610; }","duration":"229.885467ms","start":"2026-04-13T21:25:49.544664Z","end":"2026-04-13T21:25:49.774549Z","steps":["trace[358717774] 'read index received' (duration: 229.676792ms)","trace[358717774] 'applied index is now lower than readState.Index' (duration: 207.455µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:25:49.952641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.859802ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T21:25:49.952761Z","caller":"traceutil/trace.go:171","msg":"trace[1801574912] linearizableReadLoop","detail":"{readStateIndex:8612; appliedIndex:8611; }","duration":"177.075057ms","start":"2026-04-13T21:25:49.775665Z","end":"2026-04-13T21:25:49.95274Z","steps":["trace[1801574912] 'read index received' (duration: 43.99955ms)","trace[1801574912] 'applied index is now lower than readState.Index' (duration: 133.074127ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:25:49.953049Z","caller":"traceutil/trace.go:171","msg":"trace[426394] transaction","detail":"{read_only:false; response_revision:8318; number_of_response:1; }","duration":"406.536514ms","start":"2026-04-13T21:25:49.546494Z","end":"2026-04-13T21:25:49.95303Z","steps":["trace[426394] 'process raft request' (duration: 273.193759ms)","trace[426394] 'compare' (duration: 132.733209ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T21:25:49.953138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T21:25:49.546472Z","time spent":"406.622296ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T21:25:49.953378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.707865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:25:49.953423Z","caller":"traceutil/trace.go:171","msg":"trace[302460606] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8318; }","duration":"177.788327ms","start":"2026-04-13T21:25:49.775623Z","end":"2026-04-13T21:25:49.953411Z","steps":["trace[302460606] 'agreement among raft nodes before linearized reading' (duration: 177.717915ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:25:59.113273Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6193} {"level":"info","ts":"2026-04-13T21:25:59.212009Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6193,"took":"96.81459ms","hash":1034337933,"current-db-size-bytes":59023360,"current-db-size":"59 MB","current-db-size-in-use-bytes":23240704,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-13T21:25:59.212088Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1034337933,"revision":6193,"compact-revision":3030} {"level":"info","ts":"2026-04-13T21:26:02.496258Z","caller":"traceutil/trace.go:171","msg":"trace[2131699768] transaction","detail":"{read_only:false; response_revision:8427; number_of_response:1; }","duration":"134.341683ms","start":"2026-04-13T21:26:02.361861Z","end":"2026-04-13T21:26:02.496203Z","steps":["trace[2131699768] 'process raft request' (duration: 134.064255ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:26:02.662171Z","caller":"traceutil/trace.go:171","msg":"trace[730876367] transaction","detail":"{read_only:false; response_revision:8428; number_of_response:1; }","duration":"299.65374ms","start":"2026-04-13T21:26:02.362472Z","end":"2026-04-13T21:26:02.662126Z","steps":["trace[730876367] 'process raft request' (duration: 299.369602ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:26:02.662396Z","caller":"traceutil/trace.go:171","msg":"trace[1768260791] transaction","detail":"{read_only:false; response_revision:8429; number_of_response:1; }","duration":"270.645039ms","start":"2026-04-13T21:26:02.391722Z","end":"2026-04-13T21:26:02.662367Z","steps":["trace[1768260791] 'process raft request' (duration: 270.278509ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:26:02.66321Z","caller":"traceutil/trace.go:171","msg":"trace[727063549] linearizableReadLoop","detail":"{readStateIndex:8729; appliedIndex:8727; }","duration":"275.495422ms","start":"2026-04-13T21:26:02.387689Z","end":"2026-04-13T21:26:02.663184Z","steps":["trace[727063549] 'read index received' (duration: 108.227831ms)","trace[727063549] 'applied index is now lower than readState.Index' (duration: 167.266801ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:26:02.663634Z","caller":"traceutil/trace.go:171","msg":"trace[1214372863] transaction","detail":"{read_only:false; response_revision:8430; number_of_response:1; }","duration":"271.150162ms","start":"2026-04-13T21:26:02.392465Z","end":"2026-04-13T21:26:02.663615Z","steps":["trace[1214372863] 'process raft request' (duration: 270.616308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:26:02.664196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.155117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-ncdrk\" ","response":"range_response_count:1 size:4644"} {"level":"info","ts":"2026-04-13T21:26:02.664256Z","caller":"traceutil/trace.go:171","msg":"trace[267796421] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-ncdrk; range_end:; response_count:1; response_revision:8430; }","duration":"273.2807ms","start":"2026-04-13T21:26:02.390961Z","end":"2026-04-13T21:26:02.664242Z","steps":["trace[267796421] 'agreement among raft nodes before linearized reading' (duration: 273.075535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:26:02.664399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.726115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-13T21:26:02.664423Z","caller":"traceutil/trace.go:171","msg":"trace[1847672337] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8430; }","duration":"276.800217ms","start":"2026-04-13T21:26:02.387617Z","end":"2026-04-13T21:26:02.664417Z","steps":["trace[1847672337] 'agreement among raft nodes before linearized reading' (duration: 276.727645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:26:02.664696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.001625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-13T21:26:02.664826Z","caller":"traceutil/trace.go:171","msg":"trace[1881281488] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8430; }","duration":"243.138909ms","start":"2026-04-13T21:26:02.421636Z","end":"2026-04-13T21:26:02.664775Z","steps":["trace[1881281488] 'agreement among raft nodes before linearized reading' (duration: 242.888802ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T21:26:02.664944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.806036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T21:26:02.664974Z","caller":"traceutil/trace.go:171","msg":"trace[1937869339] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8430; }","duration":"119.837017ms","start":"2026-04-13T21:26:02.54513Z","end":"2026-04-13T21:26:02.664967Z","steps":["trace[1937869339] 'agreement among raft nodes before linearized reading' (duration: 119.786226ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:26:03.175783Z","caller":"traceutil/trace.go:171","msg":"trace[638983059] transaction","detail":"{read_only:false; response_revision:8437; number_of_response:1; }","duration":"107.237765ms","start":"2026-04-13T21:26:03.068509Z","end":"2026-04-13T21:26:03.175747Z","steps":["trace[638983059] 'process raft request' (duration: 22.420482ms)","trace[638983059] 'compare' (duration: 84.674749ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T21:26:52.911811Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002418.wal"} {"level":"info","ts":"2026-04-13T21:27:19.045077Z","caller":"traceutil/trace.go:171","msg":"trace[1832989587] transaction","detail":"{read_only:false; response_revision:9176; number_of_response:1; }","duration":"187.541383ms","start":"2026-04-13T21:27:18.857516Z","end":"2026-04-13T21:27:19.045057Z","steps":["trace[1832989587] 'process raft request' (duration: 187.300627ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:28:28.82357Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a847c2e9c7010db6","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-13T21:28:28.831119Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-13T21:28:28.831215Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-13T21:29:35.891244Z","caller":"traceutil/trace.go:171","msg":"trace[217547313] transaction","detail":"{read_only:false; response_revision:10218; number_of_response:1; }","duration":"121.359506ms","start":"2026-04-13T21:29:35.769843Z","end":"2026-04-13T21:29:35.891203Z","steps":["trace[217547313] 'process raft request' (duration: 121.14252ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T21:30:59.120323Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8399} {"level":"info","ts":"2026-04-13T21:30:59.204781Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8399,"took":"82.134698ms","hash":2694481570,"current-db-size-bytes":59023360,"current-db-size":"59 MB","current-db-size-in-use-bytes":24846336,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-13T21:30:59.204875Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2694481570,"revision":8399,"compact-revision":6193} {"level":"info","ts":"2026-04-13T21:35:59.126036Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10716} {"level":"info","ts":"2026-04-13T21:35:59.201915Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10716,"took":"73.934056ms","hash":233820777,"current-db-size-bytes":59023360,"current-db-size":"59 MB","current-db-size-in-use-bytes":20262912,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-13T21:35:59.201985Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":233820777,"revision":10716,"compact-revision":8399}