{"level":"warn","ts":"2026-03-29T01:55:10.59334Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-29T01:55:10.593429Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.44:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.44:2380","--initial-cluster=instance=https://199.204.45.44:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.44:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.44: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-03-29T01:55:10.593486Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-29T01:55:10.593499Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.44:2380"]} {"level":"info","ts":"2026-03-29T01:55:10.593517Z","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-03-29T01:55:10.594041Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.44:2379"]} {"level":"info","ts":"2026-03-29T01:55:10.59411Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.44:2380"],"listen-peer-urls":["https://199.204.45.44:2380"],"advertise-client-urls":["https://199.204.45.44:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.44:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.44: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-03-29T01:55:10.597716Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.404613ms"} {"level":"info","ts":"2026-03-29T01:55:10.605392Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a0a01fc7fbf6be45","cluster-id":"92fa3fee501eaaec"} {"level":"info","ts":"2026-03-29T01:55:10.605537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 switched to configuration voters=()"} {"level":"info","ts":"2026-03-29T01:55:10.605573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became follower at term 0"} {"level":"info","ts":"2026-03-29T01:55:10.605589Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a0a01fc7fbf6be45 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-29T01:55:10.605613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became follower at term 1"} {"level":"info","ts":"2026-03-29T01:55:10.605666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 switched to configuration voters=(11574285986128379461)"} {"level":"warn","ts":"2026-03-29T01:55:10.613581Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-29T01:55:10.615294Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-29T01:55:10.616565Z","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-03-29T01:55:10.621206Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a0a01fc7fbf6be45","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-29T01:55:10.6214Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a0a01fc7fbf6be45","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-29T01:55:10.621434Z","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-03-29T01:55:10.621524Z","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-03-29T01:55:10.621538Z","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-03-29T01:55:10.622273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 switched to configuration voters=(11574285986128379461)"} {"level":"info","ts":"2026-03-29T01:55:10.622394Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"92fa3fee501eaaec","local-member-id":"a0a01fc7fbf6be45","added-peer-id":"a0a01fc7fbf6be45","added-peer-peer-urls":["https://199.204.45.44:2380"]} {"level":"info","ts":"2026-03-29T01:55:10.624489Z","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-03-29T01:55:10.624615Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.44:2380"} {"level":"info","ts":"2026-03-29T01:55:10.624654Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.44:2380"} {"level":"info","ts":"2026-03-29T01:55:10.62527Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a0a01fc7fbf6be45","initial-advertise-peer-urls":["https://199.204.45.44:2380"],"listen-peer-urls":["https://199.204.45.44:2380"],"advertise-client-urls":["https://199.204.45.44:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.44:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-29T01:55:10.625356Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-29T01:55:10.905952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 is starting a new election at term 1"} {"level":"info","ts":"2026-03-29T01:55:10.906101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-29T01:55:10.906152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 received MsgPreVoteResp from a0a01fc7fbf6be45 at term 1"} {"level":"info","ts":"2026-03-29T01:55:10.906197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became candidate at term 2"} {"level":"info","ts":"2026-03-29T01:55:10.906246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 received MsgVoteResp from a0a01fc7fbf6be45 at term 2"} {"level":"info","ts":"2026-03-29T01:55:10.906285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0a01fc7fbf6be45 became leader at term 2"} {"level":"info","ts":"2026-03-29T01:55:10.906324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a0a01fc7fbf6be45 elected leader a0a01fc7fbf6be45 at term 2"} {"level":"info","ts":"2026-03-29T01:55:10.907329Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-29T01:55:10.908104Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-29T01:55:10.9081Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a0a01fc7fbf6be45","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.44:2379]}","request-path":"/0/members/a0a01fc7fbf6be45/attributes","cluster-id":"92fa3fee501eaaec","publish-timeout":"7s"} {"level":"info","ts":"2026-03-29T01:55:10.908161Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-29T01:55:10.908528Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-29T01:55:10.909071Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-29T01:55:10.90926Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"92fa3fee501eaaec","local-member-id":"a0a01fc7fbf6be45","cluster-version":"3.5"} {"level":"info","ts":"2026-03-29T01:55:10.909483Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-29T01:55:10.909553Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-29T01:55:10.913308Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.44:2379"} {"level":"info","ts":"2026-03-29T01:55:10.914191Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-29T01:55:46.86283Z","caller":"traceutil/trace.go:171","msg":"trace[1762483944] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"156.776274ms","start":"2026-03-29T01:55:46.706014Z","end":"2026-03-29T01:55:46.86279Z","steps":["trace[1762483944] 'process raft request' (duration: 152.923542ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T01:55:47.071116Z","caller":"traceutil/trace.go:171","msg":"trace[1222155408] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"110.125957ms","start":"2026-03-29T01:55:46.96096Z","end":"2026-03-29T01:55:47.071086Z","steps":["trace[1222155408] 'read index received' (duration: 109.43268ms)","trace[1222155408] 'applied index is now lower than readState.Index' (duration: 692.587µs)"],"step_count":2} {"level":"info","ts":"2026-03-29T01:55:47.071171Z","caller":"traceutil/trace.go:171","msg":"trace[938948541] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"124.43401ms","start":"2026-03-29T01:55:46.946712Z","end":"2026-03-29T01:55:47.071146Z","steps":["trace[938948541] 'process raft request' (duration: 123.896607ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T01:55:47.071342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.361374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-29T01:55:47.071473Z","caller":"traceutil/trace.go:171","msg":"trace[958308986] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:617; }","duration":"110.576898ms","start":"2026-03-29T01:55:46.960875Z","end":"2026-03-29T01:55:47.071452Z","steps":["trace[958308986] 'agreement among raft nodes before linearized reading' (duration: 110.363643ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T01:55:47.536149Z","caller":"traceutil/trace.go:171","msg":"trace[955029675] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"402.575ms","start":"2026-03-29T01:55:47.133548Z","end":"2026-03-29T01:55:47.536123Z","steps":["trace[955029675] 'process raft request' (duration: 393.782989ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T01:55:47.536776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-29T01:55:47.133522Z","time spent":"402.696623ms","remote":"127.0.0.1:35844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-29T01:57:19.172165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.11156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-29T01:57:19.172237Z","caller":"traceutil/trace.go:171","msg":"trace[1062278301] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1835; }","duration":"209.255863ms","start":"2026-03-29T01:57:18.962966Z","end":"2026-03-29T01:57:19.172222Z","steps":["trace[1062278301] 'range keys from in-memory index tree' (duration: 209.000267ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T01:57:19.172635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.704308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-29T01:57:19.172719Z","caller":"traceutil/trace.go:171","msg":"trace[1769428448] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1835; }","duration":"241.849252ms","start":"2026-03-29T01:57:18.930853Z","end":"2026-03-29T01:57:19.172702Z","steps":["trace[1769428448] 'count revisions from in-memory index tree' (duration: 241.575784ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T01:57:19.291405Z","caller":"traceutil/trace.go:171","msg":"trace[1356824453] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"115.538947ms","start":"2026-03-29T01:57:19.175836Z","end":"2026-03-29T01:57:19.291375Z","steps":["trace[1356824453] 'process raft request' (duration: 115.272711ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T01:57:19.449952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.837326ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-03-29T01:57:19.450378Z","caller":"traceutil/trace.go:171","msg":"trace[1196233347] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"154.516057ms","start":"2026-03-29T01:57:19.295828Z","end":"2026-03-29T01:57:19.450344Z","steps":["trace[1196233347] 'process raft request' (duration: 154.23098ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T01:58:01.84731Z","caller":"traceutil/trace.go:171","msg":"trace[2116938787] linearizableReadLoop","detail":"{readStateIndex:2243; appliedIndex:2242; }","duration":"185.014903ms","start":"2026-03-29T01:58:01.662271Z","end":"2026-03-29T01:58:01.847286Z","steps":["trace[2116938787] 'read index received' (duration: 163.616566ms)","trace[2116938787] 'applied index is now lower than readState.Index' (duration: 21.397367ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T01:58:01.847396Z","caller":"traceutil/trace.go:171","msg":"trace[723669876] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"199.910156ms","start":"2026-03-29T01:58:01.647459Z","end":"2026-03-29T01:58:01.847369Z","steps":["trace[723669876] 'process raft request' (duration: 178.479668ms)","trace[723669876] 'compare' (duration: 21.250224ms)"],"step_count":2} {"level":"warn","ts":"2026-03-29T01:58:01.847566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.275659ms","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-03-29T01:58:01.847606Z","caller":"traceutil/trace.go:171","msg":"trace[1138455585] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2174; }","duration":"185.349981ms","start":"2026-03-29T01:58:01.662246Z","end":"2026-03-29T01:58:01.847596Z","steps":["trace[1138455585] 'agreement among raft nodes before linearized reading' (duration: 185.180317ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T01:58:01.848032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.405497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-03-29T01:58:01.84812Z","caller":"traceutil/trace.go:171","msg":"trace[1467059201] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2174; }","duration":"181.52688ms","start":"2026-03-29T01:58:01.66658Z","end":"2026-03-29T01:58:01.848107Z","steps":["trace[1467059201] 'agreement among raft nodes before linearized reading' (duration: 181.13348ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T01:58:46.766235Z","caller":"traceutil/trace.go:171","msg":"trace[417525089] transaction","detail":"{read_only:false; response_revision:2527; number_of_response:1; }","duration":"175.929557ms","start":"2026-03-29T01:58:46.590227Z","end":"2026-03-29T01:58:46.766157Z","steps":["trace[417525089] 'process raft request' (duration: 175.739453ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T01:58:46.766344Z","caller":"traceutil/trace.go:171","msg":"trace[424025966] linearizableReadLoop","detail":"{readStateIndex:2615; appliedIndex:2614; }","duration":"162.642582ms","start":"2026-03-29T01:58:46.603664Z","end":"2026-03-29T01:58:46.766307Z","steps":["trace[424025966] 'read index received' (duration: 162.15934ms)","trace[424025966] 'applied index is now lower than readState.Index' (duration: 480.092µs)"],"step_count":2} {"level":"warn","ts":"2026-03-29T01:58:46.766565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.867427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-29T01:58:46.766611Z","caller":"traceutil/trace.go:171","msg":"trace[759447868] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:2527; }","duration":"162.98963ms","start":"2026-03-29T01:58:46.603609Z","end":"2026-03-29T01:58:46.766599Z","steps":["trace[759447868] 'agreement among raft nodes before linearized reading' (duration: 162.860577ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:01:46.681173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.810965ms","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":"warn","ts":"2026-03-29T02:01:46.681228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.497856ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-29T02:01:46.6813Z","caller":"traceutil/trace.go:171","msg":"trace[552873019] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:4662; }","duration":"110.988788ms","start":"2026-03-29T02:01:46.570292Z","end":"2026-03-29T02:01:46.681281Z","steps":["trace[552873019] 'count revisions from in-memory index tree' (duration: 110.677992ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:01:46.681355Z","caller":"traceutil/trace.go:171","msg":"trace[1727555736] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4662; }","duration":"104.66543ms","start":"2026-03-29T02:01:46.576668Z","end":"2026-03-29T02:01:46.681333Z","steps":["trace[1727555736] 'range keys from in-memory index tree' (duration: 104.481155ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:01:46.681434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.947006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/prometheus-pushgateway\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-29T02:01:46.681508Z","caller":"traceutil/trace.go:171","msg":"trace[1231392900] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/prometheus-pushgateway; range_end:; response_count:0; response_revision:4662; }","duration":"184.062979ms","start":"2026-03-29T02:01:46.497429Z","end":"2026-03-29T02:01:46.681492Z","steps":["trace[1231392900] 'range keys from in-memory index tree' (duration: 183.879885ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:01:47.023774Z","caller":"traceutil/trace.go:171","msg":"trace[943629964] transaction","detail":"{read_only:false; response_revision:4671; number_of_response:1; }","duration":"183.199769ms","start":"2026-03-29T02:01:46.840553Z","end":"2026-03-29T02:01:47.023753Z","steps":["trace[943629964] 'process raft request' (duration: 122.296117ms)","trace[943629964] 'compare' (duration: 60.784709ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:01:47.055984Z","caller":"traceutil/trace.go:171","msg":"trace[458943355] transaction","detail":"{read_only:false; response_revision:4672; number_of_response:1; }","duration":"188.215037ms","start":"2026-03-29T02:01:46.867745Z","end":"2026-03-29T02:01:47.05596Z","steps":["trace[458943355] 'process raft request' (duration: 188.031773ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:01:47.056265Z","caller":"traceutil/trace.go:171","msg":"trace[1421786296] transaction","detail":"{read_only:false; response_revision:4673; number_of_response:1; }","duration":"188.077854ms","start":"2026-03-29T02:01:46.868152Z","end":"2026-03-29T02:01:47.05623Z","steps":["trace[1421786296] 'process raft request' (duration: 187.757716ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:01:47.05662Z","caller":"traceutil/trace.go:171","msg":"trace[1543825976] transaction","detail":"{read_only:false; response_revision:4674; number_of_response:1; }","duration":"188.348241ms","start":"2026-03-29T02:01:46.868261Z","end":"2026-03-29T02:01:47.056609Z","steps":["trace[1543825976] 'process raft request' (duration: 187.898409ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:01:47.056795Z","caller":"traceutil/trace.go:171","msg":"trace[1024148815] linearizableReadLoop","detail":"{readStateIndex:4869; appliedIndex:4864; }","duration":"188.410512ms","start":"2026-03-29T02:01:46.868366Z","end":"2026-03-29T02:01:47.056777Z","steps":["trace[1024148815] 'read index received' (duration: 94.403066ms)","trace[1024148815] 'applied index is now lower than readState.Index' (duration: 94.006316ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:01:47.056899Z","caller":"traceutil/trace.go:171","msg":"trace[622975188] transaction","detail":"{read_only:false; response_revision:4675; number_of_response:1; }","duration":"188.569916ms","start":"2026-03-29T02:01:46.868321Z","end":"2026-03-29T02:01:47.056891Z","steps":["trace[622975188] 'process raft request' (duration: 188.246119ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:01:47.057095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.706759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-03-29T02:01:47.057924Z","caller":"traceutil/trace.go:171","msg":"trace[554446805] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4675; }","duration":"189.545169ms","start":"2026-03-29T02:01:46.868358Z","end":"2026-03-29T02:01:47.057904Z","steps":["trace[554446805] 'agreement among raft nodes before linearized reading' (duration: 188.538155ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:01:47.083865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.746416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-29T02:01:47.083945Z","caller":"traceutil/trace.go:171","msg":"trace[957851056] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4679; }","duration":"119.879169ms","start":"2026-03-29T02:01:46.964048Z","end":"2026-03-29T02:01:47.083928Z","steps":["trace[957851056] 'agreement among raft nodes before linearized reading' (duration: 119.749686ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:01:47.084056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.796476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:660"} {"level":"info","ts":"2026-03-29T02:01:47.084134Z","caller":"traceutil/trace.go:171","msg":"trace[1618597297] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4679; }","duration":"146.97395ms","start":"2026-03-29T02:01:46.937129Z","end":"2026-03-29T02:01:47.084103Z","steps":["trace[1618597297] 'agreement among raft nodes before linearized reading' (duration: 146.786965ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:01:47.261673Z","caller":"traceutil/trace.go:171","msg":"trace[700702850] transaction","detail":"{read_only:false; response_revision:4680; number_of_response:1; }","duration":"173.072358ms","start":"2026-03-29T02:01:47.088554Z","end":"2026-03-29T02:01:47.261626Z","steps":["trace[700702850] 'process raft request' (duration: 93.311349ms)","trace[700702850] 'compare' (duration: 79.503073ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:01:47.263021Z","caller":"traceutil/trace.go:171","msg":"trace[2077775062] transaction","detail":"{read_only:false; response_revision:4681; number_of_response:1; }","duration":"173.439197ms","start":"2026-03-29T02:01:47.089551Z","end":"2026-03-29T02:01:47.262991Z","steps":["trace[2077775062] 'process raft request' (duration: 173.012967ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:01:47.2631Z","caller":"traceutil/trace.go:171","msg":"trace[1963027303] transaction","detail":"{read_only:false; response_revision:4682; number_of_response:1; }","duration":"172.798151ms","start":"2026-03-29T02:01:47.090269Z","end":"2026-03-29T02:01:47.263067Z","steps":["trace[1963027303] 'process raft request' (duration: 172.566415ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:01:47.263319Z","caller":"traceutil/trace.go:171","msg":"trace[1446796652] transaction","detail":"{read_only:false; response_revision:4683; number_of_response:1; }","duration":"172.957235ms","start":"2026-03-29T02:01:47.090342Z","end":"2026-03-29T02:01:47.263299Z","steps":["trace[1446796652] 'process raft request' (duration: 172.592987ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:01:47.263276Z","caller":"traceutil/trace.go:171","msg":"trace[1305815325] transaction","detail":"{read_only:false; response_revision:4684; number_of_response:1; }","duration":"171.221084ms","start":"2026-03-29T02:01:47.091987Z","end":"2026-03-29T02:01:47.263208Z","steps":["trace[1305815325] 'process raft request' (duration: 171.112782ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:01:53.987517Z","caller":"traceutil/trace.go:171","msg":"trace[1815022408] linearizableReadLoop","detail":"{readStateIndex:4987; appliedIndex:4985; }","duration":"118.050696ms","start":"2026-03-29T02:01:53.869445Z","end":"2026-03-29T02:01:53.987496Z","steps":["trace[1815022408] 'read index received' (duration: 38.700426ms)","trace[1815022408] 'applied index is now lower than readState.Index' (duration: 79.34957ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:01:53.987576Z","caller":"traceutil/trace.go:171","msg":"trace[259566128] transaction","detail":"{read_only:false; response_revision:4790; number_of_response:1; }","duration":"129.21037ms","start":"2026-03-29T02:01:53.858342Z","end":"2026-03-29T02:01:53.987553Z","steps":["trace[259566128] 'process raft request' (duration: 129.044786ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:01:53.987666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.210889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/memcached-metrics\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-29T02:01:53.987694Z","caller":"traceutil/trace.go:171","msg":"trace[762556634] range","detail":"{range_begin:/registry/services/specs/openstack/memcached-metrics; range_end:; response_count:0; response_revision:4790; }","duration":"118.2776ms","start":"2026-03-29T02:01:53.86941Z","end":"2026-03-29T02:01:53.987687Z","steps":["trace[762556634] 'agreement among raft nodes before linearized reading' (duration: 118.212039ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:01:54.013045Z","caller":"traceutil/trace.go:171","msg":"trace[1787996444] transaction","detail":"{read_only:false; response_revision:4791; number_of_response:1; }","duration":"100.094741ms","start":"2026-03-29T02:01:53.91292Z","end":"2026-03-29T02:01:54.013015Z","steps":["trace[1787996444] 'process raft request' (duration: 79.701948ms)","trace[1787996444] 'compare' (duration: 19.864861ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:02:03.072224Z","caller":"traceutil/trace.go:171","msg":"trace[619431001] linearizableReadLoop","detail":"{readStateIndex:5156; appliedIndex:5155; }","duration":"109.39207ms","start":"2026-03-29T02:02:02.962804Z","end":"2026-03-29T02:02:03.072196Z","steps":["trace[619431001] 'read index received' (duration: 92.499901ms)","trace[619431001] 'applied index is now lower than readState.Index' (duration: 16.891059ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:02:03.072289Z","caller":"traceutil/trace.go:171","msg":"trace[744552231] transaction","detail":"{read_only:false; response_revision:4955; number_of_response:1; }","duration":"117.123004ms","start":"2026-03-29T02:02:02.955142Z","end":"2026-03-29T02:02:03.072265Z","steps":["trace[744552231] 'process raft request' (duration: 100.186403ms)","trace[744552231] 'compare' (duration: 16.751907ms)"],"step_count":2} {"level":"warn","ts":"2026-03-29T02:02:03.072471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.574655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-29T02:02:03.072518Z","caller":"traceutil/trace.go:171","msg":"trace[514413697] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4955; }","duration":"109.747109ms","start":"2026-03-29T02:02:02.962759Z","end":"2026-03-29T02:02:03.072506Z","steps":["trace[514413697] 'agreement among raft nodes before linearized reading' (duration: 109.590355ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:02:24.103438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.24952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-29T02:02:24.103533Z","caller":"traceutil/trace.go:171","msg":"trace[1445296190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5185; }","duration":"140.405523ms","start":"2026-03-29T02:02:23.963101Z","end":"2026-03-29T02:02:24.103506Z","steps":["trace[1445296190] 'range keys from in-memory index tree' (duration: 140.113077ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:02:24.103514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.901575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-29T02:02:24.103914Z","caller":"traceutil/trace.go:171","msg":"trace[631442170] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:5185; }","duration":"266.347055ms","start":"2026-03-29T02:02:23.837545Z","end":"2026-03-29T02:02:24.103892Z","steps":["trace[631442170] 'count revisions from in-memory index tree' (duration: 265.795092ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:02:24.104044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.751372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-03-29T02:02:24.104084Z","caller":"traceutil/trace.go:171","msg":"trace[542609098] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:5185; }","duration":"102.789722ms","start":"2026-03-29T02:02:24.001279Z","end":"2026-03-29T02:02:24.104069Z","steps":["trace[542609098] 'count revisions from in-memory index tree' (duration: 102.662069ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:02:24.223732Z","caller":"traceutil/trace.go:171","msg":"trace[426353742] transaction","detail":"{read_only:false; response_revision:5186; number_of_response:1; }","duration":"114.875549ms","start":"2026-03-29T02:02:24.108799Z","end":"2026-03-29T02:02:24.223674Z","steps":["trace[426353742] 'process raft request' (duration: 100.483118ms)","trace[426353742] 'compare' (duration: 14.120665ms)"],"step_count":2} {"level":"warn","ts":"2026-03-29T02:02:24.2238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.433134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:525"} {"level":"info","ts":"2026-03-29T02:02:24.223896Z","caller":"traceutil/trace.go:171","msg":"trace[515358463] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:5186; }","duration":"110.567277ms","start":"2026-03-29T02:02:24.113306Z","end":"2026-03-29T02:02:24.223873Z","steps":["trace[515358463] 'agreement among raft nodes before linearized reading' (duration: 110.28054ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:03:10.290909Z","caller":"traceutil/trace.go:171","msg":"trace[283409248] transaction","detail":"{read_only:false; response_revision:5656; number_of_response:1; }","duration":"105.770753ms","start":"2026-03-29T02:03:10.185111Z","end":"2026-03-29T02:03:10.290882Z","steps":["trace[283409248] 'process raft request' (duration: 105.63938ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:03:10.309512Z","caller":"traceutil/trace.go:171","msg":"trace[1168206015] transaction","detail":"{read_only:false; response_revision:5657; number_of_response:1; }","duration":"121.23429ms","start":"2026-03-29T02:03:10.188257Z","end":"2026-03-29T02:03:10.309491Z","steps":["trace[1168206015] 'process raft request' (duration: 121.122178ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:03:10.696992Z","caller":"traceutil/trace.go:171","msg":"trace[1248542218] transaction","detail":"{read_only:false; response_revision:5661; number_of_response:1; }","duration":"118.135496ms","start":"2026-03-29T02:03:10.578816Z","end":"2026-03-29T02:03:10.696951Z","steps":["trace[1248542218] 'process raft request' (duration: 55.975115ms)","trace[1248542218] 'compare' (duration: 61.974277ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:05:11.046471Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3278} {"level":"info","ts":"2026-03-29T02:05:11.137583Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3278,"took":"89.623544ms","hash":232426266,"current-db-size-bytes":60407808,"current-db-size":"60 MB","current-db-size-in-use-bytes":33689600,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-03-29T02:05:11.13768Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":232426266,"revision":3278,"compact-revision":-1} {"level":"info","ts":"2026-03-29T02:08:10.23036Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000021db.wal"} {"level":"info","ts":"2026-03-29T02:08:14.248333Z","caller":"traceutil/trace.go:171","msg":"trace[532183959] linearizableReadLoop","detail":"{readStateIndex:8692; appliedIndex:8691; }","duration":"186.274181ms","start":"2026-03-29T02:08:14.062033Z","end":"2026-03-29T02:08:14.248307Z","steps":["trace[532183959] 'read index received' (duration: 186.131468ms)","trace[532183959] 'applied index is now lower than readState.Index' (duration: 141.823µs)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:08:14.248414Z","caller":"traceutil/trace.go:171","msg":"trace[1361974334] transaction","detail":"{read_only:false; response_revision:8327; number_of_response:1; }","duration":"219.477377ms","start":"2026-03-29T02:08:14.028897Z","end":"2026-03-29T02:08:14.248374Z","steps":["trace[1361974334] 'process raft request' (duration: 219.259262ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:08:14.248562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.514177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.44\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-03-29T02:08:14.248618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.720402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-03-29T02:08:14.24864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.728842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-29T02:08:14.248701Z","caller":"traceutil/trace.go:171","msg":"trace[1255109603] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8327; }","duration":"178.853175ms","start":"2026-03-29T02:08:14.069821Z","end":"2026-03-29T02:08:14.248674Z","steps":["trace[1255109603] 'agreement among raft nodes before linearized reading' (duration: 178.627849ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:08:14.248705Z","caller":"traceutil/trace.go:171","msg":"trace[169610018] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:8327; }","duration":"107.837225ms","start":"2026-03-29T02:08:14.140853Z","end":"2026-03-29T02:08:14.24869Z","steps":["trace[169610018] 'agreement among raft nodes before linearized reading' (duration: 107.707742ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:08:14.248761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.941291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:525"} {"level":"info","ts":"2026-03-29T02:08:14.248635Z","caller":"traceutil/trace.go:171","msg":"trace[863945864] range","detail":"{range_begin:/registry/masterleases/199.204.45.44; range_end:; response_count:1; response_revision:8327; }","duration":"186.62842ms","start":"2026-03-29T02:08:14.061991Z","end":"2026-03-29T02:08:14.24862Z","steps":["trace[863945864] 'agreement among raft nodes before linearized reading' (duration: 186.434265ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:08:14.248826Z","caller":"traceutil/trace.go:171","msg":"trace[386717473] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:8327; }","duration":"166.027392ms","start":"2026-03-29T02:08:14.082779Z","end":"2026-03-29T02:08:14.248806Z","steps":["trace[386717473] 'agreement among raft nodes before linearized reading' (duration: 165.820798ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:08:25.987123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.954258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11499"} {"level":"info","ts":"2026-03-29T02:08:25.987208Z","caller":"traceutil/trace.go:171","msg":"trace[527737021] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8406; }","duration":"195.075051ms","start":"2026-03-29T02:08:25.792114Z","end":"2026-03-29T02:08:25.987189Z","steps":["trace[527737021] 'range keys from in-memory index tree' (duration: 194.739763ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:08:26.680487Z","caller":"traceutil/trace.go:171","msg":"trace[802492763] linearizableReadLoop","detail":"{readStateIndex:8781; appliedIndex:8780; }","duration":"295.506188ms","start":"2026-03-29T02:08:26.384957Z","end":"2026-03-29T02:08:26.680463Z","steps":["trace[802492763] 'read index received' (duration: 295.253993ms)","trace[802492763] 'applied index is now lower than readState.Index' (duration: 250.495µs)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:08:26.680546Z","caller":"traceutil/trace.go:171","msg":"trace[2032212953] transaction","detail":"{read_only:false; response_revision:8409; number_of_response:1; }","duration":"394.082733ms","start":"2026-03-29T02:08:26.286431Z","end":"2026-03-29T02:08:26.680514Z","steps":["trace[2032212953] 'process raft request' (duration: 393.876188ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:08:26.680701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.748524ms","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-03-29T02:08:26.680737Z","caller":"traceutil/trace.go:171","msg":"trace[1109849602] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8409; }","duration":"295.835926ms","start":"2026-03-29T02:08:26.384892Z","end":"2026-03-29T02:08:26.680728Z","steps":["trace[1109849602] 'agreement among raft nodes before linearized reading' (duration: 295.697862ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:08:26.680773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.755842ms","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-03-29T02:08:26.680833Z","caller":"traceutil/trace.go:171","msg":"trace[1546049654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8409; }","duration":"289.840714ms","start":"2026-03-29T02:08:26.390976Z","end":"2026-03-29T02:08:26.680816Z","steps":["trace[1546049654] 'agreement among raft nodes before linearized reading' (duration: 289.642579ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:08:26.680938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-29T02:08:26.286392Z","time spent":"394.215146ms","remote":"127.0.0.1:35584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-29T02:08:26.68095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.359123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-03-29T02:08:26.681028Z","caller":"traceutil/trace.go:171","msg":"trace[385975430] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:8409; }","duration":"289.458895ms","start":"2026-03-29T02:08:26.391551Z","end":"2026-03-29T02:08:26.68101Z","steps":["trace[385975430] 'agreement among raft nodes before linearized reading' (duration: 289.25633ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:08:27.490701Z","caller":"traceutil/trace.go:171","msg":"trace[1861033842] transaction","detail":"{read_only:false; response_revision:8415; number_of_response:1; }","duration":"159.649361ms","start":"2026-03-29T02:08:27.33102Z","end":"2026-03-29T02:08:27.490669Z","steps":["trace[1861033842] 'process raft request' (duration: 159.429445ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:08:57.655551Z","caller":"traceutil/trace.go:171","msg":"trace[1468754899] transaction","detail":"{read_only:false; response_revision:8669; number_of_response:1; }","duration":"245.81658ms","start":"2026-03-29T02:08:57.409713Z","end":"2026-03-29T02:08:57.65553Z","steps":["trace[1468754899] 'process raft request' (duration: 245.677907ms)"],"step_count":1} {"level":"warn","ts":"2026-03-29T02:09:10.50175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.516757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-67bbn\" ","response":"range_response_count:1 size:4609"} {"level":"warn","ts":"2026-03-29T02:09:10.501929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.371261ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-29T02:09:10.502157Z","caller":"traceutil/trace.go:171","msg":"trace[476115106] transaction","detail":"{read_only:false; response_revision:8800; number_of_response:1; }","duration":"259.696801ms","start":"2026-03-29T02:09:10.242372Z","end":"2026-03-29T02:09:10.502069Z","steps":["trace[476115106] 'process raft request' (duration: 55.101495ms)","trace[476115106] 'compare' (duration: 204.003292ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:09:10.501856Z","caller":"traceutil/trace.go:171","msg":"trace[567544301] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-67bbn; range_end:; response_count:1; response_revision:8799; }","duration":"259.680881ms","start":"2026-03-29T02:09:10.242155Z","end":"2026-03-29T02:09:10.501836Z","steps":["trace[567544301] 'range keys from in-memory index tree' (duration: 259.309172ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:09:10.636792Z","caller":"traceutil/trace.go:171","msg":"trace[1785830966] transaction","detail":"{read_only:false; response_revision:8801; number_of_response:1; }","duration":"127.003208ms","start":"2026-03-29T02:09:10.509763Z","end":"2026-03-29T02:09:10.636766Z","steps":["trace[1785830966] 'process raft request' (duration: 121.830976ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:09:12.287638Z","caller":"traceutil/trace.go:171","msg":"trace[95037357] transaction","detail":"{read_only:false; response_revision:8812; number_of_response:1; }","duration":"110.318734ms","start":"2026-03-29T02:09:12.177277Z","end":"2026-03-29T02:09:12.287596Z","steps":["trace[95037357] 'process raft request' (duration: 89.07898ms)","trace[95037357] 'compare' (duration: 20.969166ms)"],"step_count":2} {"level":"info","ts":"2026-03-29T02:09:12.474976Z","caller":"traceutil/trace.go:171","msg":"trace[1789680936] transaction","detail":"{read_only:false; response_revision:8814; number_of_response:1; }","duration":"112.72669ms","start":"2026-03-29T02:09:12.362226Z","end":"2026-03-29T02:09:12.474953Z","steps":["trace[1789680936] 'process raft request' (duration: 112.570256ms)"],"step_count":1} {"level":"info","ts":"2026-03-29T02:10:11.053042Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6578} {"level":"info","ts":"2026-03-29T02:10:11.145212Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6578,"took":"90.165304ms","hash":2099454750,"current-db-size-bytes":60407808,"current-db-size":"60 MB","current-db-size-in-use-bytes":26529792,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-03-29T02:10:11.145285Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2099454750,"revision":6578,"compact-revision":3278} {"level":"info","ts":"2026-03-29T02:10:22.991192Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a0a01fc7fbf6be45","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-03-29T02:10:22.997317Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-03-29T02:10:22.997426Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-03-29T02:15:11.059638Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":9478} {"level":"info","ts":"2026-03-29T02:15:11.147045Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":9478,"took":"85.148713ms","hash":1279827855,"current-db-size-bytes":60407808,"current-db-size":"60 MB","current-db-size-in-use-bytes":25567232,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-03-29T02:15:11.147114Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1279827855,"revision":9478,"compact-revision":6578}