{"level":"warn","ts":"2026-05-27T00:41:01.153523Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-27T00:41:01.153617Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-27T00:41:01.153685Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-27T00:41:01.153698Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-05-27T00:41:01.153715Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-27T00:41:01.154266Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-05-27T00:41:01.154336Z","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.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-27T00:41:01.15812Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.577943ms"} {"level":"info","ts":"2026-05-27T00:41:01.166031Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-05-27T00:41:01.166149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-05-27T00:41:01.166188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-05-27T00:41:01.166212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-27T00:41:01.16623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-05-27T00:41:01.166283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-05-27T00:41:01.172908Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-27T00:41:01.17475Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-27T00:41:01.176064Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-27T00:41:01.178195Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-27T00:41:01.17833Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-27T00:41:01.178612Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-27T00:41:01.178704Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-27T00:41:01.178732Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-27T00:41:01.181112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-05-27T00:41:01.182102Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-05-27T00:41:01.184313Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-27T00:41:01.184392Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-05-27T00:41:01.184424Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-05-27T00:41:01.184769Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-27T00:41:01.184904Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-27T00:41:01.567229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-05-27T00:41:01.56729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-27T00:41:01.567325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-05-27T00:41:01.567345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-05-27T00:41:01.567365Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-05-27T00:41:01.567387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-05-27T00:41:01.567408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-05-27T00:41:01.583849Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T00:41:01.585587Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T00:41:01.585585Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-05-27T00:41:01.585827Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T00:41:01.585965Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T00:41:01.585956Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T00:41:01.586009Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T00:41:01.586134Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-27T00:41:01.586164Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-27T00:41:01.589174Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-05-27T00:41:01.590247Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-27T00:41:17.501295Z","caller":"traceutil/trace.go:171","msg":"trace[856461773] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"127.109155ms","start":"2026-05-27T00:41:17.374168Z","end":"2026-05-27T00:41:17.501277Z","steps":["trace[856461773] 'process raft request' (duration: 126.995882ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:38.592132Z","caller":"traceutil/trace.go:171","msg":"trace[385329290] linearizableReadLoop","detail":"{readStateIndex:549; appliedIndex:548; }","duration":"104.456381ms","start":"2026-05-27T00:41:38.487646Z","end":"2026-05-27T00:41:38.592103Z","steps":["trace[385329290] 'read index received' (duration: 104.245595ms)","trace[385329290] 'applied index is now lower than readState.Index' (duration: 209.746µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:41:38.592236Z","caller":"traceutil/trace.go:171","msg":"trace[1324395436] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"400.102163ms","start":"2026-05-27T00:41:38.192086Z","end":"2026-05-27T00:41:38.592188Z","steps":["trace[1324395436] 'process raft request' (duration: 399.858005ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:38.5924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.641408ms","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-05-27T00:41:38.592503Z","caller":"traceutil/trace.go:171","msg":"trace[1843364264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:533; }","duration":"104.900445ms","start":"2026-05-27T00:41:38.487585Z","end":"2026-05-27T00:41:38.592485Z","steps":["trace[1843364264] 'agreement among raft nodes before linearized reading' (duration: 104.652948ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:38.593075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:38.192068Z","time spent":"400.221716ms","remote":"127.0.0.1:58224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T00:41:39.17972Z","caller":"traceutil/trace.go:171","msg":"trace[1931788377] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"152.556969ms","start":"2026-05-27T00:41:39.027113Z","end":"2026-05-27T00:41:39.17967Z","steps":["trace[1931788377] 'process raft request' (duration: 91.687427ms)","trace[1931788377] 'compare' (duration: 60.628765ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:41:39.179921Z","caller":"traceutil/trace.go:171","msg":"trace[1240276293] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"152.242751ms","start":"2026-05-27T00:41:39.027631Z","end":"2026-05-27T00:41:39.179873Z","steps":["trace[1240276293] 'process raft request' (duration: 151.953271ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:39.179965Z","caller":"traceutil/trace.go:171","msg":"trace[1748023245] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"150.33214ms","start":"2026-05-27T00:41:39.029607Z","end":"2026-05-27T00:41:39.17994Z","steps":["trace[1748023245] 'process raft request' (duration: 150.04143ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:39.180092Z","caller":"traceutil/trace.go:171","msg":"trace[648689338] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"145.084395ms","start":"2026-05-27T00:41:39.034945Z","end":"2026-05-27T00:41:39.18003Z","steps":["trace[648689338] 'process raft request' (duration: 144.995292ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:39.180102Z","caller":"traceutil/trace.go:171","msg":"trace[24405336] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"149.094701ms","start":"2026-05-27T00:41:39.030957Z","end":"2026-05-27T00:41:39.180052Z","steps":["trace[24405336] 'process raft request' (duration: 148.912066ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:39.185727Z","caller":"traceutil/trace.go:171","msg":"trace[1745659099] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"149.324609ms","start":"2026-05-27T00:41:39.036369Z","end":"2026-05-27T00:41:39.185694Z","steps":["trace[1745659099] 'process raft request' (duration: 147.207082ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:39.185961Z","caller":"traceutil/trace.go:171","msg":"trace[161509734] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"137.382291ms","start":"2026-05-27T00:41:39.048566Z","end":"2026-05-27T00:41:39.185948Z","steps":["trace[161509734] 'process raft request' (duration: 137.04882ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:39.186208Z","caller":"traceutil/trace.go:171","msg":"trace[605965639] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"101.27489ms","start":"2026-05-27T00:41:39.084907Z","end":"2026-05-27T00:41:39.186182Z","steps":["trace[605965639] 'process raft request' (duration: 101.135596ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:39.186279Z","caller":"traceutil/trace.go:171","msg":"trace[1583953960] transaction","detail":"{read_only:false; number_of_response:1; response_revision:549; }","duration":"137.618849ms","start":"2026-05-27T00:41:39.048645Z","end":"2026-05-27T00:41:39.186264Z","steps":["trace[1583953960] 'process raft request' (duration: 137.097492ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:39.186498Z","caller":"traceutil/trace.go:171","msg":"trace[626868915] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"131.512186ms","start":"2026-05-27T00:41:39.054949Z","end":"2026-05-27T00:41:39.186461Z","steps":["trace[626868915] 'process raft request' (duration: 130.865726ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:39.186806Z","caller":"traceutil/trace.go:171","msg":"trace[1695115941] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"110.772631ms","start":"2026-05-27T00:41:39.076025Z","end":"2026-05-27T00:41:39.186798Z","steps":["trace[1695115941] 'process raft request' (duration: 109.904064ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:39.186494Z","caller":"traceutil/trace.go:171","msg":"trace[108190713] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"137.881006ms","start":"2026-05-27T00:41:39.048592Z","end":"2026-05-27T00:41:39.186473Z","steps":["trace[108190713] 'process raft request' (duration: 137.084551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:39.630611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.176089ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:41:39.630885Z","caller":"traceutil/trace.go:171","msg":"trace[1140898022] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"205.804453ms","start":"2026-05-27T00:41:39.425038Z","end":"2026-05-27T00:41:39.630842Z","steps":["trace[1140898022] 'process raft request' (duration: 90.1844ms)","trace[1140898022] 'compare' (duration: 114.978642ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:41:39.630914Z","caller":"traceutil/trace.go:171","msg":"trace[749624301] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"184.937313ms","start":"2026-05-27T00:41:39.445957Z","end":"2026-05-27T00:41:39.630894Z","steps":["trace[749624301] 'process raft request' (duration: 184.784567ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:39.631149Z","caller":"traceutil/trace.go:171","msg":"trace[1449182124] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"154.237923ms","start":"2026-05-27T00:41:39.476889Z","end":"2026-05-27T00:41:39.631127Z","steps":["trace[1449182124] 'process raft request' (duration: 153.954644ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:41:45.766513Z","caller":"traceutil/trace.go:171","msg":"trace[838279011] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"108.637547ms","start":"2026-05-27T00:41:45.657811Z","end":"2026-05-27T00:41:45.766449Z","steps":["trace[838279011] 'process raft request' (duration: 108.504613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:46.358502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.990368ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:41:46.358779Z","caller":"traceutil/trace.go:171","msg":"trace[1998900255] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"459.268514ms","start":"2026-05-27T00:41:45.899466Z","end":"2026-05-27T00:41:46.358734Z","steps":["trace[1998900255] 'process raft request' (duration: 266.931407ms)","trace[1998900255] 'compare' (duration: 191.850503ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:41:46.358775Z","caller":"traceutil/trace.go:171","msg":"trace[1684096602] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"404.565383ms","start":"2026-05-27T00:41:45.954158Z","end":"2026-05-27T00:41:46.358723Z","steps":["trace[1684096602] 'process raft request' (duration: 404.507891ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:41:46.358924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:45.89943Z","time spent":"459.418289ms","remote":"127.0.0.1:58224","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-05-27T00:41:46.358926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:41:45.954114Z","time spent":"404.77912ms","remote":"127.0.0.1:58208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-27T00:42:27.303479Z","caller":"traceutil/trace.go:171","msg":"trace[1698107555] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"264.794953ms","start":"2026-05-27T00:42:27.038652Z","end":"2026-05-27T00:42:27.303447Z","steps":["trace[1698107555] 'process raft request' (duration: 264.594697ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:43:14.66723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.209269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T00:43:14.667354Z","caller":"traceutil/trace.go:171","msg":"trace[1459124138] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1874; }","duration":"244.421145ms","start":"2026-05-27T00:43:14.422904Z","end":"2026-05-27T00:43:14.667325Z","steps":["trace[1459124138] 'count revisions from in-memory index tree' (duration: 244.031534ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:43:14.667485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.369209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-28e1fc0d-3eda-4743-b2a8-b6177c38de2b\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-27T00:43:14.667536Z","caller":"traceutil/trace.go:171","msg":"trace[255101608] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-28e1fc0d-3eda-4743-b2a8-b6177c38de2b; range_end:; response_count:1; response_revision:1874; }","duration":"234.474741ms","start":"2026-05-27T00:43:14.433049Z","end":"2026-05-27T00:43:14.667524Z","steps":["trace[255101608] 'range keys from in-memory index tree' (duration: 234.132351ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:43:14.667533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.346001ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:43:14.66763Z","caller":"traceutil/trace.go:171","msg":"trace[1234490054] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1874; }","duration":"320.433614ms","start":"2026-05-27T00:43:14.347167Z","end":"2026-05-27T00:43:14.6676Z","steps":["trace[1234490054] 'range keys from in-memory index tree' (duration: 320.328641ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:43:15.084331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.910249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:43:15.084436Z","caller":"traceutil/trace.go:171","msg":"trace[351388182] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1876; }","duration":"143.023892ms","start":"2026-05-27T00:43:14.941378Z","end":"2026-05-27T00:43:15.084402Z","steps":["trace[351388182] 'count revisions from in-memory index tree' (duration: 142.805886ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:43:27.053581Z","caller":"traceutil/trace.go:171","msg":"trace[2146419634] transaction","detail":"{read_only:false; response_revision:1976; number_of_response:1; }","duration":"147.306965ms","start":"2026-05-27T00:43:26.90625Z","end":"2026-05-27T00:43:27.053557Z","steps":["trace[2146419634] 'process raft request' (duration: 147.15621ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:43:57.815709Z","caller":"traceutil/trace.go:171","msg":"trace[1144600677] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"118.501168ms","start":"2026-05-27T00:43:57.697181Z","end":"2026-05-27T00:43:57.815682Z","steps":["trace[1144600677] 'process raft request' (duration: 89.187275ms)","trace[1144600677] 'compare' (duration: 29.104927ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:43:57.815903Z","caller":"traceutil/trace.go:171","msg":"trace[141611648] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"108.762121ms","start":"2026-05-27T00:43:57.707131Z","end":"2026-05-27T00:43:57.815893Z","steps":["trace[141611648] 'process raft request' (duration: 108.502233ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:44:04.209765Z","caller":"traceutil/trace.go:171","msg":"trace[1783865514] linearizableReadLoop","detail":"{readStateIndex:2271; appliedIndex:2270; }","duration":"130.53805ms","start":"2026-05-27T00:44:04.079196Z","end":"2026-05-27T00:44:04.209735Z","steps":["trace[1783865514] 'read index received' (duration: 130.341274ms)","trace[1783865514] 'applied index is now lower than readState.Index' (duration: 195.486µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:44:04.209899Z","caller":"traceutil/trace.go:171","msg":"trace[1189167302] transaction","detail":"{read_only:false; response_revision:2192; number_of_response:1; }","duration":"151.671713ms","start":"2026-05-27T00:44:04.058182Z","end":"2026-05-27T00:44:04.209854Z","steps":["trace[1189167302] 'process raft request' (duration: 151.346113ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:44:04.209982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.769486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-27T00:44:04.210021Z","caller":"traceutil/trace.go:171","msg":"trace[740832259] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2192; }","duration":"130.87031ms","start":"2026-05-27T00:44:04.079138Z","end":"2026-05-27T00:44:04.210009Z","steps":["trace[740832259] 'agreement among raft nodes before linearized reading' (duration: 130.705035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:44:04.563095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.685675ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:44:04.563259Z","caller":"traceutil/trace.go:171","msg":"trace[1458328496] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2192; }","duration":"216.875321ms","start":"2026-05-27T00:44:04.346356Z","end":"2026-05-27T00:44:04.563232Z","steps":["trace[1458328496] 'range keys from in-memory index tree' (duration: 216.668435ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:44:04.563544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.143681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-27T00:44:04.563626Z","caller":"traceutil/trace.go:171","msg":"trace[1862826642] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2192; }","duration":"108.269075ms","start":"2026-05-27T00:44:04.45534Z","end":"2026-05-27T00:44:04.563609Z","steps":["trace[1862826642] 'range keys from in-memory index tree' (duration: 107.986737ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:44:04.703905Z","caller":"traceutil/trace.go:171","msg":"trace[1750158288] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"136.719333ms","start":"2026-05-27T00:44:04.56716Z","end":"2026-05-27T00:44:04.703879Z","steps":["trace[1750158288] 'process raft request' (duration: 136.552067ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:44:04.776547Z","caller":"traceutil/trace.go:171","msg":"trace[1297113161] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"208.088162ms","start":"2026-05-27T00:44:04.568426Z","end":"2026-05-27T00:44:04.776514Z","steps":["trace[1297113161] 'process raft request' (duration: 198.409378ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:45:04.183307Z","caller":"traceutil/trace.go:171","msg":"trace[1265230024] transaction","detail":"{read_only:false; response_revision:2699; number_of_response:1; }","duration":"123.362789ms","start":"2026-05-27T00:45:04.059902Z","end":"2026-05-27T00:45:04.183265Z","steps":["trace[1265230024] 'process raft request' (duration: 67.108487ms)","trace[1265230024] 'compare' (duration: 56.033736ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:45:04.183347Z","caller":"traceutil/trace.go:171","msg":"trace[2135968680] linearizableReadLoop","detail":"{readStateIndex:2798; appliedIndex:2796; }","duration":"101.114574ms","start":"2026-05-27T00:45:04.082206Z","end":"2026-05-27T00:45:04.18332Z","steps":["trace[2135968680] 'read index received' (duration: 29.468724ms)","trace[2135968680] 'applied index is now lower than readState.Index' (duration: 71.642939ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:45:04.184166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.941647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-27T00:45:04.184283Z","caller":"traceutil/trace.go:171","msg":"trace[241305717] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2700; }","duration":"102.138443ms","start":"2026-05-27T00:45:04.082123Z","end":"2026-05-27T00:45:04.184261Z","steps":["trace[241305717] 'agreement among raft nodes before linearized reading' (duration: 101.33362ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:45:29.319464Z","caller":"traceutil/trace.go:171","msg":"trace[588930540] linearizableReadLoop","detail":"{readStateIndex:2951; appliedIndex:2950; }","duration":"126.891121ms","start":"2026-05-27T00:45:29.192548Z","end":"2026-05-27T00:45:29.319439Z","steps":["trace[588930540] 'read index received' (duration: 99.673092ms)","trace[588930540] 'applied index is now lower than readState.Index' (duration: 27.216949ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:45:29.31961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.039665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T00:45:29.319576Z","caller":"traceutil/trace.go:171","msg":"trace[871176029] transaction","detail":"{read_only:false; response_revision:2846; number_of_response:1; }","duration":"130.143296ms","start":"2026-05-27T00:45:29.189392Z","end":"2026-05-27T00:45:29.319535Z","steps":["trace[871176029] 'process raft request' (duration: 102.825414ms)","trace[871176029] 'compare' (duration: 27.110826ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:45:29.319646Z","caller":"traceutil/trace.go:171","msg":"trace[625970509] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:2846; }","duration":"127.121738ms","start":"2026-05-27T00:45:29.192514Z","end":"2026-05-27T00:45:29.319636Z","steps":["trace[625970509] 'agreement among raft nodes before linearized reading' (duration: 127.040055ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:45:29.813272Z","caller":"traceutil/trace.go:171","msg":"trace[554558248] transaction","detail":"{read_only:false; response_revision:2847; number_of_response:1; }","duration":"115.630515ms","start":"2026-05-27T00:45:29.69761Z","end":"2026-05-27T00:45:29.81324Z","steps":["trace[554558248] 'process raft request' (duration: 115.44409ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:48:05.438658Z","caller":"traceutil/trace.go:171","msg":"trace[939947568] transaction","detail":"{read_only:false; response_revision:3869; number_of_response:1; }","duration":"166.815437ms","start":"2026-05-27T00:48:05.271792Z","end":"2026-05-27T00:48:05.438607Z","steps":["trace[939947568] 'process raft request' (duration: 166.59483ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:49:23.359682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.854839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-27T00:49:23.360067Z","caller":"traceutil/trace.go:171","msg":"trace[1654814093] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:4879; }","duration":"131.304123ms","start":"2026-05-27T00:49:23.228735Z","end":"2026-05-27T00:49:23.360039Z","steps":["trace[1654814093] 'count revisions from in-memory index tree' (duration: 130.759267ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:49:28.204264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.296663ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T00:49:28.204439Z","caller":"traceutil/trace.go:171","msg":"trace[798188945] transaction","detail":"{read_only:false; response_revision:5051; number_of_response:1; }","duration":"155.34982ms","start":"2026-05-27T00:49:28.049072Z","end":"2026-05-27T00:49:28.204422Z","steps":["trace[798188945] 'process raft request' (duration: 155.276728ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:49:28.204563Z","caller":"traceutil/trace.go:171","msg":"trace[324392512] linearizableReadLoop","detail":"{readStateIndex:5239; appliedIndex:5238; }","duration":"267.651581ms","start":"2026-05-27T00:49:27.936885Z","end":"2026-05-27T00:49:28.204536Z","steps":["trace[324392512] 'read index received' (duration: 73.978858ms)","trace[324392512] 'applied index is now lower than readState.Index' (duration: 193.670333ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:49:28.204654Z","caller":"traceutil/trace.go:171","msg":"trace[1264627610] transaction","detail":"{read_only:false; response_revision:5050; number_of_response:1; }","duration":"310.9936ms","start":"2026-05-27T00:49:27.89365Z","end":"2026-05-27T00:49:28.204643Z","steps":["trace[1264627610] 'process raft request' (duration: 117.263865ms)","trace[1264627610] 'compare' (duration: 193.18397ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:49:28.204713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:49:27.893625Z","time spent":"311.062051ms","remote":"127.0.0.1:58306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1001,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T00:49:28.204824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.935539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7da2ec1b-4b78-4eb6-be8d-11980a0487af\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-05-27T00:49:28.204868Z","caller":"traceutil/trace.go:171","msg":"trace[2098907877] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7da2ec1b-4b78-4eb6-be8d-11980a0487af; range_end:; response_count:1; response_revision:5051; }","duration":"267.99296ms","start":"2026-05-27T00:49:27.936864Z","end":"2026-05-27T00:49:28.204857Z","steps":["trace[2098907877] 'agreement among raft nodes before linearized reading' (duration: 267.810185ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:49:28.205093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.374284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-twp79-tls\" ","response":"range_response_count:1 size:1967"} {"level":"info","ts":"2026-05-27T00:49:28.205151Z","caller":"traceutil/trace.go:171","msg":"trace[730343981] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-twp79-tls; range_end:; response_count:1; response_revision:5051; }","duration":"184.478016ms","start":"2026-05-27T00:49:28.020664Z","end":"2026-05-27T00:49:28.205142Z","steps":["trace[730343981] 'agreement among raft nodes before linearized reading' (duration: 184.281461ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:49:28.205227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.72587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7da2ec1b-4b78-4eb6-be8d-11980a0487af\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-05-27T00:49:28.205311Z","caller":"traceutil/trace.go:171","msg":"trace[515163740] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7da2ec1b-4b78-4eb6-be8d-11980a0487af; range_end:; response_count:1; response_revision:5051; }","duration":"115.859654ms","start":"2026-05-27T00:49:28.08943Z","end":"2026-05-27T00:49:28.20529Z","steps":["trace[515163740] 'agreement among raft nodes before linearized reading' (duration: 115.535054ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:49:28.57024Z","caller":"traceutil/trace.go:171","msg":"trace[970135890] transaction","detail":"{read_only:false; response_revision:5065; number_of_response:1; }","duration":"178.842913ms","start":"2026-05-27T00:49:28.391377Z","end":"2026-05-27T00:49:28.57022Z","steps":["trace[970135890] 'process raft request' (duration: 79.448986ms)","trace[970135890] 'compare' (duration: 99.280754ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T00:49:28.57023Z","caller":"traceutil/trace.go:171","msg":"trace[1102434149] linearizableReadLoop","detail":"{readStateIndex:5254; appliedIndex:5253; }","duration":"151.678656ms","start":"2026-05-27T00:49:28.418529Z","end":"2026-05-27T00:49:28.570208Z","steps":["trace[1102434149] 'read index received' (duration: 52.376202ms)","trace[1102434149] 'applied index is now lower than readState.Index' (duration: 99.301293ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T00:49:28.570319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.764868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T00:49:28.570347Z","caller":"traceutil/trace.go:171","msg":"trace[1029985283] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:5065; }","duration":"151.84377ms","start":"2026-05-27T00:49:28.418497Z","end":"2026-05-27T00:49:28.570341Z","steps":["trace[1029985283] 'agreement among raft nodes before linearized reading' (duration: 151.769858ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:49:50.0349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.786049ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-27T00:51:01.836398Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3023} {"level":"info","ts":"2026-05-27T00:51:01.92885Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3023,"took":"90.571756ms","hash":1469688958,"current-db-size-bytes":58789888,"current-db-size":"59 MB","current-db-size-in-use-bytes":31744000,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-27T00:51:01.928917Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1469688958,"revision":3023,"compact-revision":-1} {"level":"info","ts":"2026-05-27T00:56:01.842059Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6118} {"level":"info","ts":"2026-05-27T00:56:01.965406Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6118,"took":"121.306065ms","hash":1200720638,"current-db-size-bytes":58789888,"current-db-size":"59 MB","current-db-size-in-use-bytes":23998464,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-05-27T00:56:01.965481Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1200720638,"revision":6118,"compact-revision":3023} {"level":"info","ts":"2026-05-27T00:56:44.869699Z","caller":"traceutil/trace.go:171","msg":"trace[33822524] transaction","detail":"{read_only:false; response_revision:8619; number_of_response:1; }","duration":"301.598079ms","start":"2026-05-27T00:56:44.568076Z","end":"2026-05-27T00:56:44.869674Z","steps":["trace[33822524] 'process raft request' (duration: 301.453394ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T00:56:44.869848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T00:56:44.568055Z","time spent":"301.720293ms","remote":"127.0.0.1:58224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-27T00:56:44.871504Z","caller":"traceutil/trace.go:171","msg":"trace[549594143] transaction","detail":"{read_only:false; response_revision:8620; number_of_response:1; }","duration":"199.869547ms","start":"2026-05-27T00:56:44.671606Z","end":"2026-05-27T00:56:44.871476Z","steps":["trace[549594143] 'process raft request' (duration: 199.707643ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:56:49.213459Z","caller":"traceutil/trace.go:171","msg":"trace[24719930] transaction","detail":"{read_only:false; response_revision:8643; number_of_response:1; }","duration":"252.575284ms","start":"2026-05-27T00:56:48.960835Z","end":"2026-05-27T00:56:49.21341Z","steps":["trace[24719930] 'process raft request' (duration: 252.027299ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:56:59.505378Z","caller":"traceutil/trace.go:171","msg":"trace[1510381357] transaction","detail":"{read_only:false; response_revision:8746; number_of_response:1; }","duration":"132.240689ms","start":"2026-05-27T00:56:59.373111Z","end":"2026-05-27T00:56:59.505352Z","steps":["trace[1510381357] 'process raft request' (duration: 132.066104ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T00:57:05.3866Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002396.wal"} {"level":"info","ts":"2026-05-27T00:58:38.229311Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-27T00:58:38.237459Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-27T00:58:38.237567Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-27T01:01:01.849363Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8340} {"level":"info","ts":"2026-05-27T01:01:01.931325Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8340,"took":"79.55541ms","hash":3943227795,"current-db-size-bytes":58789888,"current-db-size":"59 MB","current-db-size-in-use-bytes":25509888,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-27T01:01:01.931394Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3943227795,"revision":8340,"compact-revision":6118} {"level":"info","ts":"2026-05-27T01:03:49.787023Z","caller":"traceutil/trace.go:171","msg":"trace[1438088746] transaction","detail":"{read_only:false; response_revision:11897; number_of_response:1; }","duration":"105.291438ms","start":"2026-05-27T01:03:49.68169Z","end":"2026-05-27T01:03:49.786981Z","steps":["trace[1438088746] 'process raft request' (duration: 104.935108ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T01:03:50.17273Z","caller":"traceutil/trace.go:171","msg":"trace[1766695734] linearizableReadLoop","detail":"{readStateIndex:12304; appliedIndex:12303; }","duration":"217.095763ms","start":"2026-05-27T01:03:49.95561Z","end":"2026-05-27T01:03:50.172706Z","steps":["trace[1766695734] 'read index received' (duration: 182.098653ms)","trace[1766695734] 'applied index is now lower than readState.Index' (duration: 34.99517ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T01:03:50.172897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.268628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T01:03:50.172926Z","caller":"traceutil/trace.go:171","msg":"trace[297770453] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:11899; }","duration":"217.353201ms","start":"2026-05-27T01:03:49.955566Z","end":"2026-05-27T01:03:50.172919Z","steps":["trace[297770453] 'agreement among raft nodes before linearized reading' (duration: 217.272488ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T01:03:50.172948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.660541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T01:03:50.17301Z","caller":"traceutil/trace.go:171","msg":"trace[1128070929] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:11899; }","duration":"216.733612ms","start":"2026-05-27T01:03:49.956247Z","end":"2026-05-27T01:03:50.172981Z","steps":["trace[1128070929] 'agreement among raft nodes before linearized reading' (duration: 216.663951ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T01:03:50.173108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.603609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T01:03:50.173152Z","caller":"traceutil/trace.go:171","msg":"trace[99814685] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:11899; }","duration":"216.670891ms","start":"2026-05-27T01:03:49.956471Z","end":"2026-05-27T01:03:50.173142Z","steps":["trace[99814685] 'agreement among raft nodes before linearized reading' (duration: 216.612039ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T01:03:50.17314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.580159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"} {"level":"info","ts":"2026-05-27T01:03:50.173216Z","caller":"traceutil/trace.go:171","msg":"trace[1720886828] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:11899; }","duration":"216.705622ms","start":"2026-05-27T01:03:49.956494Z","end":"2026-05-27T01:03:50.1732Z","steps":["trace[1720886828] 'agreement among raft nodes before linearized reading' (duration: 216.442874ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T01:03:50.17327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.941938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T01:03:50.173318Z","caller":"traceutil/trace.go:171","msg":"trace[1372175896] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:11899; }","duration":"217.013511ms","start":"2026-05-27T01:03:49.956292Z","end":"2026-05-27T01:03:50.173305Z","steps":["trace[1372175896] 'agreement among raft nodes before linearized reading' (duration: 216.934068ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T01:03:50.173279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.037334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-05-27T01:03:50.173389Z","caller":"traceutil/trace.go:171","msg":"trace[1037707751] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:11899; }","duration":"216.165327ms","start":"2026-05-27T01:03:49.957201Z","end":"2026-05-27T01:03:50.173366Z","steps":["trace[1037707751] 'agreement among raft nodes before linearized reading' (duration: 215.805497ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T01:03:51.323754Z","caller":"traceutil/trace.go:171","msg":"trace[1156181365] linearizableReadLoop","detail":"{readStateIndex:12313; appliedIndex:12312; }","duration":"152.489037ms","start":"2026-05-27T01:03:51.171228Z","end":"2026-05-27T01:03:51.323717Z","steps":["trace[1156181365] 'read index received' (duration: 152.229359ms)","trace[1156181365] 'applied index is now lower than readState.Index' (duration: 258.488µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T01:03:51.32391Z","caller":"traceutil/trace.go:171","msg":"trace[135512437] transaction","detail":"{read_only:false; response_revision:11908; number_of_response:1; }","duration":"173.963571ms","start":"2026-05-27T01:03:51.149909Z","end":"2026-05-27T01:03:51.323873Z","steps":["trace[135512437] 'process raft request' (duration: 173.57867ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T01:03:51.32412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.867038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-05-27T01:03:51.324217Z","caller":"traceutil/trace.go:171","msg":"trace[415080797] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:11908; }","duration":"153.038252ms","start":"2026-05-27T01:03:51.171157Z","end":"2026-05-27T01:03:51.324195Z","steps":["trace[415080797] 'agreement among raft nodes before linearized reading' (duration: 152.693732ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T01:06:01.85631Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10560} {"level":"info","ts":"2026-05-27T01:06:01.938173Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10560,"took":"78.335126ms","hash":869333582,"current-db-size-bytes":58789888,"current-db-size":"59 MB","current-db-size-in-use-bytes":26501120,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-27T01:06:01.938255Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":869333582,"revision":10560,"compact-revision":8340} {"level":"info","ts":"2026-05-27T01:09:52.238075Z","caller":"traceutil/trace.go:171","msg":"trace[49315393] transaction","detail":"{read_only:false; response_revision:14390; number_of_response:1; }","duration":"101.058524ms","start":"2026-05-27T01:09:52.136971Z","end":"2026-05-27T01:09:52.23803Z","steps":["trace[49315393] 'process raft request' (duration: 45.150844ms)","trace[49315393] 'compare' (duration: 55.733815ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T01:10:26.327599Z","caller":"traceutil/trace.go:171","msg":"trace[1232671990] transaction","detail":"{read_only:false; response_revision:14572; number_of_response:1; }","duration":"114.016483ms","start":"2026-05-27T01:10:26.213552Z","end":"2026-05-27T01:10:26.327568Z","steps":["trace[1232671990] 'process raft request' (duration: 113.827207ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T01:10:30.133267Z","caller":"traceutil/trace.go:171","msg":"trace[1911927146] linearizableReadLoop","detail":"{readStateIndex:15105; appliedIndex:15104; }","duration":"108.430383ms","start":"2026-05-27T01:10:30.024808Z","end":"2026-05-27T01:10:30.133239Z","steps":["trace[1911927146] 'read index received' (duration: 108.066902ms)","trace[1911927146] 'applied index is now lower than readState.Index' (duration: 362.621µs)"],"step_count":2} {"level":"warn","ts":"2026-05-27T01:10:30.134168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.331749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:64 size:601911"} {"level":"info","ts":"2026-05-27T01:10:30.134216Z","caller":"traceutil/trace.go:171","msg":"trace[694811992] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:64; response_revision:14605; }","duration":"109.420072ms","start":"2026-05-27T01:10:30.024784Z","end":"2026-05-27T01:10:30.134204Z","steps":["trace[694811992] 'agreement among raft nodes before linearized reading' (duration: 108.593328ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T01:10:30.134738Z","caller":"traceutil/trace.go:171","msg":"trace[1920465625] transaction","detail":"{read_only:false; response_revision:14605; number_of_response:1; }","duration":"110.826542ms","start":"2026-05-27T01:10:30.023879Z","end":"2026-05-27T01:10:30.134706Z","steps":["trace[1920465625] 'process raft request' (duration: 109.105483ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T01:10:30.158717Z","caller":"traceutil/trace.go:171","msg":"trace[971338599] transaction","detail":"{read_only:false; response_revision:14607; number_of_response:1; }","duration":"128.596776ms","start":"2026-05-27T01:10:30.030096Z","end":"2026-05-27T01:10:30.158693Z","steps":["trace[971338599] 'process raft request' (duration: 128.530224ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T01:10:30.159201Z","caller":"traceutil/trace.go:171","msg":"trace[1190659305] transaction","detail":"{read_only:false; response_revision:14606; number_of_response:1; }","duration":"133.521318ms","start":"2026-05-27T01:10:30.025645Z","end":"2026-05-27T01:10:30.159166Z","steps":["trace[1190659305] 'process raft request' (duration: 132.749215ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T01:10:40.985214Z","caller":"traceutil/trace.go:171","msg":"trace[1552156118] linearizableReadLoop","detail":"{readStateIndex:15286; appliedIndex:15285; }","duration":"295.490473ms","start":"2026-05-27T01:10:40.689698Z","end":"2026-05-27T01:10:40.985188Z","steps":["trace[1552156118] 'read index received' (duration: 295.263316ms)","trace[1552156118] 'applied index is now lower than readState.Index' (duration: 226.197µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T01:10:40.985253Z","caller":"traceutil/trace.go:171","msg":"trace[1008720534] transaction","detail":"{read_only:false; response_revision:14783; number_of_response:1; }","duration":"392.408198ms","start":"2026-05-27T01:10:40.592807Z","end":"2026-05-27T01:10:40.985215Z","steps":["trace[1008720534] 'process raft request' (duration: 392.211593ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T01:10:40.985408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T01:10:40.59279Z","time spent":"392.544503ms","remote":"127.0.0.1:58066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":854,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T01:10:40.985421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.818389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-27T01:10:40.985418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.700508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T01:10:40.985459Z","caller":"traceutil/trace.go:171","msg":"trace[1566932168] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:14783; }","duration":"105.883821ms","start":"2026-05-27T01:10:40.879564Z","end":"2026-05-27T01:10:40.985448Z","steps":["trace[1566932168] 'agreement among raft nodes before linearized reading' (duration: 105.789648ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T01:10:40.985498Z","caller":"traceutil/trace.go:171","msg":"trace[781808049] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14783; }","duration":"295.830872ms","start":"2026-05-27T01:10:40.689646Z","end":"2026-05-27T01:10:40.985477Z","steps":["trace[781808049] 'agreement among raft nodes before linearized reading' (duration: 295.658477ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T01:11:01.862961Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12818} {"level":"info","ts":"2026-05-27T01:11:01.941552Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12818,"took":"74.615231ms","hash":3102880209,"current-db-size-bytes":58789888,"current-db-size":"59 MB","current-db-size-in-use-bytes":29274112,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-27T01:11:01.94168Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3102880209,"revision":12818,"compact-revision":10560} {"level":"warn","ts":"2026-05-27T01:12:22.800282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.773696ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-27T01:12:22.800439Z","caller":"traceutil/trace.go:171","msg":"trace[267367774] linearizableReadLoop","detail":"{readStateIndex:16418; appliedIndex:16417; }","duration":"239.803016ms","start":"2026-05-27T01:12:22.56061Z","end":"2026-05-27T01:12:22.800413Z","steps":["trace[267367774] 'read index received' (duration: 88.749933ms)","trace[267367774] 'applied index is now lower than readState.Index' (duration: 151.051493ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T01:12:22.800466Z","caller":"traceutil/trace.go:171","msg":"trace[1725223269] transaction","detail":"{read_only:false; response_revision:15881; number_of_response:1; }","duration":"287.185864ms","start":"2026-05-27T01:12:22.513253Z","end":"2026-05-27T01:12:22.800438Z","steps":["trace[1725223269] 'process raft request' (duration: 136.12384ms)","trace[1725223269] 'compare' (duration: 150.499947ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T01:12:22.800741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.089255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T01:12:22.800872Z","caller":"traceutil/trace.go:171","msg":"trace[1459765810] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:15881; }","duration":"240.28143ms","start":"2026-05-27T01:12:22.560553Z","end":"2026-05-27T01:12:22.800834Z","steps":["trace[1459765810] 'agreement among raft nodes before linearized reading' (duration: 240.043943ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T01:12:22.802896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.050139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-05-27T01:12:22.802994Z","caller":"traceutil/trace.go:171","msg":"trace[437615116] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15882; }","duration":"237.179622ms","start":"2026-05-27T01:12:22.565794Z","end":"2026-05-27T01:12:22.802973Z","steps":["trace[437615116] 'agreement among raft nodes before linearized reading' (duration: 236.915804ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T01:12:22.803641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.363143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T01:12:22.803684Z","caller":"traceutil/trace.go:171","msg":"trace[506717954] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15882; }","duration":"113.454386ms","start":"2026-05-27T01:12:22.69022Z","end":"2026-05-27T01:12:22.803674Z","steps":["trace[506717954] 'agreement among raft nodes before linearized reading' (duration: 113.396254ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T01:12:22.803885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.763862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-05-27T01:12:22.803934Z","caller":"traceutil/trace.go:171","msg":"trace[940246171] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15882; }","duration":"171.854165ms","start":"2026-05-27T01:12:22.632068Z","end":"2026-05-27T01:12:22.803922Z","steps":["trace[940246171] 'agreement among raft nodes before linearized reading' (duration: 171.741212ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T01:12:22.804061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.07736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-05-27T01:12:22.804126Z","caller":"traceutil/trace.go:171","msg":"trace[930897623] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15882; }","duration":"179.183003ms","start":"2026-05-27T01:12:22.624928Z","end":"2026-05-27T01:12:22.804111Z","steps":["trace[930897623] 'agreement among raft nodes before linearized reading' (duration: 179.003598ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T01:12:22.804299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.32259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T01:12:22.804338Z","caller":"traceutil/trace.go:171","msg":"trace[398251072] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:15882; }","duration":"177.372811ms","start":"2026-05-27T01:12:22.626955Z","end":"2026-05-27T01:12:22.804328Z","steps":["trace[398251072] 'agreement among raft nodes before linearized reading' (duration: 177.31675ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T01:12:22.804505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.893235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:682"} {"level":"info","ts":"2026-05-27T01:12:22.804545Z","caller":"traceutil/trace.go:171","msg":"trace[1787700902] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:15882; }","duration":"178.943207ms","start":"2026-05-27T01:12:22.62559Z","end":"2026-05-27T01:12:22.804533Z","steps":["trace[1787700902] 'agreement among raft nodes before linearized reading' (duration: 178.852084ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T01:12:22.80469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.715198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T01:12:22.804723Z","caller":"traceutil/trace.go:171","msg":"trace[652978626] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15882; }","duration":"179.748869ms","start":"2026-05-27T01:12:22.624966Z","end":"2026-05-27T01:12:22.804715Z","steps":["trace[652978626] 'agreement among raft nodes before linearized reading' (duration: 179.697418ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T01:12:22.930551Z","caller":"traceutil/trace.go:171","msg":"trace[924972559] transaction","detail":"{read_only:false; response_revision:15883; number_of_response:1; }","duration":"120.943778ms","start":"2026-05-27T01:12:22.809575Z","end":"2026-05-27T01:12:22.930519Z","steps":["trace[924972559] 'process raft request' (duration: 106.546999ms)","trace[924972559] 'compare' (duration: 14.178483ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T01:12:22.930823Z","caller":"traceutil/trace.go:171","msg":"trace[660067588] transaction","detail":"{read_only:false; response_revision:15884; number_of_response:1; }","duration":"121.126023ms","start":"2026-05-27T01:12:22.809671Z","end":"2026-05-27T01:12:22.930797Z","steps":["trace[660067588] 'process raft request' (duration: 120.801884ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T01:16:01.873746Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15119} {"level":"info","ts":"2026-05-27T01:16:01.966002Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15119,"took":"89.342163ms","hash":2240602259,"current-db-size-bytes":58789888,"current-db-size":"59 MB","current-db-size-in-use-bytes":30806016,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-27T01:16:01.966081Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2240602259,"revision":15119,"compact-revision":12818} {"level":"info","ts":"2026-05-27T01:17:55.998722Z","caller":"traceutil/trace.go:171","msg":"trace[522193004] transaction","detail":"{read_only:false; response_revision:18347; number_of_response:1; }","duration":"141.399523ms","start":"2026-05-27T01:17:55.857297Z","end":"2026-05-27T01:17:55.998697Z","steps":["trace[522193004] 'process raft request' (duration: 141.247979ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T01:18:02.847947Z","caller":"traceutil/trace.go:171","msg":"trace[1434296396] linearizableReadLoop","detail":"{readStateIndex:19013; appliedIndex:19012; }","duration":"186.861357ms","start":"2026-05-27T01:18:02.661058Z","end":"2026-05-27T01:18:02.84792Z","steps":["trace[1434296396] 'read index received' (duration: 186.641061ms)","trace[1434296396] 'applied index is now lower than readState.Index' (duration: 219.396µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T01:18:02.848085Z","caller":"traceutil/trace.go:171","msg":"trace[2096214249] transaction","detail":"{read_only:false; response_revision:18392; number_of_response:1; }","duration":"312.124752ms","start":"2026-05-27T01:18:02.535949Z","end":"2026-05-27T01:18:02.848074Z","steps":["trace[2096214249] 'process raft request' (duration: 311.808743ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T01:18:02.8482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T01:18:02.535736Z","time spent":"312.378929ms","remote":"127.0.0.1:58224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T01:18:02.848247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.317128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-27T01:18:02.848329Z","caller":"traceutil/trace.go:171","msg":"trace[1131550547] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18392; }","duration":"169.42821ms","start":"2026-05-27T01:18:02.678882Z","end":"2026-05-27T01:18:02.848311Z","steps":["trace[1131550547] 'agreement among raft nodes before linearized reading' (duration: 169.240635ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T01:18:02.848551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.545061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-27T01:18:02.848591Z","caller":"traceutil/trace.go:171","msg":"trace[1553941471] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18392; }","duration":"158.603553ms","start":"2026-05-27T01:18:02.689978Z","end":"2026-05-27T01:18:02.848581Z","steps":["trace[1553941471] 'agreement among raft nodes before linearized reading' (duration: 158.545931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T01:18:02.848593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.809192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-s988h\" ","response":"range_response_count:1 size:20849"} {"level":"info","ts":"2026-05-27T01:18:02.848702Z","caller":"traceutil/trace.go:171","msg":"trace[909478103] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-s988h; range_end:; response_count:1; response_revision:18392; }","duration":"137.921784ms","start":"2026-05-27T01:18:02.710744Z","end":"2026-05-27T01:18:02.848665Z","steps":["trace[909478103] 'agreement among raft nodes before linearized reading' (duration: 137.738939ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T01:18:02.8492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.059211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-05-27T01:18:02.849244Z","caller":"traceutil/trace.go:171","msg":"trace[1169299890] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18392; }","duration":"188.214195ms","start":"2026-05-27T01:18:02.66102Z","end":"2026-05-27T01:18:02.849234Z","steps":["trace[1169299890] 'agreement among raft nodes before linearized reading' (duration: 188.000269ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T01:18:03.062087Z","caller":"traceutil/trace.go:171","msg":"trace[462942631] transaction","detail":"{read_only:false; response_revision:18393; number_of_response:1; }","duration":"206.048143ms","start":"2026-05-27T01:18:02.85601Z","end":"2026-05-27T01:18:03.062058Z","steps":["trace[462942631] 'process raft request' (duration: 175.970207ms)","trace[462942631] 'compare' (duration: 29.719905ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T01:18:03.10407Z","caller":"traceutil/trace.go:171","msg":"trace[2008810754] transaction","detail":"{read_only:false; response_revision:18394; number_of_response:1; }","duration":"247.778311ms","start":"2026-05-27T01:18:02.856248Z","end":"2026-05-27T01:18:03.104026Z","steps":["trace[2008810754] 'process raft request' (duration: 247.38317ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T01:18:03.104125Z","caller":"traceutil/trace.go:171","msg":"trace[2112371852] transaction","detail":"{read_only:false; response_revision:18395; number_of_response:1; }","duration":"241.741698ms","start":"2026-05-27T01:18:02.862342Z","end":"2026-05-27T01:18:03.104084Z","steps":["trace[2112371852] 'process raft request' (duration: 241.569464ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T01:18:03.104329Z","caller":"traceutil/trace.go:171","msg":"trace[1818899485] transaction","detail":"{read_only:false; response_revision:18396; number_of_response:1; }","duration":"239.179605ms","start":"2026-05-27T01:18:02.865112Z","end":"2026-05-27T01:18:03.104292Z","steps":["trace[1818899485] 'process raft request' (duration: 238.866696ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T01:20:45.972376Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-27T01:20:45.978645Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-05-27T01:20:45.978786Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-05-27T01:21:01.878997Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17543} {"level":"info","ts":"2026-05-27T01:21:01.972891Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17543,"took":"90.127085ms","hash":2220255203,"current-db-size-bytes":58789888,"current-db-size":"59 MB","current-db-size-in-use-bytes":29937664,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-27T01:21:01.97295Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2220255203,"revision":17543,"compact-revision":15119} {"level":"info","ts":"2026-05-27T01:26:01.885382Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19423} {"level":"info","ts":"2026-05-27T01:26:01.973666Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19423,"took":"84.1592ms","hash":189839045,"current-db-size-bytes":58789888,"current-db-size":"59 MB","current-db-size-in-use-bytes":24203264,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-05-27T01:26:01.97373Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":189839045,"revision":19423,"compact-revision":17543}