{"level":"warn","ts":"2026-10-17T03:08:52.517274Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-17T03:08:52.517414Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.86: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://162.253.55.86:2380","--initial-cluster=instance=https://162.253.55.86:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.86:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.86: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-10-17T03:08:52.517513Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-10-17T03:08:52.517534Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.86:2380"]}
{"level":"info","ts":"2026-10-17T03:08:52.517698Z","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-10-17T03:08:52.518858Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.86:2379"]}
{"level":"info","ts":"2026-10-17T03:08:52.519099Z","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://162.253.55.86:2380"],"listen-peer-urls":["https://162.253.55.86:2380"],"advertise-client-urls":["https://162.253.55.86:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.86:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.86: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-10-17T03:08:52.522533Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.065813ms"}
{"level":"info","ts":"2026-10-17T03:08:52.536098Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d01cde7b2aa18f95","cluster-id":"9e5d9cb67aed7785"}
{"level":"info","ts":"2026-10-17T03:08:52.536222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 switched to configuration voters=()"}
{"level":"info","ts":"2026-10-17T03:08:52.536414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 became follower at term 0"}
{"level":"info","ts":"2026-10-17T03:08:52.536461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d01cde7b2aa18f95 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-10-17T03:08:52.536485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 became follower at term 1"}
{"level":"info","ts":"2026-10-17T03:08:52.536773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 switched to configuration voters=(14996105479814483861)"}
{"level":"warn","ts":"2026-10-17T03:08:52.544307Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-10-17T03:08:52.546171Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-10-17T03:08:52.547619Z","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-10-17T03:08:52.550697Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d01cde7b2aa18f95","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-10-17T03:08:52.550902Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d01cde7b2aa18f95","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-10-17T03:08:52.551141Z","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-10-17T03:08:52.551322Z","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-10-17T03:08:52.551365Z","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-10-17T03:08:52.552736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 switched to configuration voters=(14996105479814483861)"}
{"level":"info","ts":"2026-10-17T03:08:52.553617Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9e5d9cb67aed7785","local-member-id":"d01cde7b2aa18f95","added-peer-id":"d01cde7b2aa18f95","added-peer-peer-urls":["https://162.253.55.86:2380"]}
{"level":"info","ts":"2026-10-17T03:08:52.556136Z","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-10-17T03:08:52.556575Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d01cde7b2aa18f95","initial-advertise-peer-urls":["https://162.253.55.86:2380"],"listen-peer-urls":["https://162.253.55.86:2380"],"advertise-client-urls":["https://162.253.55.86:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.86:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-10-17T03:08:52.556624Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-10-17T03:08:52.556869Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.86:2380"}
{"level":"info","ts":"2026-10-17T03:08:52.556897Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.86:2380"}
{"level":"info","ts":"2026-10-17T03:08:52.737832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 is starting a new election at term 1"}
{"level":"info","ts":"2026-10-17T03:08:52.737901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 became pre-candidate at term 1"}
{"level":"info","ts":"2026-10-17T03:08:52.737941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 received MsgPreVoteResp from d01cde7b2aa18f95 at term 1"}
{"level":"info","ts":"2026-10-17T03:08:52.737979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 became candidate at term 2"}
{"level":"info","ts":"2026-10-17T03:08:52.73799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 received MsgVoteResp from d01cde7b2aa18f95 at term 2"}
{"level":"info","ts":"2026-10-17T03:08:52.738005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d01cde7b2aa18f95 became leader at term 2"}
{"level":"info","ts":"2026-10-17T03:08:52.738023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d01cde7b2aa18f95 elected leader d01cde7b2aa18f95 at term 2"}
{"level":"info","ts":"2026-10-17T03:08:52.739256Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d01cde7b2aa18f95","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.86:2379]}","request-path":"/0/members/d01cde7b2aa18f95/attributes","cluster-id":"9e5d9cb67aed7785","publish-timeout":"7s"}
{"level":"info","ts":"2026-10-17T03:08:52.739326Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-17T03:08:52.739385Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-10-17T03:08:52.739514Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-10-17T03:08:52.739312Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-17T03:08:52.739686Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-10-17T03:08:52.740727Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9e5d9cb67aed7785","local-member-id":"d01cde7b2aa18f95","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-17T03:08:52.740873Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-17T03:08:52.740923Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-10-17T03:08:52.742434Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.86:2379"}
{"level":"info","ts":"2026-10-17T03:08:52.743142Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-10-17T03:09:06.038734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.670781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"}
{"level":"info","ts":"2026-10-17T03:09:06.038895Z","caller":"traceutil/trace.go:171","msg":"trace[1905227431] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:361; }","duration":"123.940128ms","start":"2026-10-17T03:09:05.914937Z","end":"2026-10-17T03:09:06.038878Z","steps":["trace[1905227431] 'range keys from in-memory index tree'  (duration: 123.544758ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:09:39.829594Z","caller":"traceutil/trace.go:171","msg":"trace[259759917] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"107.544323ms","start":"2026-10-17T03:09:39.722016Z","end":"2026-10-17T03:09:39.82956Z","steps":["trace[259759917] 'process raft request'  (duration: 102.888927ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:09:46.736591Z","caller":"traceutil/trace.go:171","msg":"trace[1910424696] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"125.614314ms","start":"2026-10-17T03:09:46.610952Z","end":"2026-10-17T03:09:46.736567Z","steps":["trace[1910424696] 'process raft request'  (duration: 125.482651ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:09:47.113696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.47489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-10-17T03:09:47.114213Z","caller":"traceutil/trace.go:171","msg":"trace[1729010679] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:677; }","duration":"217.81187ms","start":"2026-10-17T03:09:46.89616Z","end":"2026-10-17T03:09:47.113972Z","steps":["trace[1729010679] 'range keys from in-memory index tree'  (duration: 217.004388ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:09:47.238924Z","caller":"traceutil/trace.go:171","msg":"trace[486844831] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"118.984294ms","start":"2026-10-17T03:09:47.119914Z","end":"2026-10-17T03:09:47.238898Z","steps":["trace[486844831] 'process raft request'  (duration: 118.876501ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:09:47.263499Z","caller":"traceutil/trace.go:171","msg":"trace[1346518894] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:699; }","duration":"129.766857ms","start":"2026-10-17T03:09:47.133707Z","end":"2026-10-17T03:09:47.263474Z","steps":["trace[1346518894] 'read index received'  (duration: 105.110827ms)","trace[1346518894] 'applied index is now lower than readState.Index'  (duration: 24.65503ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T03:09:47.263586Z","caller":"traceutil/trace.go:171","msg":"trace[1746493262] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"143.315395ms","start":"2026-10-17T03:09:47.120245Z","end":"2026-10-17T03:09:47.263561Z","steps":["trace[1746493262] 'process raft request'  (duration: 143.006547ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:09:47.26363Z","caller":"traceutil/trace.go:171","msg":"trace[1381740601] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"131.120274ms","start":"2026-10-17T03:09:47.132491Z","end":"2026-10-17T03:09:47.263611Z","steps":["trace[1381740601] 'process raft request'  (duration: 130.906458ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:09:47.263665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.946312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"}
{"level":"info","ts":"2026-10-17T03:09:47.263699Z","caller":"traceutil/trace.go:171","msg":"trace[49791879] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:680; }","duration":"130.032924ms","start":"2026-10-17T03:09:47.133656Z","end":"2026-10-17T03:09:47.263689Z","steps":["trace[49791879] 'agreement among raft nodes before linearized reading'  (duration: 129.909071ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:10:03.353572Z","caller":"traceutil/trace.go:171","msg":"trace[1665297962] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"175.504475ms","start":"2026-10-17T03:10:03.178023Z","end":"2026-10-17T03:10:03.353528Z","steps":["trace[1665297962] 'process raft request'  (duration: 175.241477ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:10:54.512202Z","caller":"traceutil/trace.go:171","msg":"trace[895146808] transaction","detail":"{read_only:false; response_revision:1446; number_of_response:1; }","duration":"100.731976ms","start":"2026-10-17T03:10:54.411454Z","end":"2026-10-17T03:10:54.512186Z","steps":["trace[895146808] 'process raft request'  (duration: 100.635413ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:11:21.073611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.922062ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10346353048849205214 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1741 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-17T03:11:21.073728Z","caller":"traceutil/trace.go:171","msg":"trace[918953577] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"303.34914ms","start":"2026-10-17T03:11:20.770362Z","end":"2026-10-17T03:11:21.073711Z","steps":["trace[918953577] 'process raft request'  (duration: 174.623706ms)","trace[918953577] 'compare'  (duration: 127.609644ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T03:11:21.073786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T03:11:20.770336Z","time spent":"303.421792ms","remote":"127.0.0.1:36822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:1741 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-10-17T03:11:21.44531Z","caller":"traceutil/trace.go:171","msg":"trace[1378580183] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"199.443218ms","start":"2026-10-17T03:11:21.245842Z","end":"2026-10-17T03:11:21.445285Z","steps":["trace[1378580183] 'process raft request'  (duration: 199.258133ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:12:15.887412Z","caller":"traceutil/trace.go:171","msg":"trace[1811914577] transaction","detail":"{read_only:false; response_revision:2220; number_of_response:1; }","duration":"126.147381ms","start":"2026-10-17T03:12:15.761241Z","end":"2026-10-17T03:12:15.887388Z","steps":["trace[1811914577] 'process raft request'  (duration: 125.960876ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:16:27.573043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.279865ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10346353048849210372 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:3952 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-17T03:16:27.573334Z","caller":"traceutil/trace.go:171","msg":"trace[716625505] transaction","detail":"{read_only:false; response_revision:3964; number_of_response:1; }","duration":"139.57683ms","start":"2026-10-17T03:16:27.433727Z","end":"2026-10-17T03:16:27.573304Z","steps":["trace[716625505] 'process raft request'  (duration: 20.943335ms)","trace[716625505] 'compare'  (duration: 117.995387ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T03:16:27.573365Z","caller":"traceutil/trace.go:171","msg":"trace[165581974] linearizableReadLoop","detail":"{readStateIndex:4114; appliedIndex:4113; }","duration":"119.418275ms","start":"2026-10-17T03:16:27.453909Z","end":"2026-10-17T03:16:27.573327Z","steps":["trace[165581974] 'read index received'  (duration: 700.629µs)","trace[165581974] 'applied index is now lower than readState.Index'  (duration: 118.715496ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T03:16:27.573703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.773325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12431"}
{"level":"info","ts":"2026-10-17T03:16:27.573788Z","caller":"traceutil/trace.go:171","msg":"trace[371439145] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3964; }","duration":"119.891968ms","start":"2026-10-17T03:16:27.453875Z","end":"2026-10-17T03:16:27.573767Z","steps":["trace[371439145] 'agreement among raft nodes before linearized reading'  (duration: 119.549609ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:17:51.624318Z","caller":"traceutil/trace.go:171","msg":"trace[1528336843] transaction","detail":"{read_only:false; response_revision:4879; number_of_response:1; }","duration":"103.530407ms","start":"2026-10-17T03:17:51.52075Z","end":"2026-10-17T03:17:51.624281Z","steps":["trace[1528336843] 'process raft request'  (duration: 78.398788ms)","trace[1528336843] 'compare'  (duration: 24.869781ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T03:17:51.624241Z","caller":"traceutil/trace.go:171","msg":"trace[1755991820] linearizableReadLoop","detail":"{readStateIndex:5065; appliedIndex:5064; }","duration":"102.955752ms","start":"2026-10-17T03:17:51.52125Z","end":"2026-10-17T03:17:51.624206Z","steps":["trace[1755991820] 'read index received'  (duration: 77.911125ms)","trace[1755991820] 'applied index is now lower than readState.Index'  (duration: 25.043267ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T03:17:51.624526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.248659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"}
{"level":"info","ts":"2026-10-17T03:17:51.624589Z","caller":"traceutil/trace.go:171","msg":"trace[645933492] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4879; }","duration":"103.340231ms","start":"2026-10-17T03:17:51.521231Z","end":"2026-10-17T03:17:51.624571Z","steps":["trace[645933492] 'agreement among raft nodes before linearized reading'  (duration: 103.137776ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:17:51.626362Z","caller":"traceutil/trace.go:171","msg":"trace[1242541076] transaction","detail":"{read_only:false; response_revision:4880; number_of_response:1; }","duration":"102.89267ms","start":"2026-10-17T03:17:51.523459Z","end":"2026-10-17T03:17:51.626352Z","steps":["trace[1242541076] 'process raft request'  (duration: 102.496349ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:17:51.626947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.324814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0.18df32d60553b9df\" ","response":"range_response_count:1 size:1203"}
{"level":"info","ts":"2026-10-17T03:17:51.627029Z","caller":"traceutil/trace.go:171","msg":"trace[41988925] range","detail":"{range_begin:/registry/events/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0.18df32d60553b9df; range_end:; response_count:1; response_revision:4881; }","duration":"102.427827ms","start":"2026-10-17T03:17:51.524584Z","end":"2026-10-17T03:17:51.627012Z","steps":["trace[41988925] 'agreement among raft nodes before linearized reading'  (duration: 102.230752ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:17:51.626197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.501219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T03:17:51.627222Z","caller":"traceutil/trace.go:171","msg":"trace[795541773] range","detail":"{range_begin:/registry/limitranges/local-path-storage/; range_end:/registry/limitranges/local-path-storage0; response_count:0; response_revision:4881; }","duration":"103.559078ms","start":"2026-10-17T03:17:51.523644Z","end":"2026-10-17T03:17:51.627203Z","steps":["trace[795541773] 'agreement among raft nodes before linearized reading'  (duration: 102.457558ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:18:00.77539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.556609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-lkjzp-tls\" ","response":"range_response_count:1 size:2183"}
{"level":"info","ts":"2026-10-17T03:18:00.775476Z","caller":"traceutil/trace.go:171","msg":"trace[1647744887] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-lkjzp-tls; range_end:; response_count:1; response_revision:5167; }","duration":"119.672832ms","start":"2026-10-17T03:18:00.655779Z","end":"2026-10-17T03:18:00.775452Z","steps":["trace[1647744887] 'range keys from in-memory index tree'  (duration: 119.398425ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:18:00.775523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.01997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d89cce28-dfb1-47a9-a932-4c11be581f3d\" ","response":"range_response_count:1 size:3600"}
{"level":"warn","ts":"2026-10-17T03:18:00.775548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.119858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-17T03:18:00.775624Z","caller":"traceutil/trace.go:171","msg":"trace[1487195761] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:5167; }","duration":"206.258691ms","start":"2026-10-17T03:18:00.569346Z","end":"2026-10-17T03:18:00.775604Z","steps":["trace[1487195761] 'count revisions from in-memory index tree'  (duration: 206.023415ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:18:00.775609Z","caller":"traceutil/trace.go:171","msg":"trace[964252545] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d89cce28-dfb1-47a9-a932-4c11be581f3d; range_end:; response_count:1; response_revision:5167; }","duration":"198.124732ms","start":"2026-10-17T03:18:00.577466Z","end":"2026-10-17T03:18:00.775591Z","steps":["trace[964252545] 'range keys from in-memory index tree'  (duration: 197.883926ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:18:00.775348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.68403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T03:18:00.77573Z","caller":"traceutil/trace.go:171","msg":"trace[1168002557] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:5167; }","duration":"255.106731ms","start":"2026-10-17T03:18:00.520607Z","end":"2026-10-17T03:18:00.775714Z","steps":["trace[1168002557] 'count revisions from in-memory index tree'  (duration: 254.633598ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:18:14.795678Z","caller":"traceutil/trace.go:171","msg":"trace[1453949102] transaction","detail":"{read_only:false; response_revision:5419; number_of_response:1; }","duration":"100.654069ms","start":"2026-10-17T03:18:14.695004Z","end":"2026-10-17T03:18:14.795658Z","steps":["trace[1453949102] 'process raft request'  (duration: 100.380711ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:18:16.322171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.740798ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10346353048849213679 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5395 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-17T03:18:16.322592Z","caller":"traceutil/trace.go:171","msg":"trace[1979516460] linearizableReadLoop","detail":"{readStateIndex:5649; appliedIndex:5648; }","duration":"204.772682ms","start":"2026-10-17T03:18:16.1178Z","end":"2026-10-17T03:18:16.322573Z","steps":["trace[1979516460] 'read index received'  (duration: 57.441µs)","trace[1979516460] 'applied index is now lower than readState.Index'  (duration: 204.713241ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T03:18:16.322837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.03906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-10-17T03:18:16.322874Z","caller":"traceutil/trace.go:171","msg":"trace[1994598281] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5445; }","duration":"205.126722ms","start":"2026-10-17T03:18:16.117735Z","end":"2026-10-17T03:18:16.322862Z","steps":["trace[1994598281] 'agreement among raft nodes before linearized reading'  (duration: 204.952007ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:18:16.322519Z","caller":"traceutil/trace.go:171","msg":"trace[1623328868] transaction","detail":"{read_only:false; response_revision:5445; number_of_response:1; }","duration":"384.377314ms","start":"2026-10-17T03:18:15.938112Z","end":"2026-10-17T03:18:16.322489Z","steps":["trace[1623328868] 'process raft request'  (duration: 131.195574ms)","trace[1623328868] 'compare'  (duration: 252.47004ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T03:18:16.323243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T03:18:15.938089Z","time spent":"385.080483ms","remote":"127.0.0.1:36822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5395 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-10-17T03:18:23.98985Z","caller":"traceutil/trace.go:171","msg":"trace[1736195177] linearizableReadLoop","detail":"{readStateIndex:5809; appliedIndex:5808; }","duration":"164.031891ms","start":"2026-10-17T03:18:23.825795Z","end":"2026-10-17T03:18:23.989827Z","steps":["trace[1736195177] 'read index received'  (duration: 163.856146ms)","trace[1736195177] 'applied index is now lower than readState.Index'  (duration: 174.855µs)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T03:18:23.990062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.247717ms","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-10-17T03:18:23.990185Z","caller":"traceutil/trace.go:171","msg":"trace[2031105803] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5600; }","duration":"164.405221ms","start":"2026-10-17T03:18:23.82576Z","end":"2026-10-17T03:18:23.990165Z","steps":["trace[2031105803] 'agreement among raft nodes before linearized reading'  (duration: 164.169405ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:18:23.98996Z","caller":"traceutil/trace.go:171","msg":"trace[782941426] transaction","detail":"{read_only:false; response_revision:5600; number_of_response:1; }","duration":"175.880161ms","start":"2026-10-17T03:18:23.814017Z","end":"2026-10-17T03:18:23.989897Z","steps":["trace[782941426] 'process raft request'  (duration: 175.679766ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:18:24.150304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.490656ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10346353048849214082 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5532 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-17T03:18:24.150501Z","caller":"traceutil/trace.go:171","msg":"trace[596980740] transaction","detail":"{read_only:false; response_revision:5602; number_of_response:1; }","duration":"154.295708ms","start":"2026-10-17T03:18:23.996188Z","end":"2026-10-17T03:18:24.150484Z","steps":["trace[596980740] 'process raft request'  (duration: 154.214406ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:18:24.150555Z","caller":"traceutil/trace.go:171","msg":"trace[950693513] transaction","detail":"{read_only:false; response_revision:5601; number_of_response:1; }","duration":"156.195689ms","start":"2026-10-17T03:18:23.994318Z","end":"2026-10-17T03:18:24.150513Z","steps":["trace[950693513] 'process raft request'  (duration: 52.247291ms)","trace[950693513] 'compare'  (duration: 103.26245ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T03:18:35.719616Z","caller":"traceutil/trace.go:171","msg":"trace[1706922670] transaction","detail":"{read_only:false; response_revision:5757; number_of_response:1; }","duration":"166.845549ms","start":"2026-10-17T03:18:35.552716Z","end":"2026-10-17T03:18:35.719561Z","steps":["trace[1706922670] 'process raft request'  (duration: 166.757456ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:18:35.719805Z","caller":"traceutil/trace.go:171","msg":"trace[434762952] transaction","detail":"{read_only:false; response_revision:5756; number_of_response:1; }","duration":"168.852112ms","start":"2026-10-17T03:18:35.550902Z","end":"2026-10-17T03:18:35.719754Z","steps":["trace[434762952] 'process raft request'  (duration: 100.326674ms)","trace[434762952] 'compare'  (duration: 67.987513ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T03:18:53.005426Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2948}
{"level":"info","ts":"2026-10-17T03:18:53.089041Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2948,"took":"82.256597ms","hash":3886431739,"current-db-size-bytes":56573952,"current-db-size":"57 MB","current-db-size-in-use-bytes":32739328,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-10-17T03:18:53.089107Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3886431739,"revision":2948,"compact-revision":-1}
{"level":"info","ts":"2026-10-17T03:23:53.013459Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5881}
{"level":"info","ts":"2026-10-17T03:23:53.112679Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5881,"took":"96.141371ms","hash":1044891734,"current-db-size-bytes":56573952,"current-db-size":"57 MB","current-db-size-in-use-bytes":25841664,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-10-17T03:23:53.112743Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1044891734,"revision":5881,"compact-revision":2948}
{"level":"info","ts":"2026-10-17T03:25:00.747033Z","caller":"traceutil/trace.go:171","msg":"trace[1163495557] transaction","detail":"{read_only:false; response_revision:8594; number_of_response:1; }","duration":"334.864409ms","start":"2026-10-17T03:25:00.412109Z","end":"2026-10-17T03:25:00.746973Z","steps":["trace[1163495557] 'process raft request'  (duration: 253.436756ms)","trace[1163495557] 'compare'  (duration: 81.30339ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T03:25:00.747225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T03:25:00.412088Z","time spent":"335.032984ms","remote":"127.0.0.1:36822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:8584 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:410 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-10-17T03:25:03.192586Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000022d6.wal"}
{"level":"info","ts":"2026-10-17T03:25:31.185381Z","caller":"traceutil/trace.go:171","msg":"trace[2140958337] transaction","detail":"{read_only:false; response_revision:8810; number_of_response:1; }","duration":"266.485137ms","start":"2026-10-17T03:25:30.918862Z","end":"2026-10-17T03:25:31.185347Z","steps":["trace[2140958337] 'process raft request'  (duration: 266.20329ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:25:31.185604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.871097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-17T03:25:31.185692Z","caller":"traceutil/trace.go:171","msg":"trace[659252815] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:8810; }","duration":"202.029031ms","start":"2026-10-17T03:25:30.983643Z","end":"2026-10-17T03:25:31.185672Z","steps":["trace[659252815] 'agreement among raft nodes before linearized reading'  (duration: 201.757504ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:25:31.185263Z","caller":"traceutil/trace.go:171","msg":"trace[441340269] linearizableReadLoop","detail":"{readStateIndex:9126; appliedIndex:9125; }","duration":"201.546739ms","start":"2026-10-17T03:25:30.983693Z","end":"2026-10-17T03:25:31.18524Z","steps":["trace[441340269] 'read index received'  (duration: 201.285762ms)","trace[441340269] 'applied index is now lower than readState.Index'  (duration: 260.297µs)"],"step_count":2}
{"level":"info","ts":"2026-10-17T03:25:31.386512Z","caller":"traceutil/trace.go:171","msg":"trace[553801107] transaction","detail":"{read_only:false; response_revision:8811; number_of_response:1; }","duration":"185.051345ms","start":"2026-10-17T03:25:31.20143Z","end":"2026-10-17T03:25:31.386481Z","steps":["trace[553801107] 'process raft request'  (duration: 184.703586ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:25:31.387416Z","caller":"traceutil/trace.go:171","msg":"trace[1634010190] linearizableReadLoop","detail":"{readStateIndex:9129; appliedIndex:9126; }","duration":"160.73559ms","start":"2026-10-17T03:25:31.226666Z","end":"2026-10-17T03:25:31.387402Z","steps":["trace[1634010190] 'read index received'  (duration: 159.689232ms)","trace[1634010190] 'applied index is now lower than readState.Index'  (duration: 1.045608ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T03:25:31.387472Z","caller":"traceutil/trace.go:171","msg":"trace[1273491257] transaction","detail":"{read_only:false; response_revision:8812; number_of_response:1; }","duration":"173.566005ms","start":"2026-10-17T03:25:31.213864Z","end":"2026-10-17T03:25:31.38743Z","steps":["trace[1273491257] 'process raft request'  (duration: 173.429832ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:25:31.387573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.887904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-10-17T03:25:31.387605Z","caller":"traceutil/trace.go:171","msg":"trace[1732762780] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8813; }","duration":"160.960095ms","start":"2026-10-17T03:25:31.226634Z","end":"2026-10-17T03:25:31.387595Z","steps":["trace[1732762780] 'agreement among raft nodes before linearized reading'  (duration: 160.823801ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:25:31.387788Z","caller":"traceutil/trace.go:171","msg":"trace[115912927] transaction","detail":"{read_only:false; response_revision:8813; number_of_response:1; }","duration":"171.711245ms","start":"2026-10-17T03:25:31.216024Z","end":"2026-10-17T03:25:31.387735Z","steps":["trace[115912927] 'process raft request'  (duration: 171.342665ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:25:33.510573Z","caller":"traceutil/trace.go:171","msg":"trace[1325429245] transaction","detail":"{read_only:false; response_revision:8822; number_of_response:1; }","duration":"116.641321ms","start":"2026-10-17T03:25:33.393917Z","end":"2026-10-17T03:25:33.510558Z","steps":["trace[1325429245] 'process raft request'  (duration: 113.770594ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:25:33.510887Z","caller":"traceutil/trace.go:171","msg":"trace[684689082] transaction","detail":"{read_only:false; response_revision:8823; number_of_response:1; }","duration":"116.248641ms","start":"2026-10-17T03:25:33.394627Z","end":"2026-10-17T03:25:33.510876Z","steps":["trace[684689082] 'process raft request'  (duration: 115.447259ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:25:33.510929Z","caller":"traceutil/trace.go:171","msg":"trace[2105843469] linearizableReadLoop","detail":"{readStateIndex:9140; appliedIndex:9138; }","duration":"113.687042ms","start":"2026-10-17T03:25:33.396436Z","end":"2026-10-17T03:25:33.510123Z","steps":["trace[2105843469] 'read index received'  (duration: 34.611302ms)","trace[2105843469] 'applied index is now lower than readState.Index'  (duration: 79.07457ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T03:25:33.51114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.683158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-10-17T03:25:33.511182Z","caller":"traceutil/trace.go:171","msg":"trace[232816805] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8823; }","duration":"114.742161ms","start":"2026-10-17T03:25:33.396414Z","end":"2026-10-17T03:25:33.511157Z","steps":["trace[232816805] 'agreement among raft nodes before linearized reading'  (duration: 114.606167ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:25:41.937021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.410805ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10346353048849222684 > lease_revoke:<id:0f95a147d5700b03>","response":"size:29"}
{"level":"info","ts":"2026-10-17T03:25:42.15906Z","caller":"traceutil/trace.go:171","msg":"trace[1566712151] transaction","detail":"{read_only:false; response_revision:8870; number_of_response:1; }","duration":"122.098808ms","start":"2026-10-17T03:25:42.036934Z","end":"2026-10-17T03:25:42.159033Z","steps":["trace[1566712151] 'process raft request'  (duration: 121.901703ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:25:42.683575Z","caller":"traceutil/trace.go:171","msg":"trace[1416650773] transaction","detail":"{read_only:false; response_revision:8873; number_of_response:1; }","duration":"120.858885ms","start":"2026-10-17T03:25:42.562687Z","end":"2026-10-17T03:25:42.683546Z","steps":["trace[1416650773] 'process raft request'  (duration: 81.762873ms)","trace[1416650773] 'compare'  (duration: 38.974819ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T03:25:44.095595Z","caller":"traceutil/trace.go:171","msg":"trace[1507141359] linearizableReadLoop","detail":"{readStateIndex:9211; appliedIndex:9210; }","duration":"145.438787ms","start":"2026-10-17T03:25:43.950125Z","end":"2026-10-17T03:25:44.095564Z","steps":["trace[1507141359] 'read index received'  (duration: 145.266733ms)","trace[1507141359] 'applied index is now lower than readState.Index'  (duration: 170.964µs)"],"step_count":2}
{"level":"info","ts":"2026-10-17T03:25:44.09564Z","caller":"traceutil/trace.go:171","msg":"trace[1923723114] transaction","detail":"{read_only:false; response_revision:8892; number_of_response:1; }","duration":"169.833615ms","start":"2026-10-17T03:25:43.925777Z","end":"2026-10-17T03:25:44.09561Z","steps":["trace[1923723114] 'process raft request'  (duration: 169.599668ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:25:44.095818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.675444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-r9xc4\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-10-17T03:25:44.095854Z","caller":"traceutil/trace.go:171","msg":"trace[1247854103] range","detail":"{range_begin:/registry/pods/openstack/keepalived-r9xc4; range_end:; response_count:1; response_revision:8892; }","duration":"145.771007ms","start":"2026-10-17T03:25:43.950073Z","end":"2026-10-17T03:25:44.095844Z","steps":["trace[1247854103] 'agreement among raft nodes before linearized reading'  (duration: 145.605462ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:26:59.641596Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d01cde7b2aa18f95","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-17T03:26:59.649272Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-10-17T03:26:59.649393Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"warn","ts":"2026-10-17T03:27:11.511618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.796084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T03:27:11.511732Z","caller":"traceutil/trace.go:171","msg":"trace[1209743968] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:9728; }","duration":"192.968779ms","start":"2026-10-17T03:27:11.318734Z","end":"2026-10-17T03:27:11.511703Z","steps":["trace[1209743968] 'count revisions from in-memory index tree'  (duration: 192.710801ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:27:11.558695Z","caller":"traceutil/trace.go:171","msg":"trace[420101181] linearizableReadLoop","detail":"{readStateIndex:10072; appliedIndex:10071; }","duration":"170.759411ms","start":"2026-10-17T03:27:11.387905Z","end":"2026-10-17T03:27:11.558664Z","steps":["trace[420101181] 'read index received'  (duration: 80.91721ms)","trace[420101181] 'applied index is now lower than readState.Index'  (duration: 89.840771ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T03:27:11.558887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.969946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T03:27:11.558912Z","caller":"traceutil/trace.go:171","msg":"trace[1686699097] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9728; }","duration":"171.074759ms","start":"2026-10-17T03:27:11.387829Z","end":"2026-10-17T03:27:11.558903Z","steps":["trace[1686699097] 'agreement among raft nodes before linearized reading'  (duration: 170.992907ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:28:53.024939Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8036}
{"level":"info","ts":"2026-10-17T03:28:53.092571Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8036,"took":"65.864434ms","hash":844142441,"current-db-size-bytes":56573952,"current-db-size":"57 MB","current-db-size-in-use-bytes":28209152,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-17T03:28:53.092642Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":844142441,"revision":8036,"compact-revision":5881}
{"level":"info","ts":"2026-10-17T03:32:50.046935Z","caller":"traceutil/trace.go:171","msg":"trace[1017873286] transaction","detail":"{read_only:false; response_revision:12161; number_of_response:1; }","duration":"184.645756ms","start":"2026-10-17T03:32:49.862261Z","end":"2026-10-17T03:32:50.046907Z","steps":["trace[1017873286] 'process raft request'  (duration: 184.482111ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:33:53.032086Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10424}
{"level":"info","ts":"2026-10-17T03:33:53.136911Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10424,"took":"101.130785ms","hash":1472205718,"current-db-size-bytes":56573952,"current-db-size":"57 MB","current-db-size-in-use-bytes":26263552,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-10-17T03:33:53.136989Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1472205718,"revision":10424,"compact-revision":8036}
{"level":"info","ts":"2026-10-17T03:38:53.042552Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12598}
{"level":"info","ts":"2026-10-17T03:38:53.128092Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12598,"took":"83.266965ms","hash":1986003624,"current-db-size-bytes":56573952,"current-db-size":"57 MB","current-db-size-in-use-bytes":27869184,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-10-17T03:38:53.128183Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1986003624,"revision":12598,"compact-revision":10424}
{"level":"info","ts":"2026-10-17T03:39:00.859933Z","caller":"traceutil/trace.go:171","msg":"trace[266685951] transaction","detail":"{read_only:false; response_revision:14665; number_of_response:1; }","duration":"106.78495ms","start":"2026-10-17T03:39:00.753124Z","end":"2026-10-17T03:39:00.859909Z","steps":["trace[266685951] 'process raft request'  (duration: 106.305027ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:39:39.150229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.446299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-10-17T03:39:39.150307Z","caller":"traceutil/trace.go:171","msg":"trace[352473823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14874; }","duration":"113.575284ms","start":"2026-10-17T03:39:39.036713Z","end":"2026-10-17T03:39:39.150288Z","steps":["trace[352473823] 'range keys from in-memory index tree'  (duration: 113.265075ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:39:39.150392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.994403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-r9xc4\" ","response":"range_response_count:1 size:6520"}
{"level":"info","ts":"2026-10-17T03:39:39.150658Z","caller":"traceutil/trace.go:171","msg":"trace[852796372] range","detail":"{range_begin:/registry/pods/openstack/keepalived-r9xc4; range_end:; response_count:1; response_revision:14874; }","duration":"253.314712ms","start":"2026-10-17T03:39:38.897282Z","end":"2026-10-17T03:39:39.150597Z","steps":["trace[852796372] 'range keys from in-memory index tree'  (duration: 252.848549ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:39:39.150456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.479709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-17T03:39:39.150901Z","caller":"traceutil/trace.go:171","msg":"trace[674808023] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:14874; }","duration":"219.960252ms","start":"2026-10-17T03:39:38.930887Z","end":"2026-10-17T03:39:39.150847Z","steps":["trace[674808023] 'count revisions from in-memory index tree'  (duration: 219.331645ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:39:49.314832Z","caller":"traceutil/trace.go:171","msg":"trace[1116889250] linearizableReadLoop","detail":"{readStateIndex:15571; appliedIndex:15570; }","duration":"104.93262ms","start":"2026-10-17T03:39:49.20988Z","end":"2026-10-17T03:39:49.314813Z","steps":["trace[1116889250] 'read index received'  (duration: 104.707874ms)","trace[1116889250] 'applied index is now lower than readState.Index'  (duration: 223.956µs)"],"step_count":2}
{"level":"info","ts":"2026-10-17T03:39:49.31505Z","caller":"traceutil/trace.go:171","msg":"trace[1960255884] transaction","detail":"{read_only:false; response_revision:15047; number_of_response:1; }","duration":"110.558731ms","start":"2026-10-17T03:39:49.204409Z","end":"2026-10-17T03:39:49.314967Z","steps":["trace[1960255884] 'process raft request'  (duration: 110.249963ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:39:49.315237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.345231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"warn","ts":"2026-10-17T03:39:49.315479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.707707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"info","ts":"2026-10-17T03:39:49.315518Z","caller":"traceutil/trace.go:171","msg":"trace[2048987155] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:15047; }","duration":"103.787289ms","start":"2026-10-17T03:39:49.211718Z","end":"2026-10-17T03:39:49.315506Z","steps":["trace[2048987155] 'agreement among raft nodes before linearized reading'  (duration: 103.702956ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:39:49.315478Z","caller":"traceutil/trace.go:171","msg":"trace[130332235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15047; }","duration":"105.602488ms","start":"2026-10-17T03:39:49.209846Z","end":"2026-10-17T03:39:49.315449Z","steps":["trace[130332235] 'agreement among raft nodes before linearized reading'  (duration: 105.267299ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:39:49.563987Z","caller":"traceutil/trace.go:171","msg":"trace[1032418239] transaction","detail":"{read_only:false; response_revision:15048; number_of_response:1; }","duration":"244.00141ms","start":"2026-10-17T03:39:49.319958Z","end":"2026-10-17T03:39:49.56396Z","steps":["trace[1032418239] 'process raft request'  (duration: 223.928909ms)","trace[1032418239] 'compare'  (duration: 19.899857ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T03:39:49.564007Z","caller":"traceutil/trace.go:171","msg":"trace[1416770378] linearizableReadLoop","detail":"{readStateIndex:15572; appliedIndex:15571; }","duration":"243.842486ms","start":"2026-10-17T03:39:49.320141Z","end":"2026-10-17T03:39:49.563984Z","steps":["trace[1416770378] 'read index received'  (duration: 223.762524ms)","trace[1416770378] 'applied index is now lower than readState.Index'  (duration: 20.076992ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T03:39:49.564279Z","caller":"traceutil/trace.go:171","msg":"trace[183237448] transaction","detail":"{read_only:false; response_revision:15049; number_of_response:1; }","duration":"243.737593ms","start":"2026-10-17T03:39:49.320512Z","end":"2026-10-17T03:39:49.56425Z","steps":["trace[183237448] 'process raft request'  (duration: 243.430565ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:39:49.564445Z","caller":"traceutil/trace.go:171","msg":"trace[849855408] transaction","detail":"{read_only:false; response_revision:15050; number_of_response:1; }","duration":"197.693692ms","start":"2026-10-17T03:39:49.366739Z","end":"2026-10-17T03:39:49.564433Z","steps":["trace[849855408] 'process raft request'  (duration: 197.404354ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:39:49.564432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.133666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-17T03:39:49.564504Z","caller":"traceutil/trace.go:171","msg":"trace[1481381234] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:15050; }","duration":"118.258899ms","start":"2026-10-17T03:39:49.446226Z","end":"2026-10-17T03:39:49.564485Z","steps":["trace[1481381234] 'agreement among raft nodes before linearized reading'  (duration: 118.125376ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:39:49.564851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.684049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:67 size:632501"}
{"level":"info","ts":"2026-10-17T03:39:49.564908Z","caller":"traceutil/trace.go:171","msg":"trace[1145755455] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:67; response_revision:15049; }","duration":"244.776821ms","start":"2026-10-17T03:39:49.320117Z","end":"2026-10-17T03:39:49.564894Z","steps":["trace[1145755455] 'agreement among raft nodes before linearized reading'  (duration: 243.953039ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:41:14.371803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.610896ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10346353048849242686 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:16048 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-10-17T03:41:14.371929Z","caller":"traceutil/trace.go:171","msg":"trace[1387267512] linearizableReadLoop","detail":"{readStateIndex:16613; appliedIndex:16612; }","duration":"226.362134ms","start":"2026-10-17T03:41:14.145547Z","end":"2026-10-17T03:41:14.371909Z","steps":["trace[1387267512] 'read index received'  (duration: 73.489661ms)","trace[1387267512] 'applied index is now lower than readState.Index'  (duration: 152.870873ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T03:41:14.37201Z","caller":"traceutil/trace.go:171","msg":"trace[666932070] transaction","detail":"{read_only:false; response_revision:16057; number_of_response:1; }","duration":"334.947553ms","start":"2026-10-17T03:41:14.037047Z","end":"2026-10-17T03:41:14.371995Z","steps":["trace[666932070] 'process raft request'  (duration: 182.05788ms)","trace[666932070] 'compare'  (duration: 152.346759ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T03:41:14.372084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T03:41:14.037015Z","time spent":"335.027246ms","remote":"127.0.0.1:36822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:16048 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-10-17T03:41:14.372265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.716564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-10-17T03:41:14.372321Z","caller":"traceutil/trace.go:171","msg":"trace[683582282] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:16057; }","duration":"226.776296ms","start":"2026-10-17T03:41:14.14553Z","end":"2026-10-17T03:41:14.372306Z","steps":["trace[683582282] 'agreement among raft nodes before linearized reading'  (duration: 226.500818ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:41:14.379681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"}
{"level":"info","ts":"2026-10-17T03:41:14.37974Z","caller":"traceutil/trace.go:171","msg":"trace[1222965597] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16058; }","duration":"116.185333ms","start":"2026-10-17T03:41:14.263537Z","end":"2026-10-17T03:41:14.379722Z","steps":["trace[1222965597] 'agreement among raft nodes before linearized reading'  (duration: 116.030529ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:41:14.379989Z","caller":"traceutil/trace.go:171","msg":"trace[548048606] transaction","detail":"{read_only:false; response_revision:16058; number_of_response:1; }","duration":"157.634901ms","start":"2026-10-17T03:41:14.222326Z","end":"2026-10-17T03:41:14.379961Z","steps":["trace[548048606] 'process raft request'  (duration: 157.145738ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:41:14.546659Z","caller":"traceutil/trace.go:171","msg":"trace[943077036] linearizableReadLoop","detail":"{readStateIndex:16615; appliedIndex:16614; }","duration":"159.027678ms","start":"2026-10-17T03:41:14.387605Z","end":"2026-10-17T03:41:14.546632Z","steps":["trace[943077036] 'read index received'  (duration: 136.47006ms)","trace[943077036] 'applied index is now lower than readState.Index'  (duration: 22.556538ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T03:41:14.546687Z","caller":"traceutil/trace.go:171","msg":"trace[1068542173] transaction","detail":"{read_only:false; response_revision:16059; number_of_response:1; }","duration":"160.067286ms","start":"2026-10-17T03:41:14.386585Z","end":"2026-10-17T03:41:14.546652Z","steps":["trace[1068542173] 'process raft request'  (duration: 137.60068ms)","trace[1068542173] 'compare'  (duration: 22.313111ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T03:41:14.546829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.50481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T03:41:14.546869Z","caller":"traceutil/trace.go:171","msg":"trace[1422689211] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16059; }","duration":"146.584282ms","start":"2026-10-17T03:41:14.400274Z","end":"2026-10-17T03:41:14.546858Z","steps":["trace[1422689211] 'agreement among raft nodes before linearized reading'  (duration: 146.49943ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:41:14.547113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.837237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-10-17T03:41:14.547165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.610516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T03:41:14.547194Z","caller":"traceutil/trace.go:171","msg":"trace[241162466] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16059; }","duration":"130.958921ms","start":"2026-10-17T03:41:14.416219Z","end":"2026-10-17T03:41:14.547178Z","steps":["trace[241162466] 'agreement among raft nodes before linearized reading'  (duration: 130.853368ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:41:14.547198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.789621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-10-17T03:41:14.547245Z","caller":"traceutil/trace.go:171","msg":"trace[1018048453] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16059; }","duration":"145.876733ms","start":"2026-10-17T03:41:14.401356Z","end":"2026-10-17T03:41:14.547233Z","steps":["trace[1018048453] 'agreement among raft nodes before linearized reading'  (duration: 145.778231ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:41:14.547198Z","caller":"traceutil/trace.go:171","msg":"trace[28413962] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16059; }","duration":"145.681238ms","start":"2026-10-17T03:41:14.401507Z","end":"2026-10-17T03:41:14.547188Z","steps":["trace[28413962] 'agreement among raft nodes before linearized reading'  (duration: 145.612496ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:41:14.547248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.595517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"}
{"level":"warn","ts":"2026-10-17T03:41:14.547407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.491829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"info","ts":"2026-10-17T03:41:14.547412Z","caller":"traceutil/trace.go:171","msg":"trace[1297381402] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16059; }","duration":"128.826463ms","start":"2026-10-17T03:41:14.418559Z","end":"2026-10-17T03:41:14.547385Z","steps":["trace[1297381402] 'agreement among raft nodes before linearized reading'  (duration: 128.280329ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:41:14.547454Z","caller":"traceutil/trace.go:171","msg":"trace[39340322] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16059; }","duration":"133.567981ms","start":"2026-10-17T03:41:14.413872Z","end":"2026-10-17T03:41:14.54744Z","steps":["trace[39340322] 'agreement among raft nodes before linearized reading'  (duration: 133.17933ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:41:14.547801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.085439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"}
{"level":"info","ts":"2026-10-17T03:41:14.547837Z","caller":"traceutil/trace.go:171","msg":"trace[299390166] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16059; }","duration":"126.150871ms","start":"2026-10-17T03:41:14.421676Z","end":"2026-10-17T03:41:14.547827Z","steps":["trace[299390166] 'agreement among raft nodes before linearized reading'  (duration: 125.639157ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:41:14.54795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.338633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:772515"}
{"level":"info","ts":"2026-10-17T03:41:14.547985Z","caller":"traceutil/trace.go:171","msg":"trace[1753445222] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:16059; }","duration":"160.400384ms","start":"2026-10-17T03:41:14.387575Z","end":"2026-10-17T03:41:14.547975Z","steps":["trace[1753445222] 'agreement among raft nodes before linearized reading'  (duration: 159.160111ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:43:53.04979Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14618}
{"level":"info","ts":"2026-10-17T03:43:53.129335Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14618,"took":"76.646887ms","hash":872204058,"current-db-size-bytes":56573952,"current-db-size":"57 MB","current-db-size-in-use-bytes":32223232,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-17T03:43:53.129405Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":872204058,"revision":14618,"compact-revision":12598}
{"level":"info","ts":"2026-10-17T03:47:13.761029Z","caller":"traceutil/trace.go:171","msg":"trace[1000991390] transaction","detail":"{read_only:false; response_revision:18744; number_of_response:1; }","duration":"106.941127ms","start":"2026-10-17T03:47:13.654064Z","end":"2026-10-17T03:47:13.761005Z","steps":["trace[1000991390] 'process raft request'  (duration: 106.797393ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:48:04.79491Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d01cde7b2aa18f95","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-17T03:48:04.822686Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-10-17T03:48:04.822829Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-10-17T03:48:53.071421Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17115}
{"level":"info","ts":"2026-10-17T03:48:53.178433Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17115,"took":"103.527915ms","hash":1397257996,"current-db-size-bytes":56573952,"current-db-size":"57 MB","current-db-size-in-use-bytes":34160640,"current-db-size-in-use":"34 MB"}
{"level":"info","ts":"2026-10-17T03:48:53.178505Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1397257996,"revision":17115,"compact-revision":14618}
{"level":"info","ts":"2026-10-17T03:53:20.200281Z","caller":"traceutil/trace.go:171","msg":"trace[387303747] transaction","detail":"{read_only:false; response_revision:21471; number_of_response:1; }","duration":"143.697419ms","start":"2026-10-17T03:53:20.05656Z","end":"2026-10-17T03:53:20.200258Z","steps":["trace[387303747] 'process raft request'  (duration: 143.498223ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:53:25.576107Z","caller":"traceutil/trace.go:171","msg":"trace[1360632090] transaction","detail":"{read_only:false; response_revision:21495; number_of_response:1; }","duration":"101.701725ms","start":"2026-10-17T03:53:25.474382Z","end":"2026-10-17T03:53:25.576084Z","steps":["trace[1360632090] 'process raft request'  (duration: 101.503679ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:53:25.793265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.319768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-10-17T03:53:25.793356Z","caller":"traceutil/trace.go:171","msg":"trace[1920111622] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21495; }","duration":"153.467242ms","start":"2026-10-17T03:53:25.639869Z","end":"2026-10-17T03:53:25.793336Z","steps":["trace[1920111622] 'range keys from in-memory index tree'  (duration: 153.092982ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:53:25.882834Z","caller":"traceutil/trace.go:171","msg":"trace[309695051] transaction","detail":"{read_only:false; response_revision:21496; number_of_response:1; }","duration":"117.771029ms","start":"2026-10-17T03:53:25.765034Z","end":"2026-10-17T03:53:25.882805Z","steps":["trace[309695051] 'process raft request'  (duration: 117.569783ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:53:26.051712Z","caller":"traceutil/trace.go:171","msg":"trace[177033884] transaction","detail":"{read_only:false; response_revision:21497; number_of_response:1; }","duration":"252.66868ms","start":"2026-10-17T03:53:25.799022Z","end":"2026-10-17T03:53:26.05169Z","steps":["trace[177033884] 'process raft request'  (duration: 252.501336ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:53:26.052031Z","caller":"traceutil/trace.go:171","msg":"trace[373203409] linearizableReadLoop","detail":"{readStateIndex:22235; appliedIndex:22232; }","duration":"140.517673ms","start":"2026-10-17T03:53:25.911479Z","end":"2026-10-17T03:53:26.051997Z","steps":["trace[373203409] 'read index received'  (duration: 139.926257ms)","trace[373203409] 'applied index is now lower than readState.Index'  (duration: 590.156µs)"],"step_count":2}
{"level":"info","ts":"2026-10-17T03:53:26.052161Z","caller":"traceutil/trace.go:171","msg":"trace[2107152226] transaction","detail":"{read_only:false; response_revision:21498; number_of_response:1; }","duration":"231.821208ms","start":"2026-10-17T03:53:25.820322Z","end":"2026-10-17T03:53:26.052144Z","steps":["trace[2107152226] 'process raft request'  (duration: 231.328914ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:53:26.052255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.76658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-10-17T03:53:26.052289Z","caller":"traceutil/trace.go:171","msg":"trace[1143381650] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21499; }","duration":"140.851542ms","start":"2026-10-17T03:53:25.911426Z","end":"2026-10-17T03:53:26.052278Z","steps":["trace[1143381650] 'agreement among raft nodes before linearized reading'  (duration: 140.677567ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:53:26.052422Z","caller":"traceutil/trace.go:171","msg":"trace[426212575] transaction","detail":"{read_only:false; response_revision:21499; number_of_response:1; }","duration":"231.982002ms","start":"2026-10-17T03:53:25.820423Z","end":"2026-10-17T03:53:26.052405Z","steps":["trace[426212575] 'process raft request'  (duration: 231.451257ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:53:26.244843Z","caller":"traceutil/trace.go:171","msg":"trace[267971491] transaction","detail":"{read_only:false; response_revision:21500; number_of_response:1; }","duration":"187.890051ms","start":"2026-10-17T03:53:26.056922Z","end":"2026-10-17T03:53:26.244812Z","steps":["trace[267971491] 'process raft request'  (duration: 124.363386ms)","trace[267971491] 'compare'  (duration: 63.233897ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T03:53:26.49192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.748793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-17T03:53:26.492003Z","caller":"traceutil/trace.go:171","msg":"trace[1275951102] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21501; }","duration":"102.891947ms","start":"2026-10-17T03:53:26.389092Z","end":"2026-10-17T03:53:26.491984Z","steps":["trace[1275951102] 'range keys from in-memory index tree'  (duration: 102.6245ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:53:26.492325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.701913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.86\" ","response":"range_response_count:1 size:137"}
{"level":"info","ts":"2026-10-17T03:53:26.492412Z","caller":"traceutil/trace.go:171","msg":"trace[775712426] range","detail":"{range_begin:/registry/masterleases/162.253.55.86; range_end:; response_count:1; response_revision:21501; }","duration":"115.842307ms","start":"2026-10-17T03:53:26.376549Z","end":"2026-10-17T03:53:26.492391Z","steps":["trace[775712426] 'range keys from in-memory index tree'  (duration: 115.499448ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:53:26.851025Z","caller":"traceutil/trace.go:171","msg":"trace[1242519848] transaction","detail":"{read_only:false; response_revision:21503; number_of_response:1; }","duration":"353.40202ms","start":"2026-10-17T03:53:26.497556Z","end":"2026-10-17T03:53:26.850958Z","steps":["trace[1242519848] 'process raft request'  (duration: 353.074561ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:53:26.851313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T03:53:26.497523Z","time spent":"353.628985ms","remote":"127.0.0.1:36822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:21492 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-10-17T03:53:26.851263Z","caller":"traceutil/trace.go:171","msg":"trace[1415242499] transaction","detail":"{read_only:false; response_revision:21504; number_of_response:1; }","duration":"353.165743ms","start":"2026-10-17T03:53:26.498056Z","end":"2026-10-17T03:53:26.851222Z","steps":["trace[1415242499] 'process raft request'  (duration: 352.832434ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:53:26.85157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T03:53:26.498033Z","time spent":"353.387969ms","remote":"127.0.0.1:36600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":119,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/masterleases/162.253.55.86\" mod_revision:21452 > success:<request_put:<key:\"/registry/masterleases/162.253.55.86\" value_size:67 lease:1122981011994484953 >> failure:<request_range:<key:\"/registry/masterleases/162.253.55.86\" > >"}
{"level":"info","ts":"2026-10-17T03:53:27.018688Z","caller":"traceutil/trace.go:171","msg":"trace[644356100] transaction","detail":"{read_only:false; response_revision:21505; number_of_response:1; }","duration":"328.138108ms","start":"2026-10-17T03:53:26.6905Z","end":"2026-10-17T03:53:27.018638Z","steps":["trace[644356100] 'process raft request'  (duration: 255.027114ms)","trace[644356100] 'compare'  (duration: 72.563189ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T03:53:27.018705Z","caller":"traceutil/trace.go:171","msg":"trace[816715268] linearizableReadLoop","detail":"{readStateIndex:22243; appliedIndex:22241; }","duration":"165.165838ms","start":"2026-10-17T03:53:26.853497Z","end":"2026-10-17T03:53:27.018663Z","steps":["trace[816715268] 'read index received'  (duration: 91.973623ms)","trace[816715268] 'applied index is now lower than readState.Index'  (duration: 73.190445ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T03:53:27.018794Z","caller":"traceutil/trace.go:171","msg":"trace[789224439] transaction","detail":"{read_only:false; response_revision:21506; number_of_response:1; }","duration":"285.100095ms","start":"2026-10-17T03:53:26.73367Z","end":"2026-10-17T03:53:27.01877Z","steps":["trace[789224439] 'process raft request'  (duration: 284.784007ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:53:27.018852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T03:53:26.690473Z","time spent":"328.293571ms","remote":"127.0.0.1:36822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:21494 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-10-17T03:53:27.019031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.486817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"}
{"level":"info","ts":"2026-10-17T03:53:27.019109Z","caller":"traceutil/trace.go:171","msg":"trace[2015852972] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:21506; }","duration":"165.645071ms","start":"2026-10-17T03:53:26.853447Z","end":"2026-10-17T03:53:27.019092Z","steps":["trace[2015852972] 'agreement among raft nodes before linearized reading'  (duration: 165.350243ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:53:53.07902Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19699}
{"level":"info","ts":"2026-10-17T03:53:53.202922Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19699,"took":"120.541494ms","hash":370709397,"current-db-size-bytes":56573952,"current-db-size":"57 MB","current-db-size-in-use-bytes":28934144,"current-db-size-in-use":"29 MB"}
{"level":"info","ts":"2026-10-17T03:53:53.203016Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":370709397,"revision":19699,"compact-revision":17115}
{"level":"info","ts":"2026-10-17T03:55:03.506442Z","caller":"traceutil/trace.go:171","msg":"trace[839487400] linearizableReadLoop","detail":"{readStateIndex:23128; appliedIndex:23127; }","duration":"117.302606ms","start":"2026-10-17T03:55:03.38911Z","end":"2026-10-17T03:55:03.506413Z","steps":["trace[839487400] 'read index received'  (duration: 116.950807ms)","trace[839487400] 'applied index is now lower than readState.Index'  (duration: 350.189µs)"],"step_count":2}
{"level":"info","ts":"2026-10-17T03:55:03.506595Z","caller":"traceutil/trace.go:171","msg":"trace[2034570104] transaction","detail":"{read_only:false; response_revision:22357; number_of_response:1; }","duration":"125.573479ms","start":"2026-10-17T03:55:03.380986Z","end":"2026-10-17T03:55:03.506559Z","steps":["trace[2034570104] 'process raft request'  (duration: 125.22383ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T03:55:03.506671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.543473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-17T03:55:03.50675Z","caller":"traceutil/trace.go:171","msg":"trace[348289138] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22357; }","duration":"117.679436ms","start":"2026-10-17T03:55:03.389057Z","end":"2026-10-17T03:55:03.506736Z","steps":["trace[348289138] 'agreement among raft nodes before linearized reading'  (duration: 117.509692ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:57:40.862454Z","caller":"traceutil/trace.go:171","msg":"trace[384520401] transaction","detail":"{read_only:false; response_revision:24069; number_of_response:1; }","duration":"128.021027ms","start":"2026-10-17T03:57:40.734407Z","end":"2026-10-17T03:57:40.862428Z","steps":["trace[384520401] 'process raft request'  (duration: 127.827902ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T03:58:53.08669Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21640}
{"level":"info","ts":"2026-10-17T03:58:53.201176Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21640,"took":"110.729161ms","hash":398511108,"current-db-size-bytes":56573952,"current-db-size":"57 MB","current-db-size-in-use-bytes":43016192,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-10-17T03:58:53.201389Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":398511108,"revision":21640,"compact-revision":19699}
{"level":"info","ts":"2026-10-17T03:59:08.572716Z","caller":"traceutil/trace.go:171","msg":"trace[1313166741] transaction","detail":"{read_only:false; response_revision:24990; number_of_response:1; }","duration":"107.837982ms","start":"2026-10-17T03:59:08.46484Z","end":"2026-10-17T03:59:08.572678Z","steps":["trace[1313166741] 'process raft request'  (duration: 107.740589ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T04:00:23.748845Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000067e9.wal"}
{"level":"info","ts":"2026-10-17T04:01:16.04718Z","caller":"traceutil/trace.go:171","msg":"trace[933516401] transaction","detail":"{read_only:false; response_revision:26234; number_of_response:1; }","duration":"102.194189ms","start":"2026-10-17T04:01:15.94496Z","end":"2026-10-17T04:01:16.047154Z","steps":["trace[933516401] 'process raft request'  (duration: 102.012555ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T04:01:16.370041Z","caller":"traceutil/trace.go:171","msg":"trace[1585325329] linearizableReadLoop","detail":"{readStateIndex:27105; appliedIndex:27104; }","duration":"195.362755ms","start":"2026-10-17T04:01:16.174659Z","end":"2026-10-17T04:01:16.370022Z","steps":["trace[1585325329] 'read index received'  (duration: 195.300533ms)","trace[1585325329] 'applied index is now lower than readState.Index'  (duration: 61.502µs)"],"step_count":2}
{"level":"info","ts":"2026-10-17T04:01:16.370126Z","caller":"traceutil/trace.go:171","msg":"trace[332904632] transaction","detail":"{read_only:false; response_revision:26235; number_of_response:1; }","duration":"419.821985ms","start":"2026-10-17T04:01:15.950283Z","end":"2026-10-17T04:01:16.370105Z","steps":["trace[332904632] 'process raft request'  (duration: 419.61442ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T04:01:16.370173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.493689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-10-17T04:01:16.370227Z","caller":"traceutil/trace.go:171","msg":"trace[176664483] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:26235; }","duration":"195.604052ms","start":"2026-10-17T04:01:16.174591Z","end":"2026-10-17T04:01:16.370195Z","steps":["trace[176664483] 'agreement among raft nodes before linearized reading'  (duration: 195.514899ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T04:01:16.370264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T04:01:15.950263Z","time spent":"419.911248ms","remote":"127.0.0.1:36822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:26221 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-10-17T04:02:24.739327Z","caller":"traceutil/trace.go:171","msg":"trace[525137365] transaction","detail":"{read_only:false; response_revision:26837; number_of_response:1; }","duration":"102.903058ms","start":"2026-10-17T04:02:24.6364Z","end":"2026-10-17T04:02:24.739303Z","steps":["trace[525137365] 'process raft request'  (duration: 102.199119ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T04:02:24.894288Z","caller":"traceutil/trace.go:171","msg":"trace[289765060] transaction","detail":"{read_only:false; response_revision:26838; number_of_response:1; }","duration":"146.520256ms","start":"2026-10-17T04:02:24.747743Z","end":"2026-10-17T04:02:24.894263Z","steps":["trace[289765060] 'process raft request'  (duration: 102.936619ms)","trace[289765060] 'compare'  (duration: 43.279769ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T04:02:25.183928Z","caller":"traceutil/trace.go:171","msg":"trace[741707497] transaction","detail":"{read_only:false; response_revision:26840; number_of_response:1; }","duration":"132.930479ms","start":"2026-10-17T04:02:25.05097Z","end":"2026-10-17T04:02:25.183901Z","steps":["trace[741707497] 'process raft request'  (duration: 125.541109ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T04:02:25.350408Z","caller":"traceutil/trace.go:171","msg":"trace[802259778] transaction","detail":"{read_only:false; response_revision:26841; number_of_response:1; }","duration":"156.161506ms","start":"2026-10-17T04:02:25.194201Z","end":"2026-10-17T04:02:25.350362Z","steps":["trace[802259778] 'process raft request'  (duration: 155.995342ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T04:02:25.669963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.998431ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10346353048849274729 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26826 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:18"}
{"level":"info","ts":"2026-10-17T04:02:25.670151Z","caller":"traceutil/trace.go:171","msg":"trace[240486984] transaction","detail":"{read_only:false; response_revision:26843; number_of_response:1; }","duration":"302.412876ms","start":"2026-10-17T04:02:25.367704Z","end":"2026-10-17T04:02:25.670117Z","steps":["trace[240486984] 'process raft request'  (duration: 149.162158ms)","trace[240486984] 'compare'  (duration: 152.869838ms)"],"step_count":2}
{"level":"info","ts":"2026-10-17T04:02:25.6702Z","caller":"traceutil/trace.go:171","msg":"trace[1383026324] transaction","detail":"{read_only:false; response_revision:26844; number_of_response:1; }","duration":"209.567559ms","start":"2026-10-17T04:02:25.460617Z","end":"2026-10-17T04:02:25.670184Z","steps":["trace[1383026324] 'process raft request'  (duration: 209.477646ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T04:02:25.670345Z","caller":"traceutil/trace.go:171","msg":"trace[1062749218] linearizableReadLoop","detail":"{readStateIndex:27729; appliedIndex:27728; }","duration":"283.205757ms","start":"2026-10-17T04:02:25.38709Z","end":"2026-10-17T04:02:25.670296Z","steps":["trace[1062749218] 'read index received'  (duration: 129.710052ms)","trace[1062749218] 'applied index is now lower than readState.Index'  (duration: 153.492315ms)"],"step_count":2}
{"level":"warn","ts":"2026-10-17T04:02:25.670509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.400712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"warn","ts":"2026-10-17T04:02:25.670573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T04:02:25.367687Z","time spent":"302.512868ms","remote":"127.0.0.1:36822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:26826 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"info","ts":"2026-10-17T04:02:25.67059Z","caller":"traceutil/trace.go:171","msg":"trace[632559001] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26844; }","duration":"283.515855ms","start":"2026-10-17T04:02:25.387057Z","end":"2026-10-17T04:02:25.670573Z","steps":["trace[632559001] 'agreement among raft nodes before linearized reading'  (duration: 283.361081ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T04:02:25.680073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.762758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-10-17T04:02:25.68014Z","caller":"traceutil/trace.go:171","msg":"trace[1825776689] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26845; }","duration":"241.869821ms","start":"2026-10-17T04:02:25.438253Z","end":"2026-10-17T04:02:25.680123Z","steps":["trace[1825776689] 'agreement among raft nodes before linearized reading'  (duration: 241.720787ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T04:02:46.163208Z","caller":"traceutil/trace.go:171","msg":"trace[1317013534] transaction","detail":"{read_only:false; response_revision:26995; number_of_response:1; }","duration":"108.692315ms","start":"2026-10-17T04:02:46.054485Z","end":"2026-10-17T04:02:46.163177Z","steps":["trace[1317013534] 'process raft request'  (duration: 108.429157ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T04:02:46.354426Z","caller":"traceutil/trace.go:171","msg":"trace[2085832237] linearizableReadLoop","detail":"{readStateIndex:27886; appliedIndex:27885; }","duration":"183.221448ms","start":"2026-10-17T04:02:46.171174Z","end":"2026-10-17T04:02:46.354396Z","steps":["trace[2085832237] 'read index received'  (duration: 183.027833ms)","trace[2085832237] 'applied index is now lower than readState.Index'  (duration: 192.255µs)"],"step_count":2}
{"level":"info","ts":"2026-10-17T04:02:46.354472Z","caller":"traceutil/trace.go:171","msg":"trace[1331961861] transaction","detail":"{read_only:false; response_revision:26996; number_of_response:1; }","duration":"254.139352ms","start":"2026-10-17T04:02:46.100302Z","end":"2026-10-17T04:02:46.354442Z","steps":["trace[1331961861] 'process raft request'  (duration: 253.930496ms)"],"step_count":1}
{"level":"warn","ts":"2026-10-17T04:02:46.354658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.473964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12432"}
{"level":"info","ts":"2026-10-17T04:02:46.354698Z","caller":"traceutil/trace.go:171","msg":"trace[908516499] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26996; }","duration":"183.573797ms","start":"2026-10-17T04:02:46.171114Z","end":"2026-10-17T04:02:46.354688Z","steps":["trace[908516499] 'agreement among raft nodes before linearized reading'  (duration: 183.393562ms)"],"step_count":1}
{"level":"info","ts":"2026-10-17T04:03:53.096688Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24871}
{"level":"info","ts":"2026-10-17T04:03:53.263594Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24871,"took":"162.683007ms","hash":459416241,"current-db-size-bytes":56995840,"current-db-size":"57 MB","current-db-size-in-use-bytes":36306944,"current-db-size-in-use":"36 MB"}
{"level":"info","ts":"2026-10-17T04:03:53.263702Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":459416241,"revision":24871,"compact-revision":21640}
{"level":"info","ts":"2026-10-17T04:06:12.053914Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d01cde7b2aa18f95","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-17T04:06:12.063884Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-10-17T04:06:12.064065Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-10-17T04:08:53.107061Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27665}
{"level":"info","ts":"2026-10-17T04:08:53.243062Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27665,"took":"131.73834ms","hash":2765208192,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":37462016,"current-db-size-in-use":"38 MB"}
{"level":"info","ts":"2026-10-17T04:08:53.243195Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2765208192,"revision":27665,"compact-revision":24871}
{"level":"info","ts":"2026-10-17T04:13:53.113436Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30392}
{"level":"info","ts":"2026-10-17T04:13:53.26465Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30392,"took":"147.078434ms","hash":1420297634,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":31748096,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-17T04:13:53.26471Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1420297634,"revision":30392,"compact-revision":27665}
{"level":"info","ts":"2026-10-17T04:18:53.120216Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32647}
{"level":"info","ts":"2026-10-17T04:18:53.27333Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32647,"took":"148.714448ms","hash":1672227183,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":31293440,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-10-17T04:18:53.273398Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1672227183,"revision":32647,"compact-revision":30392}
{"level":"info","ts":"2026-10-17T04:23:53.127474Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34880}
{"level":"info","ts":"2026-10-17T04:23:53.263033Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34880,"took":"131.571336ms","hash":4156628487,"current-db-size-bytes":58261504,"current-db-size":"58 MB","current-db-size-in-use-bytes":32309248,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-17T04:23:53.263101Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4156628487,"revision":34880,"compact-revision":32647}
{"level":"info","ts":"2026-10-17T04:27:23.36941Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d01cde7b2aa18f95","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-10-17T04:27:23.376751Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004}
{"level":"info","ts":"2026-10-17T04:27:23.377042Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}
{"level":"info","ts":"2026-10-17T04:28:53.134764Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37174}
{"level":"info","ts":"2026-10-17T04:28:53.27908Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37174,"took":"139.739318ms","hash":1228677200,"current-db-size-bytes":59105280,"current-db-size":"59 MB","current-db-size-in-use-bytes":33087488,"current-db-size-in-use":"33 MB"}
{"level":"info","ts":"2026-10-17T04:28:53.279167Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1228677200,"revision":37174,"compact-revision":34880}
{"level":"info","ts":"2026-10-17T04:33:53.145122Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39449}
{"level":"info","ts":"2026-10-17T04:33:53.279285Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39449,"took":"130.201589ms","hash":2045552341,"current-db-size-bytes":61222912,"current-db-size":"61 MB","current-db-size-in-use-bytes":32247808,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-10-17T04:33:53.279351Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2045552341,"revision":39449,"compact-revision":37174}