{"level":"warn","ts":"2026-08-07T20:52:31.110007Z","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-07T20:52:31.110153Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205: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.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-07T20:52:31.110254Z","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-07T20:52:31.110273Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-08-07T20:52:31.110301Z","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-07T20:52:31.111254Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-08-07T20:52:31.111373Z","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.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-07T20:52:31.113806Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.103801ms"} {"level":"info","ts":"2026-08-07T20:52:31.11829Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-08-07T20:52:31.11837Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-08-07T20:52:31.118402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-08-07T20:52:31.118416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-07T20:52:31.11843Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-08-07T20:52:31.118476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-08-07T20:52:31.122824Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-07T20:52:31.124271Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-07T20:52:31.125333Z","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-07T20:52:31.128685Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-07T20:52:31.12902Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-07T20:52:31.129279Z","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-07T20:52:31.129325Z","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-07T20:52:31.129336Z","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-07T20:52:31.12978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-08-07T20:52:31.129886Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-08-07T20:52:31.134986Z","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-07T20:52:31.1353Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-07T20:52:31.135341Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-07T20:52:31.135467Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-08-07T20:52:31.135483Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-08-07T20:52:31.618806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-08-07T20:52:31.618958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-08-07T20:52:31.619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-08-07T20:52:31.619032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-08-07T20:52:31.619049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-08-07T20:52:31.619071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-08-07T20:52:31.61909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-08-07T20:52:31.620143Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-07T20:52:31.621126Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-07T20:52:31.621116Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-08-07T20:52:31.621189Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-07T20:52:31.621543Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-08-07T20:52:31.621683Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-07T20:52:31.621723Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-07T20:52:31.62187Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-07T20:52:31.622011Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-07T20:52:31.625369Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-08-07T20:52:31.625368Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-08-07T20:52:50.366524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.74607ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-07T20:53:08.567513Z","caller":"traceutil/trace.go:171","msg":"trace[1244424778] transaction","detail":"{read_only:false; number_of_response:1; response_revision:538; }","duration":"101.637782ms","start":"2026-08-07T20:53:08.465841Z","end":"2026-08-07T20:53:08.567479Z","steps":["trace[1244424778] 'process raft request' (duration: 101.1443ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:53:08.567581Z","caller":"traceutil/trace.go:171","msg":"trace[2762443] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"100.944194ms","start":"2026-08-07T20:53:08.466613Z","end":"2026-08-07T20:53:08.567557Z","steps":["trace[2762443] 'process raft request' (duration: 100.903053ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:53:08.567787Z","caller":"traceutil/trace.go:171","msg":"trace[800411540] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"101.239901ms","start":"2026-08-07T20:53:08.46653Z","end":"2026-08-07T20:53:08.56777Z","steps":["trace[800411540] 'process raft request' (duration: 100.950424ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:53:08.567861Z","caller":"traceutil/trace.go:171","msg":"trace[1950612530] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"101.391985ms","start":"2026-08-07T20:53:08.466456Z","end":"2026-08-07T20:53:08.567848Z","steps":["trace[1950612530] 'process raft request' (duration: 100.916964ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:53:08.573221Z","caller":"traceutil/trace.go:171","msg":"trace[1992871237] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"100.324929ms","start":"2026-08-07T20:53:08.472877Z","end":"2026-08-07T20:53:08.573202Z","steps":["trace[1992871237] 'process raft request' (duration: 99.067798ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:53:08.573252Z","caller":"traceutil/trace.go:171","msg":"trace[1619131509] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"103.266411ms","start":"2026-08-07T20:53:08.469946Z","end":"2026-08-07T20:53:08.573213Z","steps":["trace[1619131509] 'process raft request' (duration: 101.831346ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:53:08.573384Z","caller":"traceutil/trace.go:171","msg":"trace[1828631467] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"100.204136ms","start":"2026-08-07T20:53:08.473169Z","end":"2026-08-07T20:53:08.573374Z","steps":["trace[1828631467] 'process raft request' (duration: 98.835802ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:53:14.370768Z","caller":"traceutil/trace.go:171","msg":"trace[1314933848] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"119.744553ms","start":"2026-08-07T20:53:14.250988Z","end":"2026-08-07T20:53:14.370732Z","steps":["trace[1314933848] 'process raft request' (duration: 85.232071ms)","trace[1314933848] 'compare' (duration: 34.362958ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T20:53:14.389149Z","caller":"traceutil/trace.go:171","msg":"trace[1568817351] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"134.655267ms","start":"2026-08-07T20:53:14.254458Z","end":"2026-08-07T20:53:14.389114Z","steps":["trace[1568817351] 'process raft request' (duration: 134.485883ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T20:53:15.269319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.25802ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-07T20:53:15.269586Z","caller":"traceutil/trace.go:171","msg":"trace[868282561] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"483.38453ms","start":"2026-08-07T20:53:14.786143Z","end":"2026-08-07T20:53:15.269528Z","steps":["trace[868282561] 'process raft request' (duration: 241.27349ms)","trace[868282561] 'compare' (duration: 240.887881ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T20:53:15.26985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T20:53:14.786108Z","time spent":"483.602916ms","remote":"127.0.0.1:59430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-07T20:53:15.270507Z","caller":"traceutil/trace.go:171","msg":"trace[1827399225] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:658; }","duration":"297.056622ms","start":"2026-08-07T20:53:14.97343Z","end":"2026-08-07T20:53:15.270486Z","steps":["trace[1827399225] 'read index received' (duration: 54.06841ms)","trace[1827399225] 'applied index is now lower than readState.Index' (duration: 242.986692ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T20:53:15.27055Z","caller":"traceutil/trace.go:171","msg":"trace[416808480] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"459.418255ms","start":"2026-08-07T20:53:14.811105Z","end":"2026-08-07T20:53:15.270523Z","steps":["trace[416808480] 'process raft request' (duration: 458.618695ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T20:53:15.270677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.347793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-07T20:53:15.270689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.245738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.205\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-08-07T20:53:15.270711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T20:53:14.811039Z","time spent":"459.58916ms","remote":"127.0.0.1:59258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-07T20:53:15.270776Z","caller":"traceutil/trace.go:171","msg":"trace[757891127] range","detail":"{range_begin:/registry/masterleases/199.204.45.205; range_end:; response_count:1; response_revision:635; }","duration":"297.381101ms","start":"2026-08-07T20:53:14.973371Z","end":"2026-08-07T20:53:15.270752Z","steps":["trace[757891127] 'agreement among raft nodes before linearized reading' (duration: 297.218867ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:53:15.270718Z","caller":"traceutil/trace.go:171","msg":"trace[294618508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:635; }","duration":"266.433026ms","start":"2026-08-07T20:53:15.004271Z","end":"2026-08-07T20:53:15.270704Z","steps":["trace[294618508] 'agreement among raft nodes before linearized reading' (duration: 266.347984ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T20:53:15.271035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.653725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-07T20:53:15.271063Z","caller":"traceutil/trace.go:171","msg":"trace[587336284] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:635; }","duration":"104.720407ms","start":"2026-08-07T20:53:15.166335Z","end":"2026-08-07T20:53:15.271056Z","steps":["trace[587336284] 'agreement among raft nodes before linearized reading' (duration: 104.40682ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:53:57.885239Z","caller":"traceutil/trace.go:171","msg":"trace[681178388] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"114.356499ms","start":"2026-08-07T20:53:57.770858Z","end":"2026-08-07T20:53:57.885215Z","steps":["trace[681178388] 'process raft request' (duration: 114.190485ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T20:54:44.569846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.237029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-08-07T20:54:44.570016Z","caller":"traceutil/trace.go:171","msg":"trace[680384568] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1855; }","duration":"278.453915ms","start":"2026-08-07T20:54:44.291537Z","end":"2026-08-07T20:54:44.569991Z","steps":["trace[680384568] 'range keys from in-memory index tree' (duration: 278.047244ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T20:54:44.569862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.323302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c4c7af5b-7b87-408e-ae60-8c8b8c7df05e\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-07T20:54:44.570206Z","caller":"traceutil/trace.go:171","msg":"trace[215856091] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c4c7af5b-7b87-408e-ae60-8c8b8c7df05e; range_end:; response_count:1; response_revision:1855; }","duration":"320.686673ms","start":"2026-08-07T20:54:44.249467Z","end":"2026-08-07T20:54:44.570153Z","steps":["trace[215856091] 'range keys from in-memory index tree' (duration: 320.147338ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T20:54:44.570274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T20:54:44.249456Z","time spent":"320.803155ms","remote":"127.0.0.1:59360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c4c7af5b-7b87-408e-ae60-8c8b8c7df05e\" "} {"level":"warn","ts":"2026-08-07T20:54:44.569934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.387358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c4c7af5b-7b87-408e-ae60-8c8b8c7df05e\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-07T20:54:44.570539Z","caller":"traceutil/trace.go:171","msg":"trace[2143020980] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c4c7af5b-7b87-408e-ae60-8c8b8c7df05e; range_end:; response_count:1; response_revision:1855; }","duration":"234.042915ms","start":"2026-08-07T20:54:44.336485Z","end":"2026-08-07T20:54:44.570528Z","steps":["trace[2143020980] 'range keys from in-memory index tree' (duration: 233.155722ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:54:45.001257Z","caller":"traceutil/trace.go:171","msg":"trace[934906655] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"184.552858ms","start":"2026-08-07T20:54:44.816649Z","end":"2026-08-07T20:54:45.001202Z","steps":["trace[934906655] 'process raft request' (duration: 184.301782ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:55:28.029842Z","caller":"traceutil/trace.go:171","msg":"trace[277688488] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"128.293732ms","start":"2026-08-07T20:55:27.901514Z","end":"2026-08-07T20:55:28.029807Z","steps":["trace[277688488] 'process raft request' (duration: 110.638132ms)","trace[277688488] 'compare' (duration: 17.439734ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T20:56:23.268532Z","caller":"traceutil/trace.go:171","msg":"trace[2009969901] transaction","detail":"{read_only:false; response_revision:2620; number_of_response:1; }","duration":"130.37575ms","start":"2026-08-07T20:56:23.138127Z","end":"2026-08-07T20:56:23.268503Z","steps":["trace[2009969901] 'process raft request' (duration: 130.197436ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T20:56:57.563632Z","caller":"traceutil/trace.go:171","msg":"trace[1759272073] transaction","detail":"{read_only:false; response_revision:2825; number_of_response:1; }","duration":"100.662177ms","start":"2026-08-07T20:56:57.462938Z","end":"2026-08-07T20:56:57.5636Z","steps":["trace[1759272073] 'process raft request' (duration: 100.426091ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:00:53.537467Z","caller":"traceutil/trace.go:171","msg":"trace[1491105720] transaction","detail":"{read_only:false; response_revision:4883; number_of_response:1; }","duration":"110.865212ms","start":"2026-08-07T21:00:53.426575Z","end":"2026-08-07T21:00:53.53744Z","steps":["trace[1491105720] 'process raft request' (duration: 110.714058ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:00:53.567017Z","caller":"traceutil/trace.go:171","msg":"trace[976160776] transaction","detail":"{read_only:false; response_revision:4884; number_of_response:1; }","duration":"135.902587ms","start":"2026-08-07T21:00:53.431085Z","end":"2026-08-07T21:00:53.566988Z","steps":["trace[976160776] 'process raft request' (duration: 135.757733ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T21:01:02.675157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.392222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225408"} {"level":"info","ts":"2026-08-07T21:01:02.675302Z","caller":"traceutil/trace.go:171","msg":"trace[1554815193] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5122; }","duration":"156.567857ms","start":"2026-08-07T21:01:02.518687Z","end":"2026-08-07T21:01:02.675255Z","steps":["trace[1554815193] 'range keys from in-memory index tree' (duration: 152.25307ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:01:02.772153Z","caller":"traceutil/trace.go:171","msg":"trace[2115742937] transaction","detail":"{read_only:false; response_revision:5123; number_of_response:1; }","duration":"104.75298ms","start":"2026-08-07T21:01:02.667144Z","end":"2026-08-07T21:01:02.771897Z","steps":["trace[2115742937] 'process raft request' (duration: 104.36896ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:01:03.463647Z","caller":"traceutil/trace.go:171","msg":"trace[2109973387] transaction","detail":"{read_only:false; response_revision:5128; number_of_response:1; }","duration":"104.458852ms","start":"2026-08-07T21:01:03.359161Z","end":"2026-08-07T21:01:03.46362Z","steps":["trace[2109973387] 'process raft request' (duration: 104.309579ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:01:09.122292Z","caller":"traceutil/trace.go:171","msg":"trace[1947336899] transaction","detail":"{read_only:false; response_revision:5260; number_of_response:1; }","duration":"103.334645ms","start":"2026-08-07T21:01:09.018928Z","end":"2026-08-07T21:01:09.122262Z","steps":["trace[1947336899] 'process raft request' (duration: 88.713965ms)","trace[1947336899] 'compare' (duration: 14.223321ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T21:01:09.122441Z","caller":"traceutil/trace.go:171","msg":"trace[647778433] transaction","detail":"{read_only:false; response_revision:5261; number_of_response:1; }","duration":"103.007157ms","start":"2026-08-07T21:01:09.019413Z","end":"2026-08-07T21:01:09.12242Z","steps":["trace[647778433] 'process raft request' (duration: 102.600437ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:02:31.848543Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3013} {"level":"info","ts":"2026-08-07T21:02:31.946478Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3013,"took":"95.795497ms","hash":896953109,"current-db-size-bytes":58736640,"current-db-size":"59 MB","current-db-size-in-use-bytes":31850496,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-07T21:02:31.946583Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":896953109,"revision":3013,"compact-revision":-1} {"level":"info","ts":"2026-08-07T21:07:31.856259Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6121} {"level":"info","ts":"2026-08-07T21:07:31.96074Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6121,"took":"102.621826ms","hash":2893754168,"current-db-size-bytes":58736640,"current-db-size":"59 MB","current-db-size-in-use-bytes":23805952,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-08-07T21:07:31.96082Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2893754168,"revision":6121,"compact-revision":3013} {"level":"warn","ts":"2026-08-07T21:08:02.672007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.26671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-07T21:08:02.672079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.834085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-07T21:08:02.672167Z","caller":"traceutil/trace.go:171","msg":"trace[1102752821] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:8542; }","duration":"150.505546ms","start":"2026-08-07T21:08:02.52164Z","end":"2026-08-07T21:08:02.672146Z","steps":["trace[1102752821] 'count revisions from in-memory index tree' (duration: 150.171168ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:08:02.672219Z","caller":"traceutil/trace.go:171","msg":"trace[717412814] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8542; }","duration":"133.05325ms","start":"2026-08-07T21:08:02.539141Z","end":"2026-08-07T21:08:02.672194Z","steps":["trace[717412814] 'range keys from in-memory index tree' (duration: 132.571229ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:08:02.839252Z","caller":"traceutil/trace.go:171","msg":"trace[695409447] transaction","detail":"{read_only:false; response_revision:8543; number_of_response:1; }","duration":"157.545838ms","start":"2026-08-07T21:08:02.681674Z","end":"2026-08-07T21:08:02.83922Z","steps":["trace[695409447] 'process raft request' (duration: 157.343363ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:08:02.839738Z","caller":"traceutil/trace.go:171","msg":"trace[328713679] linearizableReadLoop","detail":"{readStateIndex:8846; appliedIndex:8846; }","duration":"115.977233ms","start":"2026-08-07T21:08:02.723719Z","end":"2026-08-07T21:08:02.839696Z","steps":["trace[328713679] 'read index received' (duration: 115.949952ms)","trace[328713679] 'applied index is now lower than readState.Index' (duration: 23.831µs)"],"step_count":2} {"level":"warn","ts":"2026-08-07T21:08:02.839927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.181878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T21:08:02.83996Z","caller":"traceutil/trace.go:171","msg":"trace[37596152] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8543; }","duration":"116.29126ms","start":"2026-08-07T21:08:02.723659Z","end":"2026-08-07T21:08:02.83995Z","steps":["trace[37596152] 'agreement among raft nodes before linearized reading' (duration: 116.178768ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:08:04.28559Z","caller":"traceutil/trace.go:171","msg":"trace[556477165] transaction","detail":"{read_only:false; response_revision:8549; number_of_response:1; }","duration":"113.293268ms","start":"2026-08-07T21:08:04.172249Z","end":"2026-08-07T21:08:04.285543Z","steps":["trace[556477165] 'process raft request' (duration: 39.750891ms)","trace[556477165] 'compare' (duration: 73.26135ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T21:08:14.889899Z","caller":"traceutil/trace.go:171","msg":"trace[1811118988] linearizableReadLoop","detail":"{readStateIndex:8954; appliedIndex:8953; }","duration":"144.091258ms","start":"2026-08-07T21:08:14.745775Z","end":"2026-08-07T21:08:14.889866Z","steps":["trace[1811118988] 'read index received' (duration: 143.797961ms)","trace[1811118988] 'applied index is now lower than readState.Index' (duration: 292.207µs)"],"step_count":2} {"level":"warn","ts":"2026-08-07T21:08:14.890229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.385986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-2lmg2\" ","response":"range_response_count:1 size:2803"} {"level":"info","ts":"2026-08-07T21:08:14.890271Z","caller":"traceutil/trace.go:171","msg":"trace[1764124975] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-2lmg2; range_end:; response_count:1; response_revision:8646; }","duration":"144.53358ms","start":"2026-08-07T21:08:14.745721Z","end":"2026-08-07T21:08:14.890255Z","steps":["trace[1764124975] 'agreement among raft nodes before linearized reading' (duration: 144.271393ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:08:14.890513Z","caller":"traceutil/trace.go:171","msg":"trace[765924621] transaction","detail":"{read_only:false; response_revision:8646; number_of_response:1; }","duration":"160.92607ms","start":"2026-08-07T21:08:14.729576Z","end":"2026-08-07T21:08:14.890502Z","steps":["trace[765924621] 'process raft request' (duration: 160.034358ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:08:15.6748Z","caller":"traceutil/trace.go:171","msg":"trace[450194076] linearizableReadLoop","detail":"{readStateIndex:8963; appliedIndex:8962; }","duration":"114.27231ms","start":"2026-08-07T21:08:15.56049Z","end":"2026-08-07T21:08:15.674762Z","steps":["trace[450194076] 'read index received' (duration: 114.011014ms)","trace[450194076] 'applied index is now lower than readState.Index' (duration: 259.736µs)"],"step_count":2} {"level":"info","ts":"2026-08-07T21:08:15.674862Z","caller":"traceutil/trace.go:171","msg":"trace[1389350394] transaction","detail":"{read_only:false; response_revision:8654; number_of_response:1; }","duration":"114.903277ms","start":"2026-08-07T21:08:15.559933Z","end":"2026-08-07T21:08:15.674836Z","steps":["trace[1389350394] 'process raft request' (duration: 114.60392ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T21:08:15.675183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.600519ms","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-07T21:08:15.675265Z","caller":"traceutil/trace.go:171","msg":"trace[175785962] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8654; }","duration":"114.791793ms","start":"2026-08-07T21:08:15.560451Z","end":"2026-08-07T21:08:15.675243Z","steps":["trace[175785962] 'agreement among raft nodes before linearized reading' (duration: 114.466125ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:08:16.633335Z","caller":"traceutil/trace.go:171","msg":"trace[980221871] transaction","detail":"{read_only:false; response_revision:8661; number_of_response:1; }","duration":"283.918934ms","start":"2026-08-07T21:08:16.349376Z","end":"2026-08-07T21:08:16.633295Z","steps":["trace[980221871] 'process raft request' (duration: 283.842522ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:08:16.633364Z","caller":"traceutil/trace.go:171","msg":"trace[665540330] transaction","detail":"{read_only:false; response_revision:8659; number_of_response:1; }","duration":"285.671836ms","start":"2026-08-07T21:08:16.347652Z","end":"2026-08-07T21:08:16.633324Z","steps":["trace[665540330] 'process raft request' (duration: 189.17433ms)","trace[665540330] 'compare' (duration: 96.110437ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T21:08:16.633625Z","caller":"traceutil/trace.go:171","msg":"trace[1470043517] transaction","detail":"{read_only:false; response_revision:8660; number_of_response:1; }","duration":"285.021581ms","start":"2026-08-07T21:08:16.348558Z","end":"2026-08-07T21:08:16.63358Z","steps":["trace[1470043517] 'process raft request' (duration: 284.5795ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:08:16.649444Z","caller":"traceutil/trace.go:171","msg":"trace[1528266032] linearizableReadLoop","detail":"{readStateIndex:8971; appliedIndex:8967; }","duration":"214.605881ms","start":"2026-08-07T21:08:16.43482Z","end":"2026-08-07T21:08:16.649425Z","steps":["trace[1528266032] 'read index received' (duration: 101.873158ms)","trace[1528266032] 'applied index is now lower than readState.Index' (duration: 112.731723ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T21:08:16.649564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.719393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-07T21:08:16.649588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.237032ms","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-07T21:08:16.649618Z","caller":"traceutil/trace.go:171","msg":"trace[1432368057] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:8662; }","duration":"214.819546ms","start":"2026-08-07T21:08:16.434784Z","end":"2026-08-07T21:08:16.649604Z","steps":["trace[1432368057] 'agreement among raft nodes before linearized reading' (duration: 214.700333ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:08:16.649633Z","caller":"traceutil/trace.go:171","msg":"trace[1130764989] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:8662; }","duration":"171.330514ms","start":"2026-08-07T21:08:16.478287Z","end":"2026-08-07T21:08:16.649617Z","steps":["trace[1130764989] 'agreement among raft nodes before linearized reading' (duration: 171.254913ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:08:16.65001Z","caller":"traceutil/trace.go:171","msg":"trace[1180529008] transaction","detail":"{read_only:false; response_revision:8662; number_of_response:1; }","duration":"237.359066ms","start":"2026-08-07T21:08:16.412627Z","end":"2026-08-07T21:08:16.649986Z","steps":["trace[1180529008] 'process raft request' (duration: 236.67952ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:08:30.8084Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023af.wal"} {"level":"info","ts":"2026-08-07T21:10:07.082893Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"71d28e9ac1bc4e5d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-07T21:10:07.088333Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-07T21:10:07.088468Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-07T21:12:31.86342Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8321} {"level":"info","ts":"2026-08-07T21:12:31.946007Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8321,"took":"80.44106ms","hash":1254109129,"current-db-size-bytes":58736640,"current-db-size":"59 MB","current-db-size-in-use-bytes":26083328,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-08-07T21:12:31.946109Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1254109129,"revision":8321,"compact-revision":6121} {"level":"info","ts":"2026-08-07T21:17:31.869468Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10814} {"level":"info","ts":"2026-08-07T21:17:31.951406Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10814,"took":"79.841769ms","hash":2890858489,"current-db-size-bytes":58736640,"current-db-size":"59 MB","current-db-size-in-use-bytes":27836416,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-07T21:17:31.951464Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2890858489,"revision":10814,"compact-revision":8321} {"level":"info","ts":"2026-08-07T21:19:41.922621Z","caller":"traceutil/trace.go:171","msg":"trace[47658049] transaction","detail":"{read_only:false; response_revision:13850; number_of_response:1; }","duration":"169.30753ms","start":"2026-08-07T21:19:41.753292Z","end":"2026-08-07T21:19:41.9226Z","steps":["trace[47658049] 'process raft request' (duration: 169.152037ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:19:42.131682Z","caller":"traceutil/trace.go:171","msg":"trace[1843500658] linearizableReadLoop","detail":"{readStateIndex:14327; appliedIndex:14326; }","duration":"119.710211ms","start":"2026-08-07T21:19:42.011942Z","end":"2026-08-07T21:19:42.131652Z","steps":["trace[1843500658] 'read index received' (duration: 119.503226ms)","trace[1843500658] 'applied index is now lower than readState.Index' (duration: 205.955µs)"],"step_count":2} {"level":"warn","ts":"2026-08-07T21:19:42.131896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.942917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-07T21:19:42.131931Z","caller":"traceutil/trace.go:171","msg":"trace[584707350] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:13853; }","duration":"120.023579ms","start":"2026-08-07T21:19:42.011896Z","end":"2026-08-07T21:19:42.131919Z","steps":["trace[584707350] 'agreement among raft nodes before linearized reading' (duration: 119.870635ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:19:42.132012Z","caller":"traceutil/trace.go:171","msg":"trace[699866059] transaction","detail":"{read_only:false; response_revision:13853; number_of_response:1; }","duration":"142.2465ms","start":"2026-08-07T21:19:41.989735Z","end":"2026-08-07T21:19:42.131982Z","steps":["trace[699866059] 'process raft request' (duration: 141.771109ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T21:20:04.656389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.379522ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-07T21:20:04.656494Z","caller":"traceutil/trace.go:171","msg":"trace[1134434435] linearizableReadLoop","detail":"{readStateIndex:14645; appliedIndex:14644; }","duration":"292.274182ms","start":"2026-08-07T21:20:04.364206Z","end":"2026-08-07T21:20:04.65648Z","steps":["trace[1134434435] 'read index received' (duration: 179.647013ms)","trace[1134434435] 'applied index is now lower than readState.Index' (duration: 112.626029ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T21:20:04.656561Z","caller":"traceutil/trace.go:171","msg":"trace[1612626024] transaction","detail":"{read_only:false; response_revision:14159; number_of_response:1; }","duration":"402.345608ms","start":"2026-08-07T21:20:04.254198Z","end":"2026-08-07T21:20:04.656544Z","steps":["trace[1612626024] 'process raft request' (duration: 289.730659ms)","trace[1612626024] 'compare' (duration: 112.038134ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T21:20:04.656627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T21:20:04.25418Z","time spent":"402.418309ms","remote":"127.0.0.1:59430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-07T21:20:04.65664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.429966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T21:20:04.656669Z","caller":"traceutil/trace.go:171","msg":"trace[315300390] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:14159; }","duration":"292.462046ms","start":"2026-08-07T21:20:04.364197Z","end":"2026-08-07T21:20:04.656659Z","steps":["trace[315300390] 'agreement among raft nodes before linearized reading' (duration: 292.352534ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T21:20:04.656888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.977044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-07T21:20:04.657737Z","caller":"traceutil/trace.go:171","msg":"trace[714169391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14159; }","duration":"210.856195ms","start":"2026-08-07T21:20:04.446867Z","end":"2026-08-07T21:20:04.657723Z","steps":["trace[714169391] 'agreement among raft nodes before linearized reading' (duration: 209.944963ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:21:09.094837Z","caller":"traceutil/trace.go:171","msg":"trace[376942106] linearizableReadLoop","detail":"{readStateIndex:15363; appliedIndex:15362; }","duration":"134.465479ms","start":"2026-08-07T21:21:08.960348Z","end":"2026-08-07T21:21:09.094814Z","steps":["trace[376942106] 'read index received' (duration: 134.248794ms)","trace[376942106] 'applied index is now lower than readState.Index' (duration: 213.095µs)"],"step_count":2} {"level":"info","ts":"2026-08-07T21:21:09.094903Z","caller":"traceutil/trace.go:171","msg":"trace[201061326] transaction","detail":"{read_only:false; response_revision:14858; number_of_response:1; }","duration":"147.438405ms","start":"2026-08-07T21:21:08.947426Z","end":"2026-08-07T21:21:09.094865Z","steps":["trace[201061326] 'process raft request' (duration: 147.245801ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T21:21:09.095139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.776636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-07T21:21:09.095221Z","caller":"traceutil/trace.go:171","msg":"trace[843842390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14858; }","duration":"134.92811ms","start":"2026-08-07T21:21:08.960279Z","end":"2026-08-07T21:21:09.095207Z","steps":["trace[843842390] 'agreement among raft nodes before linearized reading' (duration: 134.660283ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:21:16.373449Z","caller":"traceutil/trace.go:171","msg":"trace[969030861] transaction","detail":"{read_only:false; response_revision:14895; number_of_response:1; }","duration":"124.872655ms","start":"2026-08-07T21:21:16.248547Z","end":"2026-08-07T21:21:16.373419Z","steps":["trace[969030861] 'process raft request' (duration: 124.67477ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:21:24.305706Z","caller":"traceutil/trace.go:171","msg":"trace[753846958] transaction","detail":"{read_only:false; response_revision:14935; number_of_response:1; }","duration":"115.445815ms","start":"2026-08-07T21:21:24.190235Z","end":"2026-08-07T21:21:24.30568Z","steps":["trace[753846958] 'process raft request' (duration: 115.283921ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T21:21:29.936862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.577325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-08-07T21:21:29.936977Z","caller":"traceutil/trace.go:171","msg":"trace[1073189383] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14962; }","duration":"130.728818ms","start":"2026-08-07T21:21:29.806228Z","end":"2026-08-07T21:21:29.936956Z","steps":["trace[1073189383] 'range keys from in-memory index tree' (duration: 130.461672ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T21:21:29.93727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.546299ms","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-07T21:21:29.937317Z","caller":"traceutil/trace.go:171","msg":"trace[943500363] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:14962; }","duration":"122.643851ms","start":"2026-08-07T21:21:29.814661Z","end":"2026-08-07T21:21:29.937305Z","steps":["trace[943500363] 'range keys from in-memory index tree' (duration: 122.406115ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T21:21:30.915995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.655983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-07T21:21:30.916072Z","caller":"traceutil/trace.go:171","msg":"trace[169910949] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14968; }","duration":"191.773906ms","start":"2026-08-07T21:21:30.724281Z","end":"2026-08-07T21:21:30.916055Z","steps":["trace[169910949] 'range keys from in-memory index tree' (duration: 191.589612ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:22:31.87439Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12989} {"level":"info","ts":"2026-08-07T21:22:31.949291Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12989,"took":"72.341674ms","hash":3572382730,"current-db-size-bytes":58736640,"current-db-size":"59 MB","current-db-size-in-use-bytes":30769152,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-07T21:22:31.949378Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3572382730,"revision":12989,"compact-revision":10814} {"level":"warn","ts":"2026-08-07T21:27:04.290779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.972784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-7d7gk\" ","response":"range_response_count:1 size:9800"} {"level":"info","ts":"2026-08-07T21:27:04.290876Z","caller":"traceutil/trace.go:171","msg":"trace[1520445183] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-7d7gk; range_end:; response_count:1; response_revision:17466; }","duration":"155.118248ms","start":"2026-08-07T21:27:04.135739Z","end":"2026-08-07T21:27:04.290857Z","steps":["trace[1520445183] 'range keys from in-memory index tree' (duration: 154.720959ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:27:11.044431Z","caller":"traceutil/trace.go:171","msg":"trace[1763532597] linearizableReadLoop","detail":"{readStateIndex:18101; appliedIndex:18100; }","duration":"172.068301ms","start":"2026-08-07T21:27:10.872343Z","end":"2026-08-07T21:27:11.044411Z","steps":["trace[1763532597] 'read index received' (duration: 171.980669ms)","trace[1763532597] 'applied index is now lower than readState.Index' (duration: 86.732µs)"],"step_count":2} {"level":"info","ts":"2026-08-07T21:27:11.044503Z","caller":"traceutil/trace.go:171","msg":"trace[1729250272] transaction","detail":"{read_only:false; response_revision:17508; number_of_response:1; }","duration":"173.919186ms","start":"2026-08-07T21:27:10.870531Z","end":"2026-08-07T21:27:11.044451Z","steps":["trace[1729250272] 'process raft request' (duration: 173.755662ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T21:27:11.044787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.394118ms","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-07T21:27:11.04495Z","caller":"traceutil/trace.go:171","msg":"trace[1632056686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17508; }","duration":"172.573722ms","start":"2026-08-07T21:27:10.872323Z","end":"2026-08-07T21:27:11.044897Z","steps":["trace[1632056686] 'agreement among raft nodes before linearized reading' (duration: 172.181523ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:27:11.171487Z","caller":"traceutil/trace.go:171","msg":"trace[1758503315] transaction","detail":"{read_only:false; response_revision:17510; number_of_response:1; }","duration":"122.023051ms","start":"2026-08-07T21:27:11.04944Z","end":"2026-08-07T21:27:11.171463Z","steps":["trace[1758503315] 'process raft request' (duration: 121.96902ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:27:11.171677Z","caller":"traceutil/trace.go:171","msg":"trace[388804956] linearizableReadLoop","detail":"{readStateIndex:18102; appliedIndex:18101; }","duration":"127.164508ms","start":"2026-08-07T21:27:11.044498Z","end":"2026-08-07T21:27:11.171662Z","steps":["trace[388804956] 'read index received' (duration: 62.714777ms)","trace[388804956] 'applied index is now lower than readState.Index' (duration: 64.448181ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T21:27:11.171697Z","caller":"traceutil/trace.go:171","msg":"trace[1698929675] transaction","detail":"{read_only:false; response_revision:17509; number_of_response:1; }","duration":"200.860983ms","start":"2026-08-07T21:27:10.970796Z","end":"2026-08-07T21:27:11.171657Z","steps":["trace[1698929675] 'process raft request' (duration: 136.403412ms)","trace[1698929675] 'compare' (duration: 64.081171ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T21:27:11.171774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.848757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-07T21:27:11.171804Z","caller":"traceutil/trace.go:171","msg":"trace[1802283492] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:17510; }","duration":"208.931279ms","start":"2026-08-07T21:27:10.962864Z","end":"2026-08-07T21:27:11.171795Z","steps":["trace[1802283492] 'agreement among raft nodes before linearized reading' (duration: 208.850317ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T21:27:11.171958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.552511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-07T21:27:11.17212Z","caller":"traceutil/trace.go:171","msg":"trace[1195040373] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:17510; }","duration":"199.728746ms","start":"2026-08-07T21:27:10.972351Z","end":"2026-08-07T21:27:11.17208Z","steps":["trace[1195040373] 'agreement among raft nodes before linearized reading' (duration: 199.348437ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:27:11.758504Z","caller":"traceutil/trace.go:171","msg":"trace[1762033318] transaction","detail":"{read_only:false; response_revision:17511; number_of_response:1; }","duration":"238.749315ms","start":"2026-08-07T21:27:11.519735Z","end":"2026-08-07T21:27:11.758484Z","steps":["trace[1762033318] 'process raft request' (duration: 238.580701ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:27:11.758796Z","caller":"traceutil/trace.go:171","msg":"trace[1627301860] linearizableReadLoop","detail":"{readStateIndex:18104; appliedIndex:18103; }","duration":"191.76982ms","start":"2026-08-07T21:27:11.566685Z","end":"2026-08-07T21:27:11.758455Z","steps":["trace[1627301860] 'read index received' (duration: 191.666838ms)","trace[1627301860] 'applied index is now lower than readState.Index' (duration: 102.402µs)"],"step_count":2} {"level":"warn","ts":"2026-08-07T21:27:11.759029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.197481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-08-07T21:27:11.759221Z","caller":"traceutil/trace.go:171","msg":"trace[1065488413] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17511; }","duration":"192.478139ms","start":"2026-08-07T21:27:11.566627Z","end":"2026-08-07T21:27:11.759105Z","steps":["trace[1065488413] 'agreement among raft nodes before linearized reading' (duration: 191.991117ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:27:11.807829Z","caller":"traceutil/trace.go:171","msg":"trace[1613663591] transaction","detail":"{read_only:false; response_revision:17512; number_of_response:1; }","duration":"140.80035ms","start":"2026-08-07T21:27:11.666996Z","end":"2026-08-07T21:27:11.807796Z","steps":["trace[1613663591] 'process raft request' (duration: 140.561384ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:27:11.869161Z","caller":"traceutil/trace.go:171","msg":"trace[2051450824] transaction","detail":"{read_only:false; response_revision:17513; number_of_response:1; }","duration":"106.027822ms","start":"2026-08-07T21:27:11.763079Z","end":"2026-08-07T21:27:11.869107Z","steps":["trace[2051450824] 'process raft request' (duration: 65.099325ms)","trace[2051450824] 'compare' (duration: 40.683211ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T21:27:31.885671Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15377} {"level":"info","ts":"2026-08-07T21:27:31.984934Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15377,"took":"96.07909ms","hash":1108056351,"current-db-size-bytes":58736640,"current-db-size":"59 MB","current-db-size-in-use-bytes":32464896,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-07T21:27:31.985008Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1108056351,"revision":15377,"compact-revision":12989} {"level":"info","ts":"2026-08-07T21:30:52.93413Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"71d28e9ac1bc4e5d","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-07T21:30:52.93888Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-07T21:30:52.938952Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-07T21:32:31.891547Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17776} {"level":"info","ts":"2026-08-07T21:32:31.987518Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17776,"took":"93.255649ms","hash":564625065,"current-db-size-bytes":58736640,"current-db-size":"59 MB","current-db-size-in-use-bytes":34041856,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-07T21:32:31.987581Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":564625065,"revision":17776,"compact-revision":15377} {"level":"info","ts":"2026-08-07T21:33:03.839117Z","caller":"traceutil/trace.go:171","msg":"trace[1761696799] linearizableReadLoop","detail":"{readStateIndex:20911; appliedIndex:20910; }","duration":"115.204566ms","start":"2026-08-07T21:33:03.72388Z","end":"2026-08-07T21:33:03.839084Z","steps":["trace[1761696799] 'read index received' (duration: 105.242103ms)","trace[1761696799] 'applied index is now lower than readState.Index' (duration: 9.961343ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T21:33:03.839142Z","caller":"traceutil/trace.go:171","msg":"trace[2046049943] transaction","detail":"{read_only:false; response_revision:20225; number_of_response:1; }","duration":"126.536802ms","start":"2026-08-07T21:33:03.712565Z","end":"2026-08-07T21:33:03.839102Z","steps":["trace[2046049943] 'process raft request' (duration: 116.60809ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T21:33:03.839214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.316818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-07T21:33:03.839295Z","caller":"traceutil/trace.go:171","msg":"trace[648638826] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20225; }","duration":"115.41968ms","start":"2026-08-07T21:33:03.723861Z","end":"2026-08-07T21:33:03.839281Z","steps":["trace[648638826] 'agreement among raft nodes before linearized reading' (duration: 115.292887ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T21:33:03.839383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.065007ms","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-07T21:33:03.83945Z","caller":"traceutil/trace.go:171","msg":"trace[1329828457] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20225; }","duration":"105.16304ms","start":"2026-08-07T21:33:03.734274Z","end":"2026-08-07T21:33:03.839437Z","steps":["trace[1329828457] 'agreement among raft nodes before linearized reading' (duration: 104.991316ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:33:20.302792Z","caller":"traceutil/trace.go:171","msg":"trace[1691057613] transaction","detail":"{read_only:false; response_revision:20306; number_of_response:1; }","duration":"270.768707ms","start":"2026-08-07T21:33:20.031986Z","end":"2026-08-07T21:33:20.302755Z","steps":["trace[1691057613] 'process raft request' (duration: 270.544342ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T21:33:20.53646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.679491ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-07T21:33:20.536577Z","caller":"traceutil/trace.go:171","msg":"trace[753579696] linearizableReadLoop","detail":"{readStateIndex:20996; appliedIndex:20994; }","duration":"429.342484ms","start":"2026-08-07T21:33:20.107217Z","end":"2026-08-07T21:33:20.536559Z","steps":["trace[753579696] 'read index received' (duration: 195.326854ms)","trace[753579696] 'applied index is now lower than readState.Index' (duration: 234.01421ms)"],"step_count":2} {"level":"info","ts":"2026-08-07T21:33:20.536939Z","caller":"traceutil/trace.go:171","msg":"trace[2124950435] transaction","detail":"{read_only:false; response_revision:20307; number_of_response:1; }","duration":"504.705235ms","start":"2026-08-07T21:33:20.03212Z","end":"2026-08-07T21:33:20.536825Z","steps":["trace[2124950435] 'process raft request' (duration: 367.568063ms)","trace[2124950435] 'compare' (duration: 136.549558ms)"],"step_count":2} {"level":"warn","ts":"2026-08-07T21:33:20.537143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.915278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-08-07T21:33:20.537215Z","caller":"traceutil/trace.go:171","msg":"trace[1997297954] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20307; }","duration":"430.058071ms","start":"2026-08-07T21:33:20.107142Z","end":"2026-08-07T21:33:20.5372Z","steps":["trace[1997297954] 'agreement among raft nodes before linearized reading' (duration: 429.829726ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T21:33:20.537205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T21:33:20.032086Z","time spent":"504.983481ms","remote":"127.0.0.1:59430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-07T21:33:20.537245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T21:33:20.107113Z","time spent":"430.127513ms","remote":"127.0.0.1:59430","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-07T21:33:20.553312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.871436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-07T21:33:20.55331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.338313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-07T21:33:20.553379Z","caller":"traceutil/trace.go:171","msg":"trace[2006751224] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:20308; }","duration":"321.995959ms","start":"2026-08-07T21:33:20.231365Z","end":"2026-08-07T21:33:20.553361Z","steps":["trace[2006751224] 'agreement among raft nodes before linearized reading' (duration: 321.871686ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:33:20.553403Z","caller":"traceutil/trace.go:171","msg":"trace[413766146] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:20308; }","duration":"323.489407ms","start":"2026-08-07T21:33:20.22989Z","end":"2026-08-07T21:33:20.553379Z","steps":["trace[413766146] 'agreement among raft nodes before linearized reading' (duration: 323.22603ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T21:33:20.553423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T21:33:20.231334Z","time spent":"322.078561ms","remote":"127.0.0.1:35296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true "} {"level":"warn","ts":"2026-08-07T21:33:20.553453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-07T21:33:20.229868Z","time spent":"323.573778ms","remote":"127.0.0.1:50682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":27,"response size":30,"request content":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true "} {"level":"info","ts":"2026-08-07T21:33:20.699892Z","caller":"traceutil/trace.go:171","msg":"trace[2111434324] transaction","detail":"{read_only:false; response_revision:20309; number_of_response:1; }","duration":"158.857313ms","start":"2026-08-07T21:33:20.540986Z","end":"2026-08-07T21:33:20.699844Z","steps":["trace[2111434324] 'process raft request' (duration: 153.766809ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:37:04.566459Z","caller":"traceutil/trace.go:171","msg":"trace[1152910846] linearizableReadLoop","detail":"{readStateIndex:23451; appliedIndex:23450; }","duration":"148.070669ms","start":"2026-08-07T21:37:04.418362Z","end":"2026-08-07T21:37:04.566432Z","steps":["trace[1152910846] 'read index received' (duration: 147.922235ms)","trace[1152910846] 'applied index is now lower than readState.Index' (duration: 146.484µs)"],"step_count":2} {"level":"info","ts":"2026-08-07T21:37:04.56653Z","caller":"traceutil/trace.go:171","msg":"trace[237143642] transaction","detail":"{read_only:false; response_revision:22688; number_of_response:1; }","duration":"174.053914ms","start":"2026-08-07T21:37:04.392433Z","end":"2026-08-07T21:37:04.566487Z","steps":["trace[237143642] 'process raft request' (duration: 173.707356ms)"],"step_count":1} {"level":"warn","ts":"2026-08-07T21:37:04.566708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.340716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-08-07T21:37:04.566758Z","caller":"traceutil/trace.go:171","msg":"trace[1186709764] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:22688; }","duration":"148.452578ms","start":"2026-08-07T21:37:04.418296Z","end":"2026-08-07T21:37:04.566749Z","steps":["trace[1186709764] 'agreement among raft nodes before linearized reading' (duration: 148.255724ms)"],"step_count":1} {"level":"info","ts":"2026-08-07T21:37:31.899458Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20060} {"level":"info","ts":"2026-08-07T21:37:32.006719Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20060,"took":"103.235313ms","hash":3899599914,"current-db-size-bytes":58736640,"current-db-size":"59 MB","current-db-size-in-use-bytes":41160704,"current-db-size-in-use":"41 MB"} {"level":"info","ts":"2026-08-07T21:37:32.006776Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3899599914,"revision":20060,"compact-revision":17776} {"level":"info","ts":"2026-08-07T21:42:31.90773Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22975} {"level":"info","ts":"2026-08-07T21:42:32.055248Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22975,"took":"142.261721ms","hash":1274207822,"current-db-size-bytes":59363328,"current-db-size":"59 MB","current-db-size-in-use-bytes":31567872,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-07T21:42:32.055346Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1274207822,"revision":22975,"compact-revision":20060}