{"level":"warn","ts":"2026-07-27T20:03:32.555223Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-27T20:03:32.555314Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.169:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.169:2380","--initial-cluster=instance=https://199.204.45.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.169: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-07-27T20:03:32.555417Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-27T20:03:32.555432Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-07-27T20:03:32.555451Z","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-07-27T20:03:32.555996Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"]} {"level":"info","ts":"2026-07-27T20:03:32.556071Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.169: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-07-27T20:03:32.558846Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.555081ms"} {"level":"info","ts":"2026-07-27T20:03:32.564058Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-07-27T20:03:32.564134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-07-27T20:03:32.564162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-07-27T20:03:32.564172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1c917701ce165bac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-27T20:03:32.564188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-07-27T20:03:32.564222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-07-27T20:03:32.568991Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-27T20:03:32.571444Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-27T20:03:32.572683Z","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-07-27T20:03:32.576729Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1c917701ce165bac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-27T20:03:32.577477Z","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-07-27T20:03:32.577642Z","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-07-27T20:03:32.57757Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1c917701ce165bac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-27T20:03:32.577673Z","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-07-27T20:03:32.57859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-07-27T20:03:32.578768Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","added-peer-id":"1c917701ce165bac","added-peer-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-07-27T20:03:32.58497Z","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-07-27T20:03:32.585041Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-07-27T20:03:32.585082Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-07-27T20:03:32.585392Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1c917701ce165bac","initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-27T20:03:32.585426Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-27T20:03:33.267199Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-07-27T20:03:33.267276Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-07-27T20:03:33.267312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-07-27T20:03:33.267333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-07-27T20:03:33.26735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-07-27T20:03:33.267366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-07-27T20:03:33.267386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-07-27T20:03:33.268499Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T20:03:33.269258Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1c917701ce165bac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.169:2379]}","request-path":"/0/members/1c917701ce165bac/attributes","cluster-id":"bfb5247022b87cb1","publish-timeout":"7s"} {"level":"info","ts":"2026-07-27T20:03:33.269288Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-27T20:03:33.269338Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-27T20:03:33.269648Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-27T20:03:33.269705Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-27T20:03:33.269876Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T20:03:33.270054Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T20:03:33.270084Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-27T20:03:33.271218Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-27T20:03:33.271491Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"warn","ts":"2026-07-27T20:04:14.920976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.350827ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-27T20:04:14.921101Z","caller":"traceutil/trace.go:171","msg":"trace[407774350] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"147.478483ms","start":"2026-07-27T20:04:14.773606Z","end":"2026-07-27T20:04:14.921084Z","steps":["trace[407774350] 'read index received' (duration: 37.567061ms)","trace[407774350] 'applied index is now lower than readState.Index' (duration: 109.910392ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:04:14.92115Z","caller":"traceutil/trace.go:171","msg":"trace[1316379989] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"236.359073ms","start":"2026-07-27T20:04:14.684755Z","end":"2026-07-27T20:04:14.921114Z","steps":["trace[1316379989] 'process raft request' (duration: 126.357288ms)","trace[1316379989] 'compare' (duration: 109.213223ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:04:14.921261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.657428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T20:04:14.921299Z","caller":"traceutil/trace.go:171","msg":"trace[962907367] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"147.73848ms","start":"2026-07-27T20:04:14.773552Z","end":"2026-07-27T20:04:14.92129Z","steps":["trace[962907367] 'agreement among raft nodes before linearized reading' (duration: 147.629767ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:04:15.456859Z","caller":"traceutil/trace.go:171","msg":"trace[1812261584] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"299.837521ms","start":"2026-07-27T20:04:15.156987Z","end":"2026-07-27T20:04:15.456824Z","steps":["trace[1812261584] 'read index received' (duration: 299.604565ms)","trace[1812261584] 'applied index is now lower than readState.Index' (duration: 232.066µs)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:04:15.45718Z","caller":"traceutil/trace.go:171","msg":"trace[1068747518] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"447.538409ms","start":"2026-07-27T20:04:15.009439Z","end":"2026-07-27T20:04:15.456978Z","steps":["trace[1068747518] 'process raft request' (duration: 447.239221ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:04:15.457105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.152599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-07-27T20:04:15.457446Z","caller":"traceutil/trace.go:171","msg":"trace[1862254197] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:590; }","duration":"300.571112ms","start":"2026-07-27T20:04:15.156848Z","end":"2026-07-27T20:04:15.457419Z","steps":["trace[1862254197] 'agreement among raft nodes before linearized reading' (duration: 300.085618ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:04:15.457542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:04:15.156807Z","time spent":"300.704135ms","remote":"127.0.0.1:52176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-27T20:04:15.457853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:04:15.009409Z","time spent":"447.960771ms","remote":"127.0.0.1:52106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T20:04:15.475446Z","caller":"traceutil/trace.go:171","msg":"trace[1390620192] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"109.683787ms","start":"2026-07-27T20:04:15.365737Z","end":"2026-07-27T20:04:15.475421Z","steps":["trace[1390620192] 'process raft request' (duration: 109.225184ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:05:48.716743Z","caller":"traceutil/trace.go:171","msg":"trace[1325759202] linearizableReadLoop","detail":"{readStateIndex:1901; appliedIndex:1900; }","duration":"216.339268ms","start":"2026-07-27T20:05:48.50038Z","end":"2026-07-27T20:05:48.71672Z","steps":["trace[1325759202] 'read index received' (duration: 216.205744ms)","trace[1325759202] 'applied index is now lower than readState.Index' (duration: 132.534µs)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:05:48.716825Z","caller":"traceutil/trace.go:171","msg":"trace[371872740] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"238.224313ms","start":"2026-07-27T20:05:48.478555Z","end":"2026-07-27T20:05:48.71678Z","steps":["trace[371872740] 'process raft request' (duration: 238.028587ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:05:48.716929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.405064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-76885033-3dfd-4acb-bfff-84cea0dfd76a\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-07-27T20:05:48.716968Z","caller":"traceutil/trace.go:171","msg":"trace[451222999] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-76885033-3dfd-4acb-bfff-84cea0dfd76a; range_end:; response_count:1; response_revision:1831; }","duration":"155.496526ms","start":"2026-07-27T20:05:48.56146Z","end":"2026-07-27T20:05:48.716957Z","steps":["trace[451222999] 'agreement among raft nodes before linearized reading' (duration: 155.419284ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:05:48.717037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.640906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-27T20:05:48.717125Z","caller":"traceutil/trace.go:171","msg":"trace[701663013] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1831; }","duration":"216.77782ms","start":"2026-07-27T20:05:48.500327Z","end":"2026-07-27T20:05:48.717104Z","steps":["trace[701663013] 'agreement among raft nodes before linearized reading' (duration: 216.529253ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:06:00.165485Z","caller":"traceutil/trace.go:171","msg":"trace[229678742] transaction","detail":"{read_only:false; response_revision:1935; number_of_response:1; }","duration":"120.611193ms","start":"2026-07-27T20:06:00.044849Z","end":"2026-07-27T20:06:00.16546Z","steps":["trace[229678742] 'process raft request' (duration: 120.438168ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:06:39.701827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.330499ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-27T20:06:39.702197Z","caller":"traceutil/trace.go:171","msg":"trace[302035022] linearizableReadLoop","detail":"{readStateIndex:2240; appliedIndex:2239; }","duration":"276.956491ms","start":"2026-07-27T20:06:39.42522Z","end":"2026-07-27T20:06:39.702176Z","steps":["trace[302035022] 'read index received' (duration: 167.142419ms)","trace[302035022] 'applied index is now lower than readState.Index' (duration: 109.811882ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:06:39.702272Z","caller":"traceutil/trace.go:171","msg":"trace[515667272] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"373.704461ms","start":"2026-07-27T20:06:39.328555Z","end":"2026-07-27T20:06:39.70226Z","steps":["trace[515667272] 'process raft request' (duration: 263.847748ms)","trace[515667272] 'compare' (duration: 109.053111ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:06:39.702478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:06:39.32853Z","time spent":"373.773554ms","remote":"127.0.0.1:52176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T20:06:39.702455Z","caller":"traceutil/trace.go:171","msg":"trace[2098395661] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"117.919717ms","start":"2026-07-27T20:06:39.584496Z","end":"2026-07-27T20:06:39.702416Z","steps":["trace[2098395661] 'process raft request' (duration: 117.762882ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:06:39.702539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.316412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-27T20:06:39.702611Z","caller":"traceutil/trace.go:171","msg":"trace[587097051] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:2160; }","duration":"277.415155ms","start":"2026-07-27T20:06:39.425176Z","end":"2026-07-27T20:06:39.702591Z","steps":["trace[587097051] 'agreement among raft nodes before linearized reading' (duration: 277.302972ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:06:39.757704Z","caller":"traceutil/trace.go:171","msg":"trace[521042724] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"152.880614ms","start":"2026-07-27T20:06:39.604792Z","end":"2026-07-27T20:06:39.757672Z","steps":["trace[521042724] 'process raft request' (duration: 152.663798ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:06:39.757904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.406952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-27T20:06:39.758034Z","caller":"traceutil/trace.go:171","msg":"trace[1004606558] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2162; }","duration":"152.615448ms","start":"2026-07-27T20:06:39.6054Z","end":"2026-07-27T20:06:39.758016Z","steps":["trace[1004606558] 'agreement among raft nodes before linearized reading' (duration: 152.289929ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:08:01.648731Z","caller":"traceutil/trace.go:171","msg":"trace[470397253] transaction","detail":"{read_only:false; response_revision:2798; number_of_response:1; }","duration":"102.933726ms","start":"2026-07-27T20:08:01.545763Z","end":"2026-07-27T20:08:01.648697Z","steps":["trace[470397253] 'process raft request' (duration: 102.544046ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:08:01.821564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.931598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1317"} {"level":"info","ts":"2026-07-27T20:08:01.821694Z","caller":"traceutil/trace.go:171","msg":"trace[628922159] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:2798; }","duration":"107.131423ms","start":"2026-07-27T20:08:01.714534Z","end":"2026-07-27T20:08:01.821665Z","steps":["trace[628922159] 'range keys from in-memory index tree' (duration: 106.692161ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:11:51.010366Z","caller":"traceutil/trace.go:171","msg":"trace[1159560100] transaction","detail":"{read_only:false; response_revision:4824; number_of_response:1; }","duration":"126.849766ms","start":"2026-07-27T20:11:50.883497Z","end":"2026-07-27T20:11:51.010347Z","steps":["trace[1159560100] 'process raft request' (duration: 126.817725ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:11:51.010383Z","caller":"traceutil/trace.go:171","msg":"trace[1142629739] transaction","detail":"{read_only:false; response_revision:4822; number_of_response:1; }","duration":"131.951118ms","start":"2026-07-27T20:11:50.878403Z","end":"2026-07-27T20:11:51.010354Z","steps":["trace[1142629739] 'process raft request' (duration: 89.167605ms)","trace[1142629739] 'compare' (duration: 42.599368ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:11:51.010434Z","caller":"traceutil/trace.go:171","msg":"trace[719886385] transaction","detail":"{read_only:false; response_revision:4823; number_of_response:1; }","duration":"128.187002ms","start":"2026-07-27T20:11:50.882188Z","end":"2026-07-27T20:11:51.010375Z","steps":["trace[719886385] 'process raft request' (duration: 128.08902ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:11:55.682917Z","caller":"traceutil/trace.go:171","msg":"trace[1959650044] transaction","detail":"{read_only:false; response_revision:4977; number_of_response:1; }","duration":"135.047294ms","start":"2026-07-27T20:11:55.54783Z","end":"2026-07-27T20:11:55.682878Z","steps":["trace[1959650044] 'process raft request' (duration: 111.858918ms)","trace[1959650044] 'compare' (duration: 22.716513ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:12:07.494813Z","caller":"traceutil/trace.go:171","msg":"trace[258086619] transaction","detail":"{read_only:false; response_revision:5219; number_of_response:1; }","duration":"170.326148ms","start":"2026-07-27T20:12:07.324459Z","end":"2026-07-27T20:12:07.494786Z","steps":["trace[258086619] 'process raft request' (duration: 170.163853ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:12:15.361603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.300773ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-27T20:12:15.361737Z","caller":"traceutil/trace.go:171","msg":"trace[622630512] transaction","detail":"{read_only:false; response_revision:5386; number_of_response:1; }","duration":"176.794848ms","start":"2026-07-27T20:12:15.184917Z","end":"2026-07-27T20:12:15.361712Z","steps":["trace[622630512] 'process raft request' (duration: 28.293989ms)","trace[622630512] 'compare' (duration: 148.16631ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:12:15.41551Z","caller":"traceutil/trace.go:171","msg":"trace[1011612920] transaction","detail":"{read_only:false; response_revision:5388; number_of_response:1; }","duration":"228.54661ms","start":"2026-07-27T20:12:15.186937Z","end":"2026-07-27T20:12:15.415484Z","steps":["trace[1011612920] 'process raft request' (duration: 228.480668ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:12:15.415962Z","caller":"traceutil/trace.go:171","msg":"trace[860668440] transaction","detail":"{read_only:false; response_revision:5387; number_of_response:1; }","duration":"229.568808ms","start":"2026-07-27T20:12:15.186341Z","end":"2026-07-27T20:12:15.41591Z","steps":["trace[860668440] 'process raft request' (duration: 228.93468ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:12:15.730244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.605039ms","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-07-27T20:12:15.730318Z","caller":"traceutil/trace.go:171","msg":"trace[1499049156] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5389; }","duration":"117.733352ms","start":"2026-07-27T20:12:15.612568Z","end":"2026-07-27T20:12:15.730301Z","steps":["trace[1499049156] 'range keys from in-memory index tree' (duration: 117.387782ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:13:33.289618Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2974} {"level":"info","ts":"2026-07-27T20:13:33.358115Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2974,"took":"67.232814ms","hash":38614932,"current-db-size-bytes":59609088,"current-db-size":"60 MB","current-db-size-in-use-bytes":34504704,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-27T20:13:33.358179Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":38614932,"revision":2974,"compact-revision":-1} {"level":"info","ts":"2026-07-27T20:18:33.296878Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6101} {"level":"info","ts":"2026-07-27T20:18:33.388827Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6101,"took":"90.078508ms","hash":452353303,"current-db-size-bytes":59609088,"current-db-size":"60 MB","current-db-size-in-use-bytes":23461888,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-07-27T20:18:33.38889Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":452353303,"revision":6101,"compact-revision":2974} {"level":"info","ts":"2026-07-27T20:18:46.027439Z","caller":"traceutil/trace.go:171","msg":"trace[981279571] transaction","detail":"{read_only:false; response_revision:8339; number_of_response:1; }","duration":"210.869244ms","start":"2026-07-27T20:18:45.81654Z","end":"2026-07-27T20:18:46.027409Z","steps":["trace[981279571] 'process raft request' (duration: 210.678189ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:18:46.153299Z","caller":"traceutil/trace.go:171","msg":"trace[1496543564] linearizableReadLoop","detail":"{readStateIndex:8632; appliedIndex:8630; }","duration":"332.335319ms","start":"2026-07-27T20:18:45.820938Z","end":"2026-07-27T20:18:46.153273Z","steps":["trace[1496543564] 'read index received' (duration: 206.382169ms)","trace[1496543564] 'applied index is now lower than readState.Index' (duration: 125.952ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:18:46.1534Z","caller":"traceutil/trace.go:171","msg":"trace[608757481] transaction","detail":"{read_only:false; response_revision:8340; number_of_response:1; }","duration":"333.637296ms","start":"2026-07-27T20:18:45.819729Z","end":"2026-07-27T20:18:46.153366Z","steps":["trace[608757481] 'process raft request' (duration: 296.004064ms)","trace[608757481] 'compare' (duration: 37.373055ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:18:46.153528Z","caller":"traceutil/trace.go:171","msg":"trace[1587601230] transaction","detail":"{read_only:false; response_revision:8341; number_of_response:1; }","duration":"189.797886ms","start":"2026-07-27T20:18:45.963668Z","end":"2026-07-27T20:18:46.153466Z","steps":["trace[1587601230] 'process raft request' (duration: 189.556759ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:18:46.153695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:18:45.819686Z","time spent":"333.873132ms","remote":"127.0.0.1:52176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-27T20:18:46.153696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.72135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-27T20:18:46.153825Z","caller":"traceutil/trace.go:171","msg":"trace[1709275112] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8341; }","duration":"332.904105ms","start":"2026-07-27T20:18:45.820896Z","end":"2026-07-27T20:18:46.1538Z","steps":["trace[1709275112] 'agreement among raft nodes before linearized reading' (duration: 332.574136ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:18:46.153889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:18:45.82088Z","time spent":"332.995588ms","remote":"127.0.0.1:52176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-27T20:19:19.157187Z","caller":"traceutil/trace.go:171","msg":"trace[1071890303] transaction","detail":"{read_only:false; response_revision:8572; number_of_response:1; }","duration":"118.900644ms","start":"2026-07-27T20:19:19.038256Z","end":"2026-07-27T20:19:19.157157Z","steps":["trace[1071890303] 'process raft request' (duration: 118.706409ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:19:24.485627Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000022c9.wal"} {"level":"info","ts":"2026-07-27T20:19:29.310246Z","caller":"traceutil/trace.go:171","msg":"trace[379085515] transaction","detail":"{read_only:false; response_revision:8671; number_of_response:1; }","duration":"101.475157ms","start":"2026-07-27T20:19:29.208741Z","end":"2026-07-27T20:19:29.310216Z","steps":["trace[379085515] 'process raft request' (duration: 101.287251ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:19:30.196286Z","caller":"traceutil/trace.go:171","msg":"trace[1598395511] transaction","detail":"{read_only:false; response_revision:8678; number_of_response:1; }","duration":"147.116333ms","start":"2026-07-27T20:19:30.049134Z","end":"2026-07-27T20:19:30.19625Z","steps":["trace[1598395511] 'process raft request' (duration: 146.843825ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:20:49.742401Z","caller":"traceutil/trace.go:171","msg":"trace[71868365] transaction","detail":"{read_only:false; response_revision:9437; number_of_response:1; }","duration":"111.880627ms","start":"2026-07-27T20:20:49.630498Z","end":"2026-07-27T20:20:49.742379Z","steps":["trace[71868365] 'process raft request' (duration: 98.297877ms)","trace[71868365] 'compare' (duration: 13.394875ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:20:49.742831Z","caller":"traceutil/trace.go:171","msg":"trace[128138616] transaction","detail":"{read_only:false; response_revision:9439; number_of_response:1; }","duration":"108.138812ms","start":"2026-07-27T20:20:49.634647Z","end":"2026-07-27T20:20:49.742786Z","steps":["trace[128138616] 'process raft request' (duration: 107.966247ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:20:49.742985Z","caller":"traceutil/trace.go:171","msg":"trace[43063006] transaction","detail":"{read_only:false; response_revision:9438; number_of_response:1; }","duration":"110.365074ms","start":"2026-07-27T20:20:49.63258Z","end":"2026-07-27T20:20:49.742945Z","steps":["trace[43063006] 'process raft request' (duration: 109.753517ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:20:50.035495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.838846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-07-27T20:20:50.035567Z","caller":"traceutil/trace.go:171","msg":"trace[144170054] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9440; }","duration":"184.987409ms","start":"2026-07-27T20:20:49.850562Z","end":"2026-07-27T20:20:50.03555Z","steps":["trace[144170054] 'range keys from in-memory index tree' (duration: 184.605779ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:21:23.113463Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1c917701ce165bac","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-27T20:21:23.122078Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-27T20:21:23.122223Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-27T20:23:33.303036Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8274} {"level":"info","ts":"2026-07-27T20:23:33.37931Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8274,"took":"73.984773ms","hash":4220944452,"current-db-size-bytes":59609088,"current-db-size":"60 MB","current-db-size-in-use-bytes":25186304,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-07-27T20:23:33.379385Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4220944452,"revision":8274,"compact-revision":6101} {"level":"info","ts":"2026-07-27T20:26:22.975851Z","caller":"traceutil/trace.go:171","msg":"trace[1439956740] transaction","detail":"{read_only:false; response_revision:11833; number_of_response:1; }","duration":"127.239909ms","start":"2026-07-27T20:26:22.848589Z","end":"2026-07-27T20:26:22.975829Z","steps":["trace[1439956740] 'process raft request' (duration: 127.086625ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:26:24.677672Z","caller":"traceutil/trace.go:171","msg":"trace[1044408319] linearizableReadLoop","detail":"{readStateIndex:12248; appliedIndex:12247; }","duration":"145.305144ms","start":"2026-07-27T20:26:24.532343Z","end":"2026-07-27T20:26:24.677649Z","steps":["trace[1044408319] 'read index received' (duration: 145.088058ms)","trace[1044408319] 'applied index is now lower than readState.Index' (duration: 216.246µs)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:26:24.677807Z","caller":"traceutil/trace.go:171","msg":"trace[64845543] transaction","detail":"{read_only:false; response_revision:11843; number_of_response:1; }","duration":"160.158957ms","start":"2026-07-27T20:26:24.517617Z","end":"2026-07-27T20:26:24.677776Z","steps":["trace[64845543] 'process raft request' (duration: 159.874999ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:26:24.677898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.392796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T20:26:24.678013Z","caller":"traceutil/trace.go:171","msg":"trace[721745928] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:11843; }","duration":"145.515919ms","start":"2026-07-27T20:26:24.532479Z","end":"2026-07-27T20:26:24.677995Z","steps":["trace[721745928] 'agreement among raft nodes before linearized reading' (duration: 145.344064ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:26:24.678425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.682314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-27T20:26:24.678437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.059994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-27T20:26:24.678502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.918774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5077"} {"level":"info","ts":"2026-07-27T20:26:24.678601Z","caller":"traceutil/trace.go:171","msg":"trace[330541897] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:11843; }","duration":"144.079049ms","start":"2026-07-27T20:26:24.5345Z","end":"2026-07-27T20:26:24.678579Z","steps":["trace[330541897] 'agreement among raft nodes before linearized reading' (duration: 143.7567ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:26:24.678621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.113176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-27T20:26:24.678657Z","caller":"traceutil/trace.go:171","msg":"trace[1864320379] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:11843; }","duration":"146.188007ms","start":"2026-07-27T20:26:24.532459Z","end":"2026-07-27T20:26:24.678647Z","steps":["trace[1864320379] 'agreement among raft nodes before linearized reading' (duration: 146.129336ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:26:24.678641Z","caller":"traceutil/trace.go:171","msg":"trace[2129801314] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:11843; }","duration":"146.219868ms","start":"2026-07-27T20:26:24.532284Z","end":"2026-07-27T20:26:24.678503Z","steps":["trace[2129801314] 'agreement among raft nodes before linearized reading' (duration: 145.487708ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:26:24.678477Z","caller":"traceutil/trace.go:171","msg":"trace[1768080998] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:11843; }","duration":"145.749535ms","start":"2026-07-27T20:26:24.532714Z","end":"2026-07-27T20:26:24.678463Z","steps":["trace[1768080998] 'agreement among raft nodes before linearized reading' (duration: 145.670153ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:28:33.3101Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10496} {"level":"info","ts":"2026-07-27T20:28:33.386867Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10496,"took":"74.087528ms","hash":3822332156,"current-db-size-bytes":59609088,"current-db-size":"60 MB","current-db-size-in-use-bytes":26263552,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-07-27T20:28:33.386919Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3822332156,"revision":10496,"compact-revision":8274} {"level":"info","ts":"2026-07-27T20:32:32.438917Z","caller":"traceutil/trace.go:171","msg":"trace[734907805] transaction","detail":"{read_only:false; response_revision:14333; number_of_response:1; }","duration":"148.700561ms","start":"2026-07-27T20:32:32.290204Z","end":"2026-07-27T20:32:32.438905Z","steps":["trace[734907805] 'process raft request' (duration: 148.441324ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:32:32.43918Z","caller":"traceutil/trace.go:171","msg":"trace[1408223891] transaction","detail":"{read_only:false; response_revision:14335; number_of_response:1; }","duration":"146.997384ms","start":"2026-07-27T20:32:32.292156Z","end":"2026-07-27T20:32:32.439153Z","steps":["trace[1408223891] 'process raft request' (duration: 146.893671ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:32:32.439201Z","caller":"traceutil/trace.go:171","msg":"trace[1221239761] transaction","detail":"{read_only:false; response_revision:14334; number_of_response:1; }","duration":"147.087876ms","start":"2026-07-27T20:32:32.292077Z","end":"2026-07-27T20:32:32.439165Z","steps":["trace[1221239761] 'process raft request' (duration: 146.782568ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:32:32.438785Z","caller":"traceutil/trace.go:171","msg":"trace[477017104] transaction","detail":"{read_only:false; response_revision:14332; number_of_response:1; }","duration":"150.163632ms","start":"2026-07-27T20:32:32.28857Z","end":"2026-07-27T20:32:32.438734Z","steps":["trace[477017104] 'process raft request' (duration: 131.043639ms)","trace[477017104] 'compare' (duration: 18.899827ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:33:33.317506Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12711} {"level":"info","ts":"2026-07-27T20:33:33.39334Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12711,"took":"73.194489ms","hash":1452942185,"current-db-size-bytes":59609088,"current-db-size":"60 MB","current-db-size-in-use-bytes":28405760,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-07-27T20:33:33.3934Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1452942185,"revision":12711,"compact-revision":10496} {"level":"info","ts":"2026-07-27T20:34:49.484016Z","caller":"traceutil/trace.go:171","msg":"trace[625621215] transaction","detail":"{read_only:false; response_revision:15618; number_of_response:1; }","duration":"164.423831ms","start":"2026-07-27T20:34:49.31955Z","end":"2026-07-27T20:34:49.483974Z","steps":["trace[625621215] 'process raft request' (duration: 163.837904ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:34:50.520585Z","caller":"traceutil/trace.go:171","msg":"trace[770229051] linearizableReadLoop","detail":"{readStateIndex:16154; appliedIndex:16153; }","duration":"171.439126ms","start":"2026-07-27T20:34:50.349115Z","end":"2026-07-27T20:34:50.520554Z","steps":["trace[770229051] 'read index received' (duration: 171.269411ms)","trace[770229051] 'applied index is now lower than readState.Index' (duration: 168.705µs)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:34:50.520706Z","caller":"traceutil/trace.go:171","msg":"trace[1250696395] transaction","detail":"{read_only:false; response_revision:15620; number_of_response:1; }","duration":"214.199267ms","start":"2026-07-27T20:34:50.306471Z","end":"2026-07-27T20:34:50.52067Z","steps":["trace[1250696395] 'process raft request' (duration: 213.911299ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:34:50.520856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.700044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-27T20:34:50.520909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.784734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-vbtf5\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-07-27T20:34:50.521026Z","caller":"traceutil/trace.go:171","msg":"trace[2074959887] range","detail":"{range_begin:/registry/pods/openstack/keepalived-vbtf5; range_end:; response_count:1; response_revision:15620; }","duration":"125.97348ms","start":"2026-07-27T20:34:50.39504Z","end":"2026-07-27T20:34:50.521013Z","steps":["trace[2074959887] 'agreement among raft nodes before linearized reading' (duration: 125.694572ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:34:50.521023Z","caller":"traceutil/trace.go:171","msg":"trace[1581976695] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:15620; }","duration":"171.94419ms","start":"2026-07-27T20:34:50.349049Z","end":"2026-07-27T20:34:50.520993Z","steps":["trace[1581976695] 'agreement among raft nodes before linearized reading' (duration: 171.662882ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:38:33.323729Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14875} {"level":"info","ts":"2026-07-27T20:38:33.441523Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14875,"took":"114.739637ms","hash":3321269069,"current-db-size-bytes":59609088,"current-db-size":"60 MB","current-db-size-in-use-bytes":30457856,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-27T20:38:33.441612Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3321269069,"revision":14875,"compact-revision":12711} {"level":"info","ts":"2026-07-27T20:41:05.009578Z","caller":"traceutil/trace.go:171","msg":"trace[499943260] transaction","detail":"{read_only:false; response_revision:18343; number_of_response:1; }","duration":"124.623188ms","start":"2026-07-27T20:41:04.884917Z","end":"2026-07-27T20:41:05.00954Z","steps":["trace[499943260] 'process raft request' (duration: 124.31231ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:41:12.061832Z","caller":"traceutil/trace.go:171","msg":"trace[819252402] transaction","detail":"{read_only:false; response_revision:18382; number_of_response:1; }","duration":"215.287312ms","start":"2026-07-27T20:41:11.846515Z","end":"2026-07-27T20:41:12.061802Z","steps":["trace[819252402] 'process raft request' (duration: 215.015685ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:41:12.117315Z","caller":"traceutil/trace.go:171","msg":"trace[779536878] transaction","detail":"{read_only:false; response_revision:18383; number_of_response:1; }","duration":"102.38346ms","start":"2026-07-27T20:41:12.014905Z","end":"2026-07-27T20:41:12.117289Z","steps":["trace[779536878] 'process raft request' (duration: 102.240426ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:41:12.697309Z","caller":"traceutil/trace.go:171","msg":"trace[1800283686] transaction","detail":"{read_only:false; response_revision:18387; number_of_response:1; }","duration":"242.949403ms","start":"2026-07-27T20:41:12.454327Z","end":"2026-07-27T20:41:12.697276Z","steps":["trace[1800283686] 'process raft request' (duration: 242.881951ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:41:12.697544Z","caller":"traceutil/trace.go:171","msg":"trace[94434456] transaction","detail":"{read_only:false; response_revision:18385; number_of_response:1; }","duration":"246.841671ms","start":"2026-07-27T20:41:12.450684Z","end":"2026-07-27T20:41:12.697525Z","steps":["trace[94434456] 'process raft request' (duration: 232.902142ms)","trace[94434456] 'compare' (duration: 13.402814ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:41:12.697733Z","caller":"traceutil/trace.go:171","msg":"trace[1325575739] transaction","detail":"{read_only:false; response_revision:18386; number_of_response:1; }","duration":"243.445776ms","start":"2026-07-27T20:41:12.454247Z","end":"2026-07-27T20:41:12.697693Z","steps":["trace[1325575739] 'process raft request' (duration: 242.892221ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:42:33.074245Z","caller":"traceutil/trace.go:171","msg":"trace[1737337414] transaction","detail":"{read_only:false; response_revision:19246; number_of_response:1; }","duration":"100.264131ms","start":"2026-07-27T20:42:32.973939Z","end":"2026-07-27T20:42:33.074203Z","steps":["trace[1737337414] 'process raft request' (duration: 95.1966ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:42:43.548044Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1c917701ce165bac","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-27T20:42:43.55877Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-27T20:42:43.558859Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-07-27T20:43:33.330317Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17330} {"level":"info","ts":"2026-07-27T20:43:33.425251Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17330,"took":"91.596039ms","hash":176551972,"current-db-size-bytes":59609088,"current-db-size":"60 MB","current-db-size-in-use-bytes":33619968,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-27T20:43:33.425335Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":176551972,"revision":17330,"compact-revision":14875} {"level":"warn","ts":"2026-07-27T20:47:11.191044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.200223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-07-27T20:47:11.191162Z","caller":"traceutil/trace.go:171","msg":"trace[1832022573] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:21135; }","duration":"121.370248ms","start":"2026-07-27T20:47:11.069774Z","end":"2026-07-27T20:47:11.191144Z","steps":["trace[1832022573] 'range keys from in-memory index tree' (duration: 121.027629ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:47:11.534405Z","caller":"traceutil/trace.go:171","msg":"trace[1811120943] transaction","detail":"{read_only:false; response_revision:21136; number_of_response:1; }","duration":"286.726811ms","start":"2026-07-27T20:47:11.247652Z","end":"2026-07-27T20:47:11.534379Z","steps":["trace[1811120943] 'process raft request' (duration: 286.571367ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:47:12.108533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.611491ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-07-27T20:47:12.10887Z","caller":"traceutil/trace.go:171","msg":"trace[966306973] linearizableReadLoop","detail":"{readStateIndex:21853; appliedIndex:21851; }","duration":"305.522704ms","start":"2026-07-27T20:47:11.803322Z","end":"2026-07-27T20:47:12.108844Z","steps":["trace[966306973] 'read index received' (duration: 24.650907ms)","trace[966306973] 'applied index is now lower than readState.Index' (duration: 280.869967ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:47:12.108982Z","caller":"traceutil/trace.go:171","msg":"trace[569606781] transaction","detail":"{read_only:false; response_revision:21137; number_of_response:1; }","duration":"322.223648ms","start":"2026-07-27T20:47:11.786743Z","end":"2026-07-27T20:47:12.108967Z","steps":["trace[569606781] 'process raft request' (duration: 321.90505ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:47:12.109117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:47:11.786723Z","time spent":"322.30125ms","remote":"127.0.0.1:52176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-27T20:47:12.149067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.722403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-27T20:47:12.149162Z","caller":"traceutil/trace.go:171","msg":"trace[113493404] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21137; }","duration":"345.856536ms","start":"2026-07-27T20:47:11.803278Z","end":"2026-07-27T20:47:12.149134Z","steps":["trace[113493404] 'agreement among raft nodes before linearized reading' (duration: 305.856753ms)","trace[113493404] 'range keys from in-memory index tree' (duration: 39.791058ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:47:12.14917Z","caller":"traceutil/trace.go:171","msg":"trace[942048262] transaction","detail":"{read_only:false; response_revision:21138; number_of_response:1; }","duration":"140.738618ms","start":"2026-07-27T20:47:12.008402Z","end":"2026-07-27T20:47:12.149141Z","steps":["trace[942048262] 'process raft request' (duration: 105.383534ms)","trace[942048262] 'compare' (duration: 35.116827ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:47:12.14922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:47:11.80326Z","time spent":"345.945798ms","remote":"127.0.0.1:52176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-27T20:47:12.149487Z","caller":"traceutil/trace.go:171","msg":"trace[1023231098] transaction","detail":"{read_only:false; response_revision:21139; number_of_response:1; }","duration":"101.916517ms","start":"2026-07-27T20:47:12.047552Z","end":"2026-07-27T20:47:12.149469Z","steps":["trace[1023231098] 'process raft request' (duration: 101.541636ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:47:12.149627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.219837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-27T20:47:12.149743Z","caller":"traceutil/trace.go:171","msg":"trace[2119868723] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:21139; }","duration":"212.450584ms","start":"2026-07-27T20:47:11.937267Z","end":"2026-07-27T20:47:12.149718Z","steps":["trace[2119868723] 'agreement among raft nodes before linearized reading' (duration: 212.220227ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:47:12.282334Z","caller":"traceutil/trace.go:171","msg":"trace[1950539617] linearizableReadLoop","detail":"{readStateIndex:21856; appliedIndex:21855; }","duration":"132.849968ms","start":"2026-07-27T20:47:12.149458Z","end":"2026-07-27T20:47:12.282308Z","steps":["trace[1950539617] 'read index received' (duration: 120.637688ms)","trace[1950539617] 'applied index is now lower than readState.Index' (duration: 12.21117ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:47:12.282476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.419808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-27T20:47:12.28252Z","caller":"traceutil/trace.go:171","msg":"trace[2128455627] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:21140; }","duration":"154.51823ms","start":"2026-07-27T20:47:12.127987Z","end":"2026-07-27T20:47:12.282505Z","steps":["trace[2128455627] 'agreement among raft nodes before linearized reading' (duration: 154.417878ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:47:12.282481Z","caller":"traceutil/trace.go:171","msg":"trace[1961642959] transaction","detail":"{read_only:false; response_revision:21140; number_of_response:1; }","duration":"151.578659ms","start":"2026-07-27T20:47:12.130861Z","end":"2026-07-27T20:47:12.28244Z","steps":["trace[1961642959] 'process raft request' (duration: 139.257856ms)","trace[1961642959] 'compare' (duration: 12.056835ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:47:12.564407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.745593ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-27T20:47:12.564512Z","caller":"traceutil/trace.go:171","msg":"trace[2056254913] transaction","detail":"{read_only:false; response_revision:21141; number_of_response:1; }","duration":"410.617128ms","start":"2026-07-27T20:47:12.153876Z","end":"2026-07-27T20:47:12.564493Z","steps":["trace[2056254913] 'process raft request' (duration: 304.69566ms)","trace[2056254913] 'compare' (duration: 105.63045ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:47:12.56457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T20:47:12.153859Z","time spent":"410.68365ms","remote":"127.0.0.1:52176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T20:47:12.962784Z","caller":"traceutil/trace.go:171","msg":"trace[1636012254] transaction","detail":"{read_only:false; response_revision:21142; number_of_response:1; }","duration":"114.294241ms","start":"2026-07-27T20:47:12.848464Z","end":"2026-07-27T20:47:12.962758Z","steps":["trace[1636012254] 'process raft request' (duration: 114.150007ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:47:13.176312Z","caller":"traceutil/trace.go:171","msg":"trace[967329483] linearizableReadLoop","detail":"{readStateIndex:21859; appliedIndex:21858; }","duration":"171.548395ms","start":"2026-07-27T20:47:13.004739Z","end":"2026-07-27T20:47:13.176287Z","steps":["trace[967329483] 'read index received' (duration: 144.578925ms)","trace[967329483] 'applied index is now lower than readState.Index' (duration: 26.96858ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:47:13.176549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.796872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-27T20:47:13.176587Z","caller":"traceutil/trace.go:171","msg":"trace[2120968426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21143; }","duration":"171.882404ms","start":"2026-07-27T20:47:13.004695Z","end":"2026-07-27T20:47:13.176578Z","steps":["trace[2120968426] 'agreement among raft nodes before linearized reading' (duration: 171.750711ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:47:13.176662Z","caller":"traceutil/trace.go:171","msg":"trace[1196968239] transaction","detail":"{read_only:false; response_revision:21143; number_of_response:1; }","duration":"173.53574ms","start":"2026-07-27T20:47:13.003084Z","end":"2026-07-27T20:47:13.17662Z","steps":["trace[1196968239] 'process raft request' (duration: 146.238851ms)","trace[1196968239] 'compare' (duration: 26.580309ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T20:47:13.176708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.919165ms","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-07-27T20:47:13.176793Z","caller":"traceutil/trace.go:171","msg":"trace[1779837252] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21143; }","duration":"172.002868ms","start":"2026-07-27T20:47:13.004741Z","end":"2026-07-27T20:47:13.176744Z","steps":["trace[1779837252] 'agreement among raft nodes before linearized reading' (duration: 171.844463ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:48:33.336292Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19637} {"level":"info","ts":"2026-07-27T20:48:33.444805Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19637,"took":"105.347332ms","hash":1979429914,"current-db-size-bytes":59609088,"current-db-size":"60 MB","current-db-size-in-use-bytes":29368320,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-27T20:48:33.444883Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1979429914,"revision":19637,"compact-revision":17330} {"level":"info","ts":"2026-07-27T20:51:16.413945Z","caller":"traceutil/trace.go:171","msg":"trace[1728441347] linearizableReadLoop","detail":"{readStateIndex:24466; appliedIndex:24465; }","duration":"233.910882ms","start":"2026-07-27T20:51:16.179998Z","end":"2026-07-27T20:51:16.413909Z","steps":["trace[1728441347] 'read index received' (duration: 225.151149ms)","trace[1728441347] 'applied index is now lower than readState.Index' (duration: 8.757453ms)"],"step_count":2} {"level":"info","ts":"2026-07-27T20:51:16.41403Z","caller":"traceutil/trace.go:171","msg":"trace[1729093977] transaction","detail":"{read_only:false; response_revision:23677; number_of_response:1; }","duration":"248.409116ms","start":"2026-07-27T20:51:16.165591Z","end":"2026-07-27T20:51:16.414Z","steps":["trace[1729093977] 'process raft request' (duration: 239.507058ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T20:51:16.414307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.283322ms","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-07-27T20:51:16.414371Z","caller":"traceutil/trace.go:171","msg":"trace[510234706] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23677; }","duration":"234.385286ms","start":"2026-07-27T20:51:16.179969Z","end":"2026-07-27T20:51:16.414355Z","steps":["trace[510234706] 'agreement among raft nodes before linearized reading' (duration: 234.162139ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T20:53:33.342239Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21856} {"level":"info","ts":"2026-07-27T20:53:33.448804Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21856,"took":"102.314725ms","hash":2618731248,"current-db-size-bytes":59609088,"current-db-size":"60 MB","current-db-size-in-use-bytes":44244992,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-07-27T20:53:33.448914Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2618731248,"revision":21856,"compact-revision":19637} {"level":"info","ts":"2026-07-27T20:57:57.427757Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006cb8.wal"} {"level":"info","ts":"2026-07-27T20:58:33.347094Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24970} {"level":"info","ts":"2026-07-27T20:58:33.485639Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24970,"took":"134.50546ms","hash":2939203082,"current-db-size-bytes":59609088,"current-db-size":"60 MB","current-db-size-in-use-bytes":30613504,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-27T20:58:33.485709Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2939203082,"revision":24970,"compact-revision":21856} {"level":"warn","ts":"2026-07-27T21:00:20.493551Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605830285217865864,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-27T21:00:20.530099Z","caller":"traceutil/trace.go:171","msg":"trace[622519772] transaction","detail":"{read_only:false; response_revision:28070; number_of_response:1; }","duration":"597.603237ms","start":"2026-07-27T21:00:19.932468Z","end":"2026-07-27T21:00:20.530071Z","steps":["trace[622519772] 'process raft request' (duration: 597.434543ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T21:00:20.530275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T21:00:19.932442Z","time spent":"597.742172ms","remote":"127.0.0.1:52176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T21:00:20.584249Z","caller":"traceutil/trace.go:171","msg":"trace[51854591] transaction","detail":"{read_only:false; response_revision:28071; number_of_response:1; }","duration":"585.914342ms","start":"2026-07-27T21:00:19.998308Z","end":"2026-07-27T21:00:20.584223Z","steps":["trace[51854591] 'process raft request' (duration: 585.662815ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T21:00:20.584331Z","caller":"traceutil/trace.go:171","msg":"trace[1860684046] transaction","detail":"{read_only:false; response_revision:28072; number_of_response:1; }","duration":"510.006806ms","start":"2026-07-27T21:00:20.074276Z","end":"2026-07-27T21:00:20.584283Z","steps":["trace[1860684046] 'process raft request' (duration: 509.843281ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T21:00:20.58442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T21:00:19.99829Z","time spent":"586.035225ms","remote":"127.0.0.1:52176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-27T21:00:20.584449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T21:00:20.074249Z","time spent":"510.129659ms","remote":"127.0.0.1:52176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-27T21:00:20.584613Z","caller":"traceutil/trace.go:171","msg":"trace[447804687] transaction","detail":"{read_only:false; response_revision:28073; number_of_response:1; }","duration":"262.479977ms","start":"2026-07-27T21:00:20.322105Z","end":"2026-07-27T21:00:20.584585Z","steps":["trace[447804687] 'process raft request' (duration: 262.061545ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T21:00:20.584676Z","caller":"traceutil/trace.go:171","msg":"trace[987167951] linearizableReadLoop","detail":"{readStateIndex:28986; appliedIndex:28981; }","duration":"592.065653ms","start":"2026-07-27T21:00:19.992594Z","end":"2026-07-27T21:00:20.58466Z","steps":["trace[987167951] 'read index received' (duration: 537.43185ms)","trace[987167951] 'applied index is now lower than readState.Index' (duration: 54.632593ms)"],"step_count":2} {"level":"warn","ts":"2026-07-27T21:00:20.584834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.224267ms","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:8"} {"level":"warn","ts":"2026-07-27T21:00:20.584865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.521684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-27T21:00:20.584835Z","caller":"traceutil/trace.go:171","msg":"trace[1767329162] transaction","detail":"{read_only:false; response_revision:28074; number_of_response:1; }","duration":"168.442555ms","start":"2026-07-27T21:00:20.416328Z","end":"2026-07-27T21:00:20.584771Z","steps":["trace[1767329162] 'process raft request' (duration: 168.189628ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T21:00:20.584892Z","caller":"traceutil/trace.go:171","msg":"trace[1047744196] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:28074; }","duration":"592.33085ms","start":"2026-07-27T21:00:19.992545Z","end":"2026-07-27T21:00:20.584876Z","steps":["trace[1047744196] 'agreement among raft nodes before linearized reading' (duration: 592.224837ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T21:00:20.584908Z","caller":"traceutil/trace.go:171","msg":"trace[1322931215] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:28074; }","duration":"541.607407ms","start":"2026-07-27T21:00:20.043287Z","end":"2026-07-27T21:00:20.584894Z","steps":["trace[1322931215] 'agreement among raft nodes before linearized reading' (duration: 541.516914ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T21:00:20.584937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T21:00:19.992528Z","time spent":"592.397563ms","remote":"127.0.0.1:53198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-07-27T21:00:20.584945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T21:00:20.043245Z","time spent":"541.688599ms","remote":"127.0.0.1:54790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true "} {"level":"warn","ts":"2026-07-27T21:00:20.585077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.827227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-07-27T21:00:20.58509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.866747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/neutron-l3-agent\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-07-27T21:00:20.585173Z","caller":"traceutil/trace.go:171","msg":"trace[2089368078] range","detail":"{range_begin:/registry/serviceaccounts/openstack/neutron-l3-agent; range_end:; response_count:1; response_revision:28074; }","duration":"389.97373ms","start":"2026-07-27T21:00:20.195183Z","end":"2026-07-27T21:00:20.585156Z","steps":["trace[2089368078] 'agreement among raft nodes before linearized reading' (duration: 389.748504ms)"],"step_count":1} {"level":"info","ts":"2026-07-27T21:00:20.58518Z","caller":"traceutil/trace.go:171","msg":"trace[356758922] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:28074; }","duration":"262.974231ms","start":"2026-07-27T21:00:20.32218Z","end":"2026-07-27T21:00:20.585154Z","steps":["trace[356758922] 'agreement among raft nodes before linearized reading' (duration: 262.730694ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T21:00:20.585229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T21:00:20.195163Z","time spent":"390.058602ms","remote":"127.0.0.1:52132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":561,"request content":"key:\"/registry/serviceaccounts/openstack/neutron-l3-agent\" "} {"level":"warn","ts":"2026-07-27T21:00:20.585079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.306377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/cinder-keystone-test\" ","response":"range_response_count:1 size:1069"} {"level":"info","ts":"2026-07-27T21:00:20.585509Z","caller":"traceutil/trace.go:171","msg":"trace[252252363] range","detail":"{range_begin:/registry/secrets/openstack/cinder-keystone-test; range_end:; response_count:1; response_revision:28074; }","duration":"386.736319ms","start":"2026-07-27T21:00:20.198745Z","end":"2026-07-27T21:00:20.585481Z","steps":["trace[252252363] 'agreement among raft nodes before linearized reading' (duration: 386.172073ms)"],"step_count":1} {"level":"warn","ts":"2026-07-27T21:00:20.58561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-27T21:00:20.198717Z","time spent":"386.859123ms","remote":"127.0.0.1:52040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":1092,"request content":"key:\"/registry/secrets/openstack/cinder-keystone-test\" "}