{"level":"warn","ts":"2026-08-19T20:31:55.222692Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-19T20:31:55.222773Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.83: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.19.213.83:2380","--initial-cluster=instance=https://199.19.213.83:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.83:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.83: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-08-19T20:31:55.222837Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-19T20:31:55.22285Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.83:2380"]}
{"level":"info","ts":"2026-08-19T20:31:55.222871Z","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-08-19T20:31:55.223473Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.83:2379"]}
{"level":"info","ts":"2026-08-19T20:31:55.223542Z","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.19.213.83:2380"],"listen-peer-urls":["https://199.19.213.83:2380"],"advertise-client-urls":["https://199.19.213.83:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.83:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.83: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-08-19T20:31:55.227115Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.391247ms"}
{"level":"info","ts":"2026-08-19T20:31:55.242444Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5887d25060a34f1b","cluster-id":"8c4d9ec591b76d84"}
{"level":"info","ts":"2026-08-19T20:31:55.242537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5887d25060a34f1b switched to configuration voters=()"}
{"level":"info","ts":"2026-08-19T20:31:55.242561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5887d25060a34f1b became follower at term 0"}
{"level":"info","ts":"2026-08-19T20:31:55.242572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5887d25060a34f1b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-19T20:31:55.242586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5887d25060a34f1b became follower at term 1"}
{"level":"info","ts":"2026-08-19T20:31:55.242628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5887d25060a34f1b switched to configuration voters=(6379298639854128923)"}
{"level":"warn","ts":"2026-08-19T20:31:55.247237Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-19T20:31:55.248698Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-19T20:31:55.249866Z","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-08-19T20:31:55.252106Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5887d25060a34f1b","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-19T20:31:55.252327Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5887d25060a34f1b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-19T20:31:55.252629Z","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-08-19T20:31:55.252713Z","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-08-19T20:31:55.252727Z","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-08-19T20:31:55.256762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5887d25060a34f1b switched to configuration voters=(6379298639854128923)"}
{"level":"info","ts":"2026-08-19T20:31:55.256884Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8c4d9ec591b76d84","local-member-id":"5887d25060a34f1b","added-peer-id":"5887d25060a34f1b","added-peer-peer-urls":["https://199.19.213.83:2380"]}
{"level":"info","ts":"2026-08-19T20:31:55.258263Z","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-08-19T20:31:55.258385Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.83:2380"}
{"level":"info","ts":"2026-08-19T20:31:55.258405Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.83:2380"}
{"level":"info","ts":"2026-08-19T20:31:55.259137Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5887d25060a34f1b","initial-advertise-peer-urls":["https://199.19.213.83:2380"],"listen-peer-urls":["https://199.19.213.83:2380"],"advertise-client-urls":["https://199.19.213.83:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.83:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-19T20:31:55.259176Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-19T20:31:56.04306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5887d25060a34f1b is starting a new election at term 1"}
{"level":"info","ts":"2026-08-19T20:31:56.043152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5887d25060a34f1b became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-19T20:31:56.043191Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5887d25060a34f1b received MsgPreVoteResp from 5887d25060a34f1b at term 1"}
{"level":"info","ts":"2026-08-19T20:31:56.043212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5887d25060a34f1b became candidate at term 2"}
{"level":"info","ts":"2026-08-19T20:31:56.043222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5887d25060a34f1b received MsgVoteResp from 5887d25060a34f1b at term 2"}
{"level":"info","ts":"2026-08-19T20:31:56.043239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5887d25060a34f1b became leader at term 2"}
{"level":"info","ts":"2026-08-19T20:31:56.043252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5887d25060a34f1b elected leader 5887d25060a34f1b at term 2"}
{"level":"info","ts":"2026-08-19T20:31:56.044348Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5887d25060a34f1b","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.83:2379]}","request-path":"/0/members/5887d25060a34f1b/attributes","cluster-id":"8c4d9ec591b76d84","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-19T20:31:56.044363Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-19T20:31:56.044395Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-19T20:31:56.044388Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T20:31:56.045035Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-19T20:31:56.045174Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-19T20:31:56.045483Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8c4d9ec591b76d84","local-member-id":"5887d25060a34f1b","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T20:31:56.045642Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T20:31:56.045677Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-19T20:31:56.047659Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-08-19T20:31:56.048662Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.83:2379"}
{"level":"info","ts":"2026-08-19T20:32:05.553581Z","caller":"traceutil/trace.go:171","msg":"trace[1356979010] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"112.108082ms","start":"2026-08-19T20:32:05.441443Z","end":"2026-08-19T20:32:05.553551Z","steps":["trace[1356979010] 'process raft request'  (duration: 111.933969ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:32:11.625183Z","caller":"traceutil/trace.go:171","msg":"trace[842866397] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"212.063299ms","start":"2026-08-19T20:32:11.413095Z","end":"2026-08-19T20:32:11.625159Z","steps":["trace[842866397] 'process raft request'  (duration: 211.919377ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:32:33.357331Z","caller":"traceutil/trace.go:171","msg":"trace[313317572] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"143.661985ms","start":"2026-08-19T20:32:33.213629Z","end":"2026-08-19T20:32:33.357291Z","steps":["trace[313317572] 'process raft request'  (duration: 143.39434ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:32:33.362316Z","caller":"traceutil/trace.go:171","msg":"trace[1774726252] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"142.510312ms","start":"2026-08-19T20:32:33.219771Z","end":"2026-08-19T20:32:33.362281Z","steps":["trace[1774726252] 'process raft request'  (duration: 142.148014ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:32:33.362294Z","caller":"traceutil/trace.go:171","msg":"trace[271070228] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"142.655454ms","start":"2026-08-19T20:32:33.219573Z","end":"2026-08-19T20:32:33.362228Z","steps":["trace[271070228] 'process raft request'  (duration: 142.280747ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:32:33.362357Z","caller":"traceutil/trace.go:171","msg":"trace[170649735] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"134.930416ms","start":"2026-08-19T20:32:33.227393Z","end":"2026-08-19T20:32:33.362323Z","steps":["trace[170649735] 'process raft request'  (duration: 134.577568ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:32:33.362432Z","caller":"traceutil/trace.go:171","msg":"trace[1581343278] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"134.285033ms","start":"2026-08-19T20:32:33.2281Z","end":"2026-08-19T20:32:33.362385Z","steps":["trace[1581343278] 'process raft request'  (duration: 134.102898ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:32:33.36257Z","caller":"traceutil/trace.go:171","msg":"trace[493385968] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"133.269814ms","start":"2026-08-19T20:32:33.229233Z","end":"2026-08-19T20:32:33.362502Z","steps":["trace[493385968] 'process raft request'  (duration: 133.05282ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:32:33.362649Z","caller":"traceutil/trace.go:171","msg":"trace[174619103] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"133.6126ms","start":"2026-08-19T20:32:33.229005Z","end":"2026-08-19T20:32:33.362617Z","steps":["trace[174619103] 'process raft request'  (duration: 133.246363ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:32:33.362672Z","caller":"traceutil/trace.go:171","msg":"trace[1465142566] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"125.832629ms","start":"2026-08-19T20:32:33.236824Z","end":"2026-08-19T20:32:33.362657Z","steps":["trace[1465142566] 'process raft request'  (duration: 125.626125ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:32:33.362614Z","caller":"traceutil/trace.go:171","msg":"trace[67918986] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"132.364666ms","start":"2026-08-19T20:32:33.230235Z","end":"2026-08-19T20:32:33.362599Z","steps":["trace[67918986] 'process raft request'  (duration: 132.086281ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:32:33.362804Z","caller":"traceutil/trace.go:171","msg":"trace[591432768] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"113.951409ms","start":"2026-08-19T20:32:33.248822Z","end":"2026-08-19T20:32:33.362773Z","steps":["trace[591432768] 'process raft request'  (duration: 113.680564ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:32:39.551683Z","caller":"traceutil/trace.go:171","msg":"trace[33775471] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"114.821725ms","start":"2026-08-19T20:32:39.436828Z","end":"2026-08-19T20:32:39.55165Z","steps":["trace[33775471] 'process raft request'  (duration: 114.54067ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:32:40.02952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.887047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:32:40.029647Z","caller":"traceutil/trace.go:171","msg":"trace[12585020] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"196.06499ms","start":"2026-08-19T20:32:39.833564Z","end":"2026-08-19T20:32:40.029629Z","steps":["trace[12585020] 'range keys from in-memory index tree'  (duration: 195.802014ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:33:22.585751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.094002ms","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-08-19T20:33:22.585955Z","caller":"traceutil/trace.go:171","msg":"trace[1455195851] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1187; }","duration":"213.392677ms","start":"2026-08-19T20:33:22.372536Z","end":"2026-08-19T20:33:22.585929Z","steps":["trace[1455195851] 'range keys from in-memory index tree'  (duration: 212.760466ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:33:22.598316Z","caller":"traceutil/trace.go:171","msg":"trace[465797880] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"131.403902ms","start":"2026-08-19T20:33:22.466883Z","end":"2026-08-19T20:33:22.598287Z","steps":["trace[465797880] 'process raft request'  (duration: 131.108566ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:33:43.726697Z","caller":"traceutil/trace.go:171","msg":"trace[317547416] transaction","detail":"{read_only:false; response_revision:1442; number_of_response:1; }","duration":"154.461091ms","start":"2026-08-19T20:33:43.572186Z","end":"2026-08-19T20:33:43.726647Z","steps":["trace[317547416] 'process raft request'  (duration: 154.094204ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:34:06.95582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.740588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:34:06.955921Z","caller":"traceutil/trace.go:171","msg":"trace[559554182] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1840; }","duration":"122.9011ms","start":"2026-08-19T20:34:06.832999Z","end":"2026-08-19T20:34:06.9559Z","steps":["trace[559554182] 'range keys from in-memory index tree'  (duration: 122.643386ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:34:06.95607Z","caller":"traceutil/trace.go:171","msg":"trace[1412674697] linearizableReadLoop","detail":"{readStateIndex:1910; appliedIndex:1909; }","duration":"106.798139ms","start":"2026-08-19T20:34:06.849237Z","end":"2026-08-19T20:34:06.956035Z","steps":["trace[1412674697] 'read index received'  (duration: 33.491288ms)","trace[1412674697] 'applied index is now lower than readState.Index'  (duration: 73.304591ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:34:06.956353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.089374ms","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-08-19T20:34:06.956407Z","caller":"traceutil/trace.go:171","msg":"trace[1364429544] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1841; }","duration":"107.233057ms","start":"2026-08-19T20:34:06.849161Z","end":"2026-08-19T20:34:06.956394Z","steps":["trace[1364429544] 'agreement among raft nodes before linearized reading'  (duration: 106.991383ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:34:06.956335Z","caller":"traceutil/trace.go:171","msg":"trace[1317455061] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"114.464288ms","start":"2026-08-19T20:34:06.841785Z","end":"2026-08-19T20:34:06.956249Z","steps":["trace[1317455061] 'process raft request'  (duration: 40.882722ms)","trace[1317455061] 'compare'  (duration: 73.179808ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:34:07.192688Z","caller":"traceutil/trace.go:171","msg":"trace[536537882] linearizableReadLoop","detail":"{readStateIndex:1911; appliedIndex:1910; }","duration":"148.1466ms","start":"2026-08-19T20:34:07.044521Z","end":"2026-08-19T20:34:07.192668Z","steps":["trace[536537882] 'read index received'  (duration: 84.383074ms)","trace[536537882] 'applied index is now lower than readState.Index'  (duration: 63.762406ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:34:07.192743Z","caller":"traceutil/trace.go:171","msg":"trace[575934090] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"232.636655ms","start":"2026-08-19T20:34:06.960066Z","end":"2026-08-19T20:34:07.192702Z","steps":["trace[575934090] 'process raft request'  (duration: 168.913721ms)","trace[575934090] 'compare'  (duration: 63.585422ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:34:07.192906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.358033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-08-19T20:34:07.192958Z","caller":"traceutil/trace.go:171","msg":"trace[1468744378] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1842; }","duration":"148.445185ms","start":"2026-08-19T20:34:07.044495Z","end":"2026-08-19T20:34:07.19294Z","steps":["trace[1468744378] 'agreement among raft nodes before linearized reading'  (duration: 148.255341ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:34:51.887563Z","caller":"traceutil/trace.go:171","msg":"trace[1171359215] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"144.332755ms","start":"2026-08-19T20:34:51.743211Z","end":"2026-08-19T20:34:51.887544Z","steps":["trace[1171359215] 'process raft request'  (duration: 143.874406ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:34:52.26572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.332638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"warn","ts":"2026-08-19T20:34:52.265761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.210337ms","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-08-19T20:34:52.265826Z","caller":"traceutil/trace.go:171","msg":"trace[109162267] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2140; }","duration":"188.476041ms","start":"2026-08-19T20:34:52.07731Z","end":"2026-08-19T20:34:52.265786Z","steps":["trace[109162267] 'range keys from in-memory index tree'  (duration: 188.145164ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:34:52.265884Z","caller":"traceutil/trace.go:171","msg":"trace[636571037] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:2140; }","duration":"122.402971ms","start":"2026-08-19T20:34:52.14344Z","end":"2026-08-19T20:34:52.265843Z","steps":["trace[636571037] 'count revisions from in-memory index tree'  (duration: 122.098285ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:36:21.069879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.458455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:36:21.069976Z","caller":"traceutil/trace.go:171","msg":"trace[1770956365] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2815; }","duration":"236.614098ms","start":"2026-08-19T20:36:20.833345Z","end":"2026-08-19T20:36:21.069959Z","steps":["trace[1770956365] 'range keys from in-memory index tree'  (duration: 236.348553ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:36:21.069881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.535561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:36:21.070195Z","caller":"traceutil/trace.go:171","msg":"trace[1356794044] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:2815; }","duration":"113.912238ms","start":"2026-08-19T20:36:20.956268Z","end":"2026-08-19T20:36:21.07018Z","steps":["trace[1356794044] 'count revisions from in-memory index tree'  (duration: 113.439769ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:40:17.86311Z","caller":"traceutil/trace.go:171","msg":"trace[1705315539] transaction","detail":"{read_only:false; response_revision:5031; number_of_response:1; }","duration":"127.138816ms","start":"2026-08-19T20:40:17.735944Z","end":"2026-08-19T20:40:17.863083Z","steps":["trace[1705315539] 'process raft request'  (duration: 126.678097ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:40:17.873611Z","caller":"traceutil/trace.go:171","msg":"trace[584425154] transaction","detail":"{read_only:false; response_revision:5032; number_of_response:1; }","duration":"105.074528ms","start":"2026-08-19T20:40:17.768491Z","end":"2026-08-19T20:40:17.873566Z","steps":["trace[584425154] 'process raft request'  (duration: 104.855893ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:40:29.803912Z","caller":"traceutil/trace.go:171","msg":"trace[95715474] transaction","detail":"{read_only:false; response_revision:5262; number_of_response:1; }","duration":"263.606782ms","start":"2026-08-19T20:40:29.54026Z","end":"2026-08-19T20:40:29.803867Z","steps":["trace[95715474] 'process raft request'  (duration: 263.222965ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:40:29.803921Z","caller":"traceutil/trace.go:171","msg":"trace[1650803308] linearizableReadLoop","detail":"{readStateIndex:5454; appliedIndex:5453; }","duration":"242.380572ms","start":"2026-08-19T20:40:29.561468Z","end":"2026-08-19T20:40:29.803848Z","steps":["trace[1650803308] 'read index received'  (duration: 241.988205ms)","trace[1650803308] 'applied index is now lower than readState.Index'  (duration: 386.467µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:40:29.804168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.662238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:40:29.804271Z","caller":"traceutil/trace.go:171","msg":"trace[989526453] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5262; }","duration":"242.825382ms","start":"2026-08-19T20:40:29.561422Z","end":"2026-08-19T20:40:29.804248Z","steps":["trace[989526453] 'agreement among raft nodes before linearized reading'  (duration: 242.607077ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:40:29.804367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.289382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:40:29.804449Z","caller":"traceutil/trace.go:171","msg":"trace[413781324] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:5262; }","duration":"123.391694ms","start":"2026-08-19T20:40:29.681016Z","end":"2026-08-19T20:40:29.804408Z","steps":["trace[413781324] 'agreement among raft nodes before linearized reading'  (duration: 123.267151ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:40:29.804361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.593866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-08-19T20:40:29.804677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.775981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-19T20:40:29.804809Z","caller":"traceutil/trace.go:171","msg":"trace[1637532547] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:5262; }","duration":"123.950814ms","start":"2026-08-19T20:40:29.680809Z","end":"2026-08-19T20:40:29.80476Z","steps":["trace[1637532547] 'agreement among raft nodes before linearized reading'  (duration: 123.758921ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:40:29.804628Z","caller":"traceutil/trace.go:171","msg":"trace[1664448714] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:5262; }","duration":"155.863001ms","start":"2026-08-19T20:40:29.648689Z","end":"2026-08-19T20:40:29.804552Z","steps":["trace[1664448714] 'agreement among raft nodes before linearized reading'  (duration: 155.554805ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:41:30.16043Z","caller":"traceutil/trace.go:171","msg":"trace[1632221295] transaction","detail":"{read_only:false; response_revision:5930; number_of_response:1; }","duration":"106.722281ms","start":"2026-08-19T20:41:30.05368Z","end":"2026-08-19T20:41:30.160402Z","steps":["trace[1632221295] 'process raft request'  (duration: 106.546428ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:41:56.071021Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3006}
{"level":"info","ts":"2026-08-19T20:41:56.1635Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3006,"took":"91.111333ms","hash":2157502076,"current-db-size-bytes":58990592,"current-db-size":"59 MB","current-db-size-in-use-bytes":32153600,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-19T20:41:56.163582Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2157502076,"revision":3006,"compact-revision":-1}
{"level":"info","ts":"2026-08-19T20:46:42.131473Z","caller":"traceutil/trace.go:171","msg":"trace[1524236535] linearizableReadLoop","detail":"{readStateIndex:8529; appliedIndex:8528; }","duration":"297.986404ms","start":"2026-08-19T20:46:41.833439Z","end":"2026-08-19T20:46:42.131425Z","steps":["trace[1524236535] 'read index received'  (duration: 297.79239ms)","trace[1524236535] 'applied index is now lower than readState.Index'  (duration: 192.824µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:46:42.131608Z","caller":"traceutil/trace.go:171","msg":"trace[1332228493] transaction","detail":"{read_only:false; response_revision:8245; number_of_response:1; }","duration":"343.221588ms","start":"2026-08-19T20:46:41.788352Z","end":"2026-08-19T20:46:42.131573Z","steps":["trace[1332228493] 'process raft request'  (duration: 342.892122ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:46:42.131672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.503385ms","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":"info","ts":"2026-08-19T20:46:42.131711Z","caller":"traceutil/trace.go:171","msg":"trace[39553427] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:8245; }","duration":"114.609497ms","start":"2026-08-19T20:46:42.01709Z","end":"2026-08-19T20:46:42.1317Z","steps":["trace[39553427] 'agreement among raft nodes before linearized reading'  (duration: 114.520884ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:46:42.131705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.252829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:46:42.131793Z","caller":"traceutil/trace.go:171","msg":"trace[1805889009] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8245; }","duration":"298.392293ms","start":"2026-08-19T20:46:41.833378Z","end":"2026-08-19T20:46:42.13177Z","steps":["trace[1805889009] 'agreement among raft nodes before linearized reading'  (duration: 298.219879ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:46:42.132194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T20:46:41.788314Z","time spent":"343.365891ms","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:8234 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-19T20:46:53.39675Z","caller":"traceutil/trace.go:171","msg":"trace[711017522] linearizableReadLoop","detail":"{readStateIndex:8598; appliedIndex:8597; }","duration":"143.658329ms","start":"2026-08-19T20:46:53.253068Z","end":"2026-08-19T20:46:53.396726Z","steps":["trace[711017522] 'read index received'  (duration: 143.512836ms)","trace[711017522] 'applied index is now lower than readState.Index'  (duration: 144.563µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:46:53.396811Z","caller":"traceutil/trace.go:171","msg":"trace[792363177] transaction","detail":"{read_only:false; response_revision:8311; number_of_response:1; }","duration":"147.827758ms","start":"2026-08-19T20:46:53.24895Z","end":"2026-08-19T20:46:53.396777Z","steps":["trace[792363177] 'process raft request'  (duration: 147.593114ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:46:53.397307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.20493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:223782"}
{"level":"info","ts":"2026-08-19T20:46:53.397411Z","caller":"traceutil/trace.go:171","msg":"trace[2135436696] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8311; }","duration":"144.343862ms","start":"2026-08-19T20:46:53.253046Z","end":"2026-08-19T20:46:53.39739Z","steps":["trace[2135436696] 'agreement among raft nodes before linearized reading'  (duration: 143.807111ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:46:54.507248Z","caller":"traceutil/trace.go:171","msg":"trace[430976749] transaction","detail":"{read_only:false; response_revision:8316; number_of_response:1; }","duration":"255.636794ms","start":"2026-08-19T20:46:54.251586Z","end":"2026-08-19T20:46:54.507223Z","steps":["trace[430976749] 'process raft request'  (duration: 246.334766ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:46:54.521919Z","caller":"traceutil/trace.go:171","msg":"trace[231734755] transaction","detail":"{read_only:false; response_revision:8317; number_of_response:1; }","duration":"270.172396ms","start":"2026-08-19T20:46:54.251721Z","end":"2026-08-19T20:46:54.521893Z","steps":["trace[231734755] 'process raft request'  (duration: 269.902151ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:46:54.54802Z","caller":"traceutil/trace.go:171","msg":"trace[1660813583] linearizableReadLoop","detail":"{readStateIndex:8604; appliedIndex:8602; }","duration":"252.556955ms","start":"2026-08-19T20:46:54.295429Z","end":"2026-08-19T20:46:54.547986Z","steps":["trace[1660813583] 'read index received'  (duration: 202.499248ms)","trace[1660813583] 'applied index is now lower than readState.Index'  (duration: 50.056357ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:46:54.548328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.885842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-08-19T20:46:54.54845Z","caller":"traceutil/trace.go:171","msg":"trace[1647076699] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8317; }","duration":"253.044655ms","start":"2026-08-19T20:46:54.295378Z","end":"2026-08-19T20:46:54.548422Z","steps":["trace[1647076699] 'agreement among raft nodes before linearized reading'  (duration: 252.75455ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:46:56.076795Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6144}
{"level":"info","ts":"2026-08-19T20:46:56.169236Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6144,"took":"90.896669ms","hash":3612699227,"current-db-size-bytes":58990592,"current-db-size":"59 MB","current-db-size-in-use-bytes":23891968,"current-db-size-in-use":"24 MB"}
{"level":"info","ts":"2026-08-19T20:46:56.169371Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3612699227,"revision":6144,"compact-revision":3006}
{"level":"info","ts":"2026-08-19T20:47:35.392902Z","caller":"traceutil/trace.go:171","msg":"trace[1851371917] transaction","detail":"{read_only:false; response_revision:8631; number_of_response:1; }","duration":"221.588526ms","start":"2026-08-19T20:47:35.171287Z","end":"2026-08-19T20:47:35.392875Z","steps":["trace[1851371917] 'process raft request'  (duration: 147.509033ms)","trace[1851371917] 'compare'  (duration: 73.885959ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:47:35.411294Z","caller":"traceutil/trace.go:171","msg":"trace[564980714] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8632; }","duration":"239.587964ms","start":"2026-08-19T20:47:35.171665Z","end":"2026-08-19T20:47:35.411253Z","steps":["trace[564980714] 'process raft request'  (duration: 239.37677ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:47:36.083474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.022439ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5700325794298707113 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:8616 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T20:47:36.083589Z","caller":"traceutil/trace.go:171","msg":"trace[69916870] transaction","detail":"{read_only:false; response_revision:8638; number_of_response:1; }","duration":"211.053513ms","start":"2026-08-19T20:47:35.872515Z","end":"2026-08-19T20:47:36.083569Z","steps":["trace[69916870] 'process raft request'  (duration: 101.715568ms)","trace[69916870] 'compare'  (duration: 108.837175ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:47:36.26699Z","caller":"traceutil/trace.go:171","msg":"trace[557164733] transaction","detail":"{read_only:false; response_revision:8639; number_of_response:1; }","duration":"113.506126ms","start":"2026-08-19T20:47:36.153446Z","end":"2026-08-19T20:47:36.266953Z","steps":["trace[557164733] 'process raft request'  (duration: 61.720454ms)","trace[557164733] 'compare'  (duration: 51.642729ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:47:51.536795Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023b8.wal"}
{"level":"info","ts":"2026-08-19T20:49:29.232749Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5887d25060a34f1b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-19T20:49:29.238088Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-19T20:49:29.238211Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-19T20:51:56.083539Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8328}
{"level":"info","ts":"2026-08-19T20:51:56.167686Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8328,"took":"82.114805ms","hash":2701846255,"current-db-size-bytes":58990592,"current-db-size":"59 MB","current-db-size-in-use-bytes":25485312,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-08-19T20:51:56.167763Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2701846255,"revision":8328,"compact-revision":6144}
{"level":"warn","ts":"2026-08-19T20:52:34.412443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.209874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-08-19T20:52:34.412531Z","caller":"traceutil/trace.go:171","msg":"trace[1758893902] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11227; }","duration":"147.371407ms","start":"2026-08-19T20:52:34.26514Z","end":"2026-08-19T20:52:34.412511Z","steps":["trace[1758893902] 'range keys from in-memory index tree'  (duration: 147.00634ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:52:34.412725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.626639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-08-19T20:52:34.412853Z","caller":"traceutil/trace.go:171","msg":"trace[1523040624] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:11227; }","duration":"150.790692ms","start":"2026-08-19T20:52:34.262033Z","end":"2026-08-19T20:52:34.412824Z","steps":["trace[1523040624] 'range keys from in-memory index tree'  (duration: 150.395775ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:52:34.688854Z","caller":"traceutil/trace.go:171","msg":"trace[1425149342] linearizableReadLoop","detail":"{readStateIndex:11606; appliedIndex:11605; }","duration":"183.706048ms","start":"2026-08-19T20:52:34.505097Z","end":"2026-08-19T20:52:34.688803Z","steps":["trace[1425149342] 'read index received'  (duration: 162.835051ms)","trace[1425149342] 'applied index is now lower than readState.Index'  (duration: 20.868947ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:52:34.688906Z","caller":"traceutil/trace.go:171","msg":"trace[1154361031] transaction","detail":"{read_only:false; response_revision:11230; number_of_response:1; }","duration":"186.977531ms","start":"2026-08-19T20:52:34.501879Z","end":"2026-08-19T20:52:34.688856Z","steps":["trace[1154361031] 'process raft request'  (duration: 166.029922ms)","trace[1154361031] 'compare'  (duration: 20.664734ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:52:34.68918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.058185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-08-19T20:52:34.689248Z","caller":"traceutil/trace.go:171","msg":"trace[1350905746] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:11230; }","duration":"184.178137ms","start":"2026-08-19T20:52:34.505049Z","end":"2026-08-19T20:52:34.689227Z","steps":["trace[1350905746] 'agreement among raft nodes before linearized reading'  (duration: 183.875331ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:52:34.689287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.216294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"}
{"level":"info","ts":"2026-08-19T20:52:34.689473Z","caller":"traceutil/trace.go:171","msg":"trace[729314589] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:11230; }","duration":"135.355108ms","start":"2026-08-19T20:52:34.554014Z","end":"2026-08-19T20:52:34.689369Z","steps":["trace[729314589] 'agreement among raft nodes before linearized reading'  (duration: 135.083473ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:56:56.091115Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10830}
{"level":"info","ts":"2026-08-19T20:56:56.171048Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10830,"took":"76.36414ms","hash":2061720778,"current-db-size-bytes":58990592,"current-db-size":"59 MB","current-db-size-in-use-bytes":27877376,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-19T20:56:56.171158Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2061720778,"revision":10830,"compact-revision":8328}
{"level":"warn","ts":"2026-08-19T20:59:08.610655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.372634ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5700325794298721798 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:13840 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-19T20:59:08.610781Z","caller":"traceutil/trace.go:171","msg":"trace[603644723] linearizableReadLoop","detail":"{readStateIndex:14335; appliedIndex:14333; }","duration":"264.808257ms","start":"2026-08-19T20:59:08.345954Z","end":"2026-08-19T20:59:08.610762Z","steps":["trace[603644723] 'read index received'  (duration: 11.382399ms)","trace[603644723] 'applied index is now lower than readState.Index'  (duration: 253.423908ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:59:08.610871Z","caller":"traceutil/trace.go:171","msg":"trace[891301970] transaction","detail":"{read_only:false; response_revision:13866; number_of_response:1; }","duration":"273.846181ms","start":"2026-08-19T20:59:08.337013Z","end":"2026-08-19T20:59:08.610859Z","steps":["trace[891301970] 'process raft request'  (duration: 78.154061ms)","trace[891301970] 'compare'  (duration: 195.15229ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T20:59:08.61136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.433146ms","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-08-19T20:59:08.611388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.428858ms","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-08-19T20:59:08.611467Z","caller":"traceutil/trace.go:171","msg":"trace[71333861] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:13866; }","duration":"265.559991ms","start":"2026-08-19T20:59:08.345888Z","end":"2026-08-19T20:59:08.611448Z","steps":["trace[71333861] 'agreement among raft nodes before linearized reading'  (duration: 265.294416ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:59:08.611466Z","caller":"traceutil/trace.go:171","msg":"trace[373346175] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:13866; }","duration":"256.619029ms","start":"2026-08-19T20:59:08.354821Z","end":"2026-08-19T20:59:08.61144Z","steps":["trace[373346175] 'agreement among raft nodes before linearized reading'  (duration: 256.10386ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:59:29.952086Z","caller":"traceutil/trace.go:171","msg":"trace[843697720] linearizableReadLoop","detail":"{readStateIndex:14655; appliedIndex:14654; }","duration":"213.601073ms","start":"2026-08-19T20:59:29.738459Z","end":"2026-08-19T20:59:29.95206Z","steps":["trace[843697720] 'read index received'  (duration: 213.362468ms)","trace[843697720] 'applied index is now lower than readState.Index'  (duration: 237.635µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T20:59:29.952176Z","caller":"traceutil/trace.go:171","msg":"trace[333853564] transaction","detail":"{read_only:false; response_revision:14172; number_of_response:1; }","duration":"254.459077ms","start":"2026-08-19T20:59:29.697678Z","end":"2026-08-19T20:59:29.952137Z","steps":["trace[333853564] 'process raft request'  (duration: 254.204862ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:59:29.952318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.844897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-00eace49-0951-41d7-b412-564d42f97735\" ","response":"range_response_count:1 size:3753"}
{"level":"warn","ts":"2026-08-19T20:59:29.952379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.563811ms","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-08-19T20:59:29.952428Z","caller":"traceutil/trace.go:171","msg":"trace[12792288] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14172; }","duration":"202.643643ms","start":"2026-08-19T20:59:29.749774Z","end":"2026-08-19T20:59:29.952417Z","steps":["trace[12792288] 'agreement among raft nodes before linearized reading'  (duration: 202.448389ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T20:59:29.952451Z","caller":"traceutil/trace.go:171","msg":"trace[789655475] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-00eace49-0951-41d7-b412-564d42f97735; range_end:; response_count:1; response_revision:14172; }","duration":"214.038022ms","start":"2026-08-19T20:59:29.738375Z","end":"2026-08-19T20:59:29.952413Z","steps":["trace[789655475] 'agreement among raft nodes before linearized reading'  (duration: 213.790117ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:59:29.952467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.559388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:59:29.952523Z","caller":"traceutil/trace.go:171","msg":"trace[1114119375] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:14172; }","duration":"168.62669ms","start":"2026-08-19T20:59:29.783874Z","end":"2026-08-19T20:59:29.9525Z","steps":["trace[1114119375] 'agreement among raft nodes before linearized reading'  (duration: 168.514018ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T20:59:29.952536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.954555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T20:59:29.952675Z","caller":"traceutil/trace.go:171","msg":"trace[431759028] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14172; }","duration":"120.128438ms","start":"2026-08-19T20:59:29.832517Z","end":"2026-08-19T20:59:29.952645Z","steps":["trace[431759028] 'agreement among raft nodes before linearized reading'  (duration: 119.840413ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:00:59.747403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.651438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-9zk9v\" ","response":"range_response_count:1 size:22128"}
{"level":"info","ts":"2026-08-19T21:00:59.74749Z","caller":"traceutil/trace.go:171","msg":"trace[245561797] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-9zk9v; range_end:; response_count:1; response_revision:15002; }","duration":"170.786151ms","start":"2026-08-19T21:00:59.576687Z","end":"2026-08-19T21:00:59.747474Z","steps":["trace[245561797] 'range keys from in-memory index tree'  (duration: 170.498405ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:00:59.747404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.744398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-9zk9v\" ","response":"range_response_count:1 size:22128"}
{"level":"info","ts":"2026-08-19T21:00:59.747648Z","caller":"traceutil/trace.go:171","msg":"trace[158379369] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-9zk9v; range_end:; response_count:1; response_revision:15002; }","duration":"147.963252ms","start":"2026-08-19T21:00:59.599636Z","end":"2026-08-19T21:00:59.747599Z","steps":["trace[158379369] 'range keys from in-memory index tree'  (duration: 147.556665ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:01:00.366536Z","caller":"traceutil/trace.go:171","msg":"trace[1749180592] linearizableReadLoop","detail":"{readStateIndex:15513; appliedIndex:15512; }","duration":"125.706755ms","start":"2026-08-19T21:01:00.24081Z","end":"2026-08-19T21:01:00.366517Z","steps":["trace[1749180592] 'read index received'  (duration: 125.579052ms)","trace[1749180592] 'applied index is now lower than readState.Index'  (duration: 127.063µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:01:00.366696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.877439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-08-19T21:01:00.366723Z","caller":"traceutil/trace.go:171","msg":"trace[2084050023] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15004; }","duration":"125.961489ms","start":"2026-08-19T21:01:00.240754Z","end":"2026-08-19T21:01:00.366715Z","steps":["trace[2084050023] 'agreement among raft nodes before linearized reading'  (duration: 125.840017ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:01:00.366849Z","caller":"traceutil/trace.go:171","msg":"trace[1013078523] transaction","detail":"{read_only:false; response_revision:15004; number_of_response:1; }","duration":"244.461365ms","start":"2026-08-19T21:01:00.122358Z","end":"2026-08-19T21:01:00.36682Z","steps":["trace[1013078523] 'process raft request'  (duration: 244.040388ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:01:00.555005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.282074ms","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-08-19T21:01:00.555103Z","caller":"traceutil/trace.go:171","msg":"trace[45409214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15004; }","duration":"127.433418ms","start":"2026-08-19T21:01:00.427648Z","end":"2026-08-19T21:01:00.555082Z","steps":["trace[45409214] 'range keys from in-memory index tree'  (duration: 127.07954ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:01:56.10544Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13011}
{"level":"info","ts":"2026-08-19T21:01:56.195447Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13011,"took":"87.322987ms","hash":1691676709,"current-db-size-bytes":58990592,"current-db-size":"59 MB","current-db-size-in-use-bytes":29802496,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-19T21:01:56.195526Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1691676709,"revision":13011,"compact-revision":10830}
{"level":"warn","ts":"2026-08-19T21:03:42.518446Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5700325794298730384,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-08-19T21:03:42.571923Z","caller":"traceutil/trace.go:171","msg":"trace[152100907] linearizableReadLoop","detail":"{readStateIndex:16716; appliedIndex:16714; }","duration":"554.261316ms","start":"2026-08-19T21:03:42.017634Z","end":"2026-08-19T21:03:42.571895Z","steps":["trace[152100907] 'read index received'  (duration: 553.93985ms)","trace[152100907] 'applied index is now lower than readState.Index'  (duration: 320.326µs)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:03:42.572429Z","caller":"traceutil/trace.go:171","msg":"trace[528681626] transaction","detail":"{read_only:false; response_revision:16164; number_of_response:1; }","duration":"583.538764ms","start":"2026-08-19T21:03:41.98887Z","end":"2026-08-19T21:03:42.572409Z","steps":["trace[528681626] 'process raft request'  (duration: 582.800101ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:42.572589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:41.988861Z","time spent":"583.620086ms","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:16153 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-08-19T21:03:42.572809Z","caller":"traceutil/trace.go:171","msg":"trace[1155364491] transaction","detail":"{read_only:false; response_revision:16165; number_of_response:1; }","duration":"556.15033ms","start":"2026-08-19T21:03:42.016645Z","end":"2026-08-19T21:03:42.572795Z","steps":["trace[1155364491] 'process raft request'  (duration: 555.195703ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:42.572881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:42.016628Z","time spent":"556.218922ms","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:16154 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:454 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-08-19T21:03:42.573133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.488858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-08-19T21:03:42.573189Z","caller":"traceutil/trace.go:171","msg":"trace[215993497] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16165; }","duration":"555.561129ms","start":"2026-08-19T21:03:42.017609Z","end":"2026-08-19T21:03:42.57317Z","steps":["trace[215993497] 'agreement among raft nodes before linearized reading'  (duration: 555.401006ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:42.57323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:42.017599Z","time spent":"555.621951ms","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-08-19T21:03:42.573391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.098081ms","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-08-19T21:03:42.573523Z","caller":"traceutil/trace.go:171","msg":"trace[1386466082] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:16165; }","duration":"555.237734ms","start":"2026-08-19T21:03:42.018269Z","end":"2026-08-19T21:03:42.573507Z","steps":["trace[1386466082] 'agreement among raft nodes before linearized reading'  (duration: 555.052681ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:42.573564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:42.018261Z","time spent":"555.290455ms","remote":"127.0.0.1:39906","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-08-19T21:03:42.573978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.653528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-w9w9l\" ","response":"range_response_count:1 size:9798"}
{"level":"info","ts":"2026-08-19T21:03:42.574023Z","caller":"traceutil/trace.go:171","msg":"trace[1542229745] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-w9w9l; range_end:; response_count:1; response_revision:16165; }","duration":"276.73535ms","start":"2026-08-19T21:03:42.297278Z","end":"2026-08-19T21:03:42.574013Z","steps":["trace[1542229745] 'agreement among raft nodes before linearized reading'  (duration: 276.625028ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:43.895631Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5700325794298730403,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-08-19T21:03:44.396231Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5700325794298730403,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-08-19T21:03:44.896443Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5700325794298730403,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-08-19T21:03:45.396921Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5700325794298730403,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-08-19T21:03:46.250554Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5700325794298730403,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-08-19T21:03:46.250666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.416806916s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"}
{"level":"info","ts":"2026-08-19T21:03:46.250699Z","caller":"traceutil/trace.go:171","msg":"trace[2082142248] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.416895838s","start":"2026-08-19T21:03:43.833788Z","end":"2026-08-19T21:03:46.250684Z","steps":["trace[2082142248] 'agreement among raft nodes before linearized reading'  (duration: 2.416844567s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.25073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:43.833769Z","time spent":"2.416955839s","remote":"127.0.0.1:39628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-08-19T21:03:46.7516Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5700325794298730403,"retry-timeout":"500ms"}
{"level":"warn","ts":"2026-08-19T21:03:46.785017Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.435066887s","expected-duration":"1s"}
{"level":"info","ts":"2026-08-19T21:03:46.786728Z","caller":"traceutil/trace.go:171","msg":"trace[37505379] transaction","detail":"{read_only:false; response_revision:16170; number_of_response:1; }","duration":"3.436888771s","start":"2026-08-19T21:03:43.34981Z","end":"2026-08-19T21:03:46.786699Z","steps":["trace[37505379] 'process raft request'  (duration: 3.436668517s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.786938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:43.349788Z","time spent":"3.437012253s","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:16161 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-08-19T21:03:46.787068Z","caller":"traceutil/trace.go:171","msg":"trace[938151532] transaction","detail":"{read_only:false; response_revision:16171; number_of_response:1; }","duration":"3.110770671s","start":"2026-08-19T21:03:43.676268Z","end":"2026-08-19T21:03:46.787039Z","steps":["trace[938151532] 'process raft request'  (duration: 3.110334503s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.787203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:43.676248Z","time spent":"3.110883012s","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:16163 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:477 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-19T21:03:46.789662Z","caller":"traceutil/trace.go:171","msg":"trace[1661544994] linearizableReadLoop","detail":"{readStateIndex:16724; appliedIndex:16722; }","duration":"3.394410769s","start":"2026-08-19T21:03:43.395226Z","end":"2026-08-19T21:03:46.789637Z","steps":["trace[1661544994] 'read index received'  (duration: 3.392086827s)","trace[1661544994] 'applied index is now lower than readState.Index'  (duration: 2.323102ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:03:46.789863Z","caller":"traceutil/trace.go:171","msg":"trace[360820128] transaction","detail":"{read_only:false; response_revision:16172; number_of_response:1; }","duration":"2.206900475s","start":"2026-08-19T21:03:44.582951Z","end":"2026-08-19T21:03:46.789851Z","steps":["trace[360820128] 'process raft request'  (duration: 2.206415736s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.79Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:44.582923Z","time spent":"2.206974006s","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:16165 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-08-19T21:03:46.790536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.353852523s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-9zk9v\" ","response":"range_response_count:1 size:22128"}
{"level":"info","ts":"2026-08-19T21:03:46.790662Z","caller":"traceutil/trace.go:171","msg":"trace[1838646759] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-9zk9v; range_end:; response_count:1; response_revision:16172; }","duration":"3.354199919s","start":"2026-08-19T21:03:43.436433Z","end":"2026-08-19T21:03:46.790633Z","steps":["trace[1838646759] 'agreement among raft nodes before linearized reading'  (duration: 3.353719161s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.790724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:43.436405Z","time spent":"3.354307752s","remote":"127.0.0.1:39814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22151,"request content":"key:\"/registry/pods/openstack/nova-compute-default-9zk9v\" "}
{"level":"warn","ts":"2026-08-19T21:03:46.791064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.395843115s","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-08-19T21:03:46.791152Z","caller":"traceutil/trace.go:171","msg":"trace[446900389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:16172; }","duration":"3.395964897s","start":"2026-08-19T21:03:43.395179Z","end":"2026-08-19T21:03:46.791144Z","steps":["trace[446900389] 'agreement among raft nodes before linearized reading'  (duration: 3.395817344s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.791211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:43.395155Z","time spent":"3.396047309s","remote":"127.0.0.1:39906","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-08-19T21:03:46.7914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.182096748s","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-08-19T21:03:46.791456Z","caller":"traceutil/trace.go:171","msg":"trace[265953917] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:16172; }","duration":"2.182170511s","start":"2026-08-19T21:03:44.609278Z","end":"2026-08-19T21:03:46.791448Z","steps":["trace[265953917] 'agreement among raft nodes before linearized reading'  (duration: 2.182069988s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.791497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:44.609267Z","time spent":"2.182222722s","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"warn","ts":"2026-08-19T21:03:46.791744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.193635751s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-w9w9l\" ","response":"range_response_count:1 size:9798"}
{"level":"info","ts":"2026-08-19T21:03:46.791801Z","caller":"traceutil/trace.go:171","msg":"trace[119151799] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-w9w9l; range_end:; response_count:1; response_revision:16172; }","duration":"2.193713193s","start":"2026-08-19T21:03:44.59808Z","end":"2026-08-19T21:03:46.791794Z","steps":["trace[119151799] 'agreement among raft nodes before linearized reading'  (duration: 2.193584331s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.79204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:44.598071Z","time spent":"2.193805005s","remote":"127.0.0.1:39814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9821,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-w9w9l\" "}
{"level":"warn","ts":"2026-08-19T21:03:46.792193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.098696381s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-19T21:03:46.792205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.359399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"}
{"level":"info","ts":"2026-08-19T21:03:46.792255Z","caller":"traceutil/trace.go:171","msg":"trace[2040269415] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:16172; }","duration":"1.098812902s","start":"2026-08-19T21:03:45.693431Z","end":"2026-08-19T21:03:46.792244Z","steps":["trace[2040269415] 'agreement among raft nodes before linearized reading'  (duration: 1.0987217s)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:03:46.792302Z","caller":"traceutil/trace.go:171","msg":"trace[244210984] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:16172; }","duration":"541.502152ms","start":"2026-08-19T21:03:46.250777Z","end":"2026-08-19T21:03:46.792279Z","steps":["trace[244210984] 'agreement among raft nodes before linearized reading'  (duration: 541.174036ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.792364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:46.250765Z","time spent":"541.589093ms","remote":"127.0.0.1:39772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1656,"request content":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" "}
{"level":"warn","ts":"2026-08-19T21:03:46.792485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.307937829s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"}
{"level":"info","ts":"2026-08-19T21:03:46.792523Z","caller":"traceutil/trace.go:171","msg":"trace[518166138] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:16172; }","duration":"1.308007031s","start":"2026-08-19T21:03:45.4845Z","end":"2026-08-19T21:03:46.792507Z","steps":["trace[518166138] 'agreement among raft nodes before linearized reading'  (duration: 1.307894109s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.792507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.658965016s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-19T21:03:46.792562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:45.484476Z","time spent":"1.308081002s","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "}
{"level":"warn","ts":"2026-08-19T21:03:46.792661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.203138156s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"warn","ts":"2026-08-19T21:03:46.792721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.005194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T21:03:46.792767Z","caller":"traceutil/trace.go:171","msg":"trace[899920428] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:16172; }","duration":"508.093175ms","start":"2026-08-19T21:03:46.284662Z","end":"2026-08-19T21:03:46.792755Z","steps":["trace[899920428] 'agreement among raft nodes before linearized reading'  (duration: 508.005884ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.792804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:46.284651Z","time spent":"508.143886ms","remote":"127.0.0.1:59896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "}
{"level":"info","ts":"2026-08-19T21:03:46.792747Z","caller":"traceutil/trace.go:171","msg":"trace[1629217786] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:16172; }","duration":"2.20340326s","start":"2026-08-19T21:03:44.589334Z","end":"2026-08-19T21:03:46.792737Z","steps":["trace[1629217786] 'agreement among raft nodes before linearized reading'  (duration: 2.203034103s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.792868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.204498732s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-08-19T21:03:46.792892Z","caller":"traceutil/trace.go:171","msg":"trace[1274154861] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16172; }","duration":"2.204538842s","start":"2026-08-19T21:03:44.588346Z","end":"2026-08-19T21:03:46.792885Z","steps":["trace[1274154861] 'agreement among raft nodes before linearized reading'  (duration: 2.204482281s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.792913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:44.588336Z","time spent":"2.204573713s","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-08-19T21:03:46.792883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.935281954s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T21:03:46.792962Z","caller":"traceutil/trace.go:171","msg":"trace[1231536907] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:16172; }","duration":"2.935361966s","start":"2026-08-19T21:03:43.857589Z","end":"2026-08-19T21:03:46.792931Z","steps":["trace[1231536907] 'agreement among raft nodes before linearized reading'  (duration: 2.935264054s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.792984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.659652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-19T21:03:46.793027Z","caller":"traceutil/trace.go:171","msg":"trace[1548823753] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:16172; }","duration":"517.700473ms","start":"2026-08-19T21:03:46.275314Z","end":"2026-08-19T21:03:46.793015Z","steps":["trace[1548823753] 'agreement among raft nodes before linearized reading'  (duration: 517.636622ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.793063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:46.275292Z","time spent":"517.763903ms","remote":"127.0.0.1:43874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true "}
{"level":"warn","ts":"2026-08-19T21:03:46.793078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.205402418s","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-08-19T21:03:46.793128Z","caller":"traceutil/trace.go:171","msg":"trace[902832556] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:16172; }","duration":"2.205479169s","start":"2026-08-19T21:03:44.587642Z","end":"2026-08-19T21:03:46.793121Z","steps":["trace[902832556] 'agreement among raft nodes before linearized reading'  (duration: 2.205364887s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.793154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:44.58763Z","time spent":"2.20551795s","remote":"127.0.0.1:39906","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-08-19T21:03:46.793234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:44.589324Z","time spent":"2.203644706s","remote":"127.0.0.1:39906","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-08-19T21:03:46.792991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:43.857516Z","time spent":"2.935466957s","remote":"127.0.0.1:35486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "}
{"level":"warn","ts":"2026-08-19T21:03:46.793438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.332943219s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-k8zm9\" ","response":"range_response_count:1 size:20655"}
{"level":"info","ts":"2026-08-19T21:03:46.793489Z","caller":"traceutil/trace.go:171","msg":"trace[1097561402] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-k8zm9; range_end:; response_count:1; response_revision:16172; }","duration":"3.333037781s","start":"2026-08-19T21:03:43.460443Z","end":"2026-08-19T21:03:46.793481Z","steps":["trace[1097561402] 'agreement among raft nodes before linearized reading'  (duration: 3.332892728s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.793527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.90084893s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-19T21:03:46.793577Z","caller":"traceutil/trace.go:171","msg":"trace[2135766059] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:16172; }","duration":"2.900947472s","start":"2026-08-19T21:03:43.892618Z","end":"2026-08-19T21:03:46.793565Z","steps":["trace[2135766059] 'agreement among raft nodes before linearized reading'  (duration: 2.900848171s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.793616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:43.89259Z","time spent":"2.901018003s","remote":"127.0.0.1:40122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":15,"response size":30,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "}
{"level":"warn","ts":"2026-08-19T21:03:46.793559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:43.460418Z","time spent":"3.333133302s","remote":"127.0.0.1:39814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20678,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-k8zm9\" "}
{"level":"warn","ts":"2026-08-19T21:03:46.792264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.657426588s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-08-19T21:03:46.793907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.210955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-08-19T21:03:46.793929Z","caller":"traceutil/trace.go:171","msg":"trace[1336909783] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:16172; }","duration":"541.245656ms","start":"2026-08-19T21:03:46.252677Z","end":"2026-08-19T21:03:46.793923Z","steps":["trace[1336909783] 'agreement among raft nodes before linearized reading'  (duration: 540.507503ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.793954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:46.252673Z","time spent":"541.276936ms","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1698,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "}
{"level":"info","ts":"2026-08-19T21:03:46.793952Z","caller":"traceutil/trace.go:171","msg":"trace[838846710] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:16172; }","duration":"1.659133399s","start":"2026-08-19T21:03:45.134774Z","end":"2026-08-19T21:03:46.793907Z","steps":["trace[838846710] 'agreement among raft nodes before linearized reading'  (duration: 1.657401748s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.793086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.174241599s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-2tzp4\" ","response":"range_response_count:1 size:6527"}
{"level":"warn","ts":"2026-08-19T21:03:46.791757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.181837625s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"warn","ts":"2026-08-19T21:03:46.794002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:45.134765Z","time spent":"1.659223081s","remote":"127.0.0.1:39930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":12,"response size":30,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "}
{"level":"info","ts":"2026-08-19T21:03:46.794232Z","caller":"traceutil/trace.go:171","msg":"trace[1485281363] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:16172; }","duration":"2.18435378s","start":"2026-08-19T21:03:44.609807Z","end":"2026-08-19T21:03:46.794161Z","steps":["trace[1485281363] 'agreement among raft nodes before linearized reading'  (duration: 2.181502277s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.79429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:44.609774Z","time spent":"2.184504404s","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-08-19T21:03:46.793039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.130026916s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-9zk9v\" ","response":"range_response_count:1 size:22128"}
{"level":"info","ts":"2026-08-19T21:03:46.794367Z","caller":"traceutil/trace.go:171","msg":"trace[1899522748] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-9zk9v; range_end:; response_count:1; response_revision:16172; }","duration":"3.13133952s","start":"2026-08-19T21:03:43.663008Z","end":"2026-08-19T21:03:46.794348Z","steps":["trace[1899522748] 'agreement among raft nodes before linearized reading'  (duration: 3.129975695s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.794409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.076692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-19T21:03:46.794439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:43.662975Z","time spent":"3.131440022s","remote":"127.0.0.1:39814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22151,"request content":"key:\"/registry/pods/openstack/nova-compute-default-9zk9v\" "}
{"level":"info","ts":"2026-08-19T21:03:46.794462Z","caller":"traceutil/trace.go:171","msg":"trace[2139585987] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:16172; }","duration":"542.271526ms","start":"2026-08-19T21:03:46.252182Z","end":"2026-08-19T21:03:46.794453Z","steps":["trace[2139585987] 'agreement among raft nodes before linearized reading'  (duration: 542.198195ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.794493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:46.252174Z","time spent":"542.311417ms","remote":"127.0.0.1:39634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-08-19T21:03:46.792563Z","caller":"traceutil/trace.go:171","msg":"trace[1415389517] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:16172; }","duration":"1.659173s","start":"2026-08-19T21:03:45.133381Z","end":"2026-08-19T21:03:46.792554Z","steps":["trace[1415389517] 'agreement among raft nodes before linearized reading'  (duration: 1.658998206s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.792815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.263902388s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-19T21:03:46.794695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:45.133354Z","time spent":"1.66132364s","remote":"127.0.0.1:59870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "}
{"level":"info","ts":"2026-08-19T21:03:46.79473Z","caller":"traceutil/trace.go:171","msg":"trace[254706971] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:16172; }","duration":"3.265811624s","start":"2026-08-19T21:03:43.528885Z","end":"2026-08-19T21:03:46.794697Z","steps":["trace[254706971] 'agreement among raft nodes before linearized reading'  (duration: 3.263913489s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.792316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:45.693407Z","time spent":"1.098899524s","remote":"127.0.0.1:51496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true "}
{"level":"warn","ts":"2026-08-19T21:03:46.79477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:43.528872Z","time spent":"3.265886935s","remote":"127.0.0.1:39786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":0,"response size":28,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "}
{"level":"warn","ts":"2026-08-19T21:03:46.792716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.657873136s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-19T21:03:46.794971Z","caller":"traceutil/trace.go:171","msg":"trace[1247490078] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:16172; }","duration":"1.660135628s","start":"2026-08-19T21:03:45.134809Z","end":"2026-08-19T21:03:46.794944Z","steps":["trace[1247490078] 'agreement among raft nodes before linearized reading'  (duration: 1.657884186s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.795068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:45.134794Z","time spent":"1.660239939s","remote":"127.0.0.1:33344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":30,"request content":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true "}
{"level":"info","ts":"2026-08-19T21:03:46.794111Z","caller":"traceutil/trace.go:171","msg":"trace[455496792] range","detail":"{range_begin:/registry/pods/openstack/keepalived-2tzp4; range_end:; response_count:1; response_revision:16172; }","duration":"3.175286958s","start":"2026-08-19T21:03:43.618801Z","end":"2026-08-19T21:03:46.794088Z","steps":["trace[455496792] 'agreement among raft nodes before linearized reading'  (duration: 3.174249439s)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:03:46.795778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:03:43.618779Z","time spent":"3.176976229s","remote":"127.0.0.1:39814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6550,"request content":"key:\"/registry/pods/openstack/keepalived-2tzp4\" "}
{"level":"warn","ts":"2026-08-19T21:04:16.094028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.33819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:04:16.094141Z","caller":"traceutil/trace.go:171","msg":"trace[1767519208] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:16562; }","duration":"147.507513ms","start":"2026-08-19T21:04:15.946607Z","end":"2026-08-19T21:04:16.094115Z","steps":["trace[1767519208] 'count revisions from in-memory index tree'  (duration: 147.212438ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:06:51.752981Z","caller":"traceutil/trace.go:171","msg":"trace[1972144895] transaction","detail":"{read_only:false; response_revision:17626; number_of_response:1; }","duration":"202.620199ms","start":"2026-08-19T21:06:51.550316Z","end":"2026-08-19T21:06:51.752936Z","steps":["trace[1972144895] 'process raft request'  (duration: 202.408765ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:06:52.028196Z","caller":"traceutil/trace.go:171","msg":"trace[372003306] linearizableReadLoop","detail":"{readStateIndex:18223; appliedIndex:18221; }","duration":"346.197937ms","start":"2026-08-19T21:06:51.681973Z","end":"2026-08-19T21:06:52.028171Z","steps":["trace[372003306] 'read index received'  (duration: 70.85249ms)","trace[372003306] 'applied index is now lower than readState.Index'  (duration: 275.342217ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:06:52.028287Z","caller":"traceutil/trace.go:171","msg":"trace[1537478545] transaction","detail":"{read_only:false; response_revision:17627; number_of_response:1; }","duration":"474.951919ms","start":"2026-08-19T21:06:51.553305Z","end":"2026-08-19T21:06:52.028256Z","steps":["trace[1537478545] 'process raft request'  (duration: 408.580695ms)","trace[1537478545] 'compare'  (duration: 66.17023ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:06:52.028364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.36126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-19T21:06:52.028431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.138826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-08-19T21:06:52.028459Z","caller":"traceutil/trace.go:171","msg":"trace[384314321] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:17627; }","duration":"346.472282ms","start":"2026-08-19T21:06:51.681966Z","end":"2026-08-19T21:06:52.028438Z","steps":["trace[384314321] 'agreement among raft nodes before linearized reading'  (duration: 346.301949ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:06:52.028512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:06:51.681892Z","time spent":"346.610434ms","remote":"127.0.0.1:35334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "}
{"level":"warn","ts":"2026-08-19T21:06:52.028542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.015782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-08-19T21:06:52.028525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:06:51.553279Z","time spent":"475.06109ms","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:17614 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-08-19T21:06:52.028552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.630316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-08-19T21:06:52.028569Z","caller":"traceutil/trace.go:171","msg":"trace[1604662570] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17627; }","duration":"223.080353ms","start":"2026-08-19T21:06:51.805482Z","end":"2026-08-19T21:06:52.028562Z","steps":["trace[1604662570] 'agreement among raft nodes before linearized reading'  (duration: 223.006252ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:06:52.028608Z","caller":"traceutil/trace.go:171","msg":"trace[1784845335] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17627; }","duration":"209.761738ms","start":"2026-08-19T21:06:51.818828Z","end":"2026-08-19T21:06:52.02859Z","steps":["trace[1784845335] 'agreement among raft nodes before linearized reading'  (duration: 209.516053ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:06:52.028668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.092293ms","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-08-19T21:06:52.028468Z","caller":"traceutil/trace.go:171","msg":"trace[616071280] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17627; }","duration":"282.221048ms","start":"2026-08-19T21:06:51.746236Z","end":"2026-08-19T21:06:52.028457Z","steps":["trace[616071280] 'agreement among raft nodes before linearized reading'  (duration: 282.077246ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:06:52.028707Z","caller":"traceutil/trace.go:171","msg":"trace[854564408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:17627; }","duration":"223.122964ms","start":"2026-08-19T21:06:51.805569Z","end":"2026-08-19T21:06:52.028692Z","steps":["trace[854564408] 'agreement among raft nodes before linearized reading'  (duration: 223.065743ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:06:52.028596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.022511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"}
{"level":"info","ts":"2026-08-19T21:06:52.028825Z","caller":"traceutil/trace.go:171","msg":"trace[12148897] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17627; }","duration":"223.230646ms","start":"2026-08-19T21:06:51.805514Z","end":"2026-08-19T21:06:52.028744Z","steps":["trace[12148897] 'agreement among raft nodes before linearized reading'  (duration: 222.959661ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:06:52.028861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.643487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"}
{"level":"info","ts":"2026-08-19T21:06:52.02896Z","caller":"traceutil/trace.go:171","msg":"trace[2133592315] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17627; }","duration":"207.751778ms","start":"2026-08-19T21:06:51.821197Z","end":"2026-08-19T21:06:52.028949Z","steps":["trace[2133592315] 'agreement among raft nodes before linearized reading'  (duration: 207.528444ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:06:56.110437Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15353}
{"level":"info","ts":"2026-08-19T21:06:56.225487Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15353,"took":"112.041511ms","hash":2108288558,"current-db-size-bytes":58990592,"current-db-size":"59 MB","current-db-size-in-use-bytes":31961088,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-19T21:06:56.225546Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2108288558,"revision":15353,"compact-revision":13011}
{"level":"info","ts":"2026-08-19T21:10:18.061641Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5887d25060a34f1b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-19T21:10:18.074661Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-19T21:10:18.07476Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-08-19T21:11:56.118101Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17665}
{"level":"info","ts":"2026-08-19T21:11:56.217989Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17665,"took":"96.067465ms","hash":4068789515,"current-db-size-bytes":58990592,"current-db-size":"59 MB","current-db-size-in-use-bytes":34254848,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-08-19T21:11:56.218052Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4068789515,"revision":17665,"compact-revision":15353}
{"level":"warn","ts":"2026-08-19T21:12:26.150905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.407741ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5700325794298743617 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:20232 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-19T21:12:26.151057Z","caller":"traceutil/trace.go:171","msg":"trace[347301037] transaction","detail":"{read_only:false; response_revision:20241; number_of_response:1; }","duration":"325.469168ms","start":"2026-08-19T21:12:25.825551Z","end":"2026-08-19T21:12:26.15102Z","steps":["trace[347301037] 'process raft request'  (duration: 183.842573ms)","trace[347301037] 'compare'  (duration: 141.186747ms)"],"step_count":2}
{"level":"info","ts":"2026-08-19T21:12:26.15112Z","caller":"traceutil/trace.go:171","msg":"trace[1862572999] transaction","detail":"{read_only:false; response_revision:20242; number_of_response:1; }","duration":"323.743496ms","start":"2026-08-19T21:12:25.82736Z","end":"2026-08-19T21:12:26.151103Z","steps":["trace[1862572999] 'process raft request'  (duration: 323.670484ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:12:26.151138Z","caller":"traceutil/trace.go:171","msg":"trace[1672540092] linearizableReadLoop","detail":"{readStateIndex:20925; appliedIndex:20924; }","duration":"323.808337ms","start":"2026-08-19T21:12:25.827301Z","end":"2026-08-19T21:12:26.151109Z","steps":["trace[1672540092] 'read index received'  (duration: 182.10688ms)","trace[1672540092] 'applied index is now lower than readState.Index'  (duration: 141.699257ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:12:26.151192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:12:25.825521Z","time spent":"325.60039ms","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:20232 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-08-19T21:12:26.151196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:12:25.82734Z","time spent":"323.823967ms","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:20233 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"warn","ts":"2026-08-19T21:12:26.151419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.077873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"warn","ts":"2026-08-19T21:12:26.151444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.797123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"}
{"level":"info","ts":"2026-08-19T21:12:26.151465Z","caller":"traceutil/trace.go:171","msg":"trace[525026258] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20242; }","duration":"324.206825ms","start":"2026-08-19T21:12:25.827247Z","end":"2026-08-19T21:12:26.151454Z","steps":["trace[525026258] 'agreement among raft nodes before linearized reading'  (duration: 324.004711ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:12:26.1515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:12:25.827228Z","time spent":"324.263286ms","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-08-19T21:12:26.151547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.003601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:12:26.151581Z","caller":"traceutil/trace.go:171","msg":"trace[1732637612] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:20242; }","duration":"315.046401ms","start":"2026-08-19T21:12:25.836522Z","end":"2026-08-19T21:12:26.151569Z","steps":["trace[1732637612] 'agreement among raft nodes before linearized reading'  (duration: 314.98427ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:12:26.151615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:12:25.836516Z","time spent":"315.090662ms","remote":"127.0.0.1:35338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "}
{"level":"info","ts":"2026-08-19T21:12:26.151483Z","caller":"traceutil/trace.go:171","msg":"trace[1612442464] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20242; }","duration":"318.849603ms","start":"2026-08-19T21:12:25.832618Z","end":"2026-08-19T21:12:26.151468Z","steps":["trace[1612442464] 'agreement among raft nodes before linearized reading'  (duration: 318.734421ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:12:26.151706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:12:25.832609Z","time spent":"319.086017ms","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-08-19T21:12:26.151817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.832133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:12:26.151862Z","caller":"traceutil/trace.go:171","msg":"trace[912789695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20242; }","duration":"318.885524ms","start":"2026-08-19T21:12:25.832964Z","end":"2026-08-19T21:12:26.15185Z","steps":["trace[912789695] 'agreement among raft nodes before linearized reading'  (duration: 318.820183ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:12:26.151889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:12:25.832959Z","time spent":"318.923755ms","remote":"127.0.0.1:39628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-08-19T21:12:26.470565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.601842ms","expected-duration":"100ms","prefix":"","request":"header:<ID:5700325794298743622 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:20235 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:18"}
{"level":"info","ts":"2026-08-19T21:12:26.470717Z","caller":"traceutil/trace.go:171","msg":"trace[1398376552] transaction","detail":"{read_only:false; response_revision:20244; number_of_response:1; }","duration":"313.538463ms","start":"2026-08-19T21:12:26.157164Z","end":"2026-08-19T21:12:26.470703Z","steps":["trace[1398376552] 'process raft request'  (duration: 313.497422ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:12:26.470781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:12:26.157134Z","time spent":"313.613004ms","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:20234 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-08-19T21:12:26.470958Z","caller":"traceutil/trace.go:171","msg":"trace[62604002] transaction","detail":"{read_only:false; response_revision:20243; number_of_response:1; }","duration":"314.42884ms","start":"2026-08-19T21:12:26.156465Z","end":"2026-08-19T21:12:26.470894Z","steps":["trace[62604002] 'process raft request'  (duration: 151.41163ms)","trace[62604002] 'compare'  (duration: 162.450209ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:12:26.471244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-19T21:12:26.156445Z","time spent":"314.729115ms","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:20235 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:463 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-08-19T21:12:26.934615Z","caller":"traceutil/trace.go:171","msg":"trace[570199078] transaction","detail":"{read_only:false; response_revision:20245; number_of_response:1; }","duration":"122.100826ms","start":"2026-08-19T21:12:26.812461Z","end":"2026-08-19T21:12:26.934561Z","steps":["trace[570199078] 'process raft request'  (duration: 121.947923ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:12:27.228298Z","caller":"traceutil/trace.go:171","msg":"trace[1952302028] transaction","detail":"{read_only:false; response_revision:20246; number_of_response:1; }","duration":"211.626007ms","start":"2026-08-19T21:12:27.016644Z","end":"2026-08-19T21:12:27.22827Z","steps":["trace[1952302028] 'process raft request'  (duration: 211.420023ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:12:27.509525Z","caller":"traceutil/trace.go:171","msg":"trace[2078500568] transaction","detail":"{read_only:false; response_revision:20247; number_of_response:1; }","duration":"227.932876ms","start":"2026-08-19T21:12:27.281563Z","end":"2026-08-19T21:12:27.509496Z","steps":["trace[2078500568] 'process raft request'  (duration: 152.661344ms)","trace[2078500568] 'compare'  (duration: 74.956465ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-19T21:16:04.470969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.785937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:16:04.471049Z","caller":"traceutil/trace.go:171","msg":"trace[1483733176] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:22479; }","duration":"133.926399ms","start":"2026-08-19T21:16:04.337108Z","end":"2026-08-19T21:16:04.471035Z","steps":["trace[1483733176] 'count revisions from in-memory index tree'  (duration: 133.688045ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:16:04.471044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.641047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" limit:500 ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-08-19T21:16:04.47104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.509067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:16:04.471208Z","caller":"traceutil/trace.go:171","msg":"trace[905293593] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:22479; }","duration":"120.779361ms","start":"2026-08-19T21:16:04.350403Z","end":"2026-08-19T21:16:04.471182Z","steps":["trace[905293593] 'count revisions from in-memory index tree'  (duration: 120.407574ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:16:04.471135Z","caller":"traceutil/trace.go:171","msg":"trace[781620419] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:22479; }","duration":"112.78914ms","start":"2026-08-19T21:16:04.358322Z","end":"2026-08-19T21:16:04.471111Z","steps":["trace[781620419] 'range keys from in-memory index tree'  (duration: 112.505215ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:16:04.471354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.101912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" limit:10000 ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:16:04.471436Z","caller":"traceutil/trace.go:171","msg":"trace[2029769513] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:22479; }","duration":"135.232955ms","start":"2026-08-19T21:16:04.336186Z","end":"2026-08-19T21:16:04.471419Z","steps":["trace[2029769513] 'range keys from in-memory index tree'  (duration: 135.015851ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-19T21:16:04.471357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.004756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" limit:10000 ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-19T21:16:04.471487Z","caller":"traceutil/trace.go:171","msg":"trace[1829969405] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:22479; }","duration":"121.18704ms","start":"2026-08-19T21:16:04.350288Z","end":"2026-08-19T21:16:04.471475Z","steps":["trace[1829969405] 'range keys from in-memory index tree'  (duration: 120.889865ms)"],"step_count":1}
{"level":"info","ts":"2026-08-19T21:16:56.124913Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20090}
{"level":"info","ts":"2026-08-19T21:16:56.233155Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20090,"took":"104.423325ms","hash":2047489784,"current-db-size-bytes":58990592,"current-db-size":"59 MB","current-db-size-in-use-bytes":42446848,"current-db-size-in-use":"42 MB"}
{"level":"info","ts":"2026-08-19T21:16:56.233234Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2047489784,"revision":20090,"compact-revision":17665}
{"level":"info","ts":"2026-08-19T21:21:56.130786Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23091}
{"level":"info","ts":"2026-08-19T21:21:56.262995Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23091,"took":"128.666915ms","hash":3257409884,"current-db-size-bytes":58990592,"current-db-size":"59 MB","current-db-size-in-use-bytes":31703040,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-19T21:21:56.26317Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3257409884,"revision":23091,"compact-revision":20090}