{"level":"warn","ts":"2026-05-24T22:08:37.732608Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-24T22:08:37.732756Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156: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.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156: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-05-24T22:08:37.73287Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-24T22:08:37.732892Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-05-24T22:08:37.732917Z","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-05-24T22:08:37.733851Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-05-24T22:08:37.734032Z","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.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156: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-05-24T22:08:37.737488Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.132893ms"} {"level":"info","ts":"2026-05-24T22:08:37.749436Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-05-24T22:08:37.749553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-05-24T22:08:37.749589Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-05-24T22:08:37.749602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-24T22:08:37.749617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-05-24T22:08:37.749671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-05-24T22:08:37.755632Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-24T22:08:37.758316Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-24T22:08:37.759539Z","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-05-24T22:08:37.76227Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-24T22:08:37.76278Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-24T22:08:37.762982Z","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-05-24T22:08:37.763093Z","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-05-24T22:08:37.763102Z","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-05-24T22:08:37.763711Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-05-24T22:08:37.764542Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-05-24T22:08:37.767373Z","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-05-24T22:08:37.767542Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-05-24T22:08:37.767617Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-05-24T22:08:37.768747Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-24T22:08:37.768804Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-24T22:08:38.550375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-05-24T22:08:38.550439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-24T22:08:38.550479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-05-24T22:08:38.5505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-05-24T22:08:38.550512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-05-24T22:08:38.550536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-05-24T22:08:38.550563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-05-24T22:08:38.554275Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-24T22:08:38.563281Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-05-24T22:08:38.56333Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-24T22:08:38.563371Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-24T22:08:38.563661Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-24T22:08:38.563736Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-24T22:08:38.5647Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-05-24T22:08:38.564837Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-24T22:08:38.564874Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-24T22:08:38.566496Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-05-24T22:08:38.567474Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-24T22:09:04.41945Z","caller":"traceutil/trace.go:171","msg":"trace[1421206813] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"123.693611ms","start":"2026-05-24T22:09:04.295723Z","end":"2026-05-24T22:09:04.419417Z","steps":["trace[1421206813] 'process raft request' (duration: 123.416024ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:09:04.569907Z","caller":"traceutil/trace.go:171","msg":"trace[441366345] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"145.902528ms","start":"2026-05-24T22:09:04.423972Z","end":"2026-05-24T22:09:04.569874Z","steps":["trace[441366345] 'process raft request' (duration: 145.691372ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:09:22.96491Z","caller":"traceutil/trace.go:171","msg":"trace[939228491] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"141.485046ms","start":"2026-05-24T22:09:22.8234Z","end":"2026-05-24T22:09:22.964885Z","steps":["trace[939228491] 'process raft request' (duration: 141.326622ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:09:23.925927Z","caller":"traceutil/trace.go:171","msg":"trace[705097887] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"247.385753ms","start":"2026-05-24T22:09:23.678496Z","end":"2026-05-24T22:09:23.925882Z","steps":["trace[705097887] 'read index received' (duration: 246.21791ms)","trace[705097887] 'applied index is now lower than readState.Index' (duration: 1.165753ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T22:09:23.926047Z","caller":"traceutil/trace.go:171","msg":"trace[638804644] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"368.401932ms","start":"2026-05-24T22:09:23.557583Z","end":"2026-05-24T22:09:23.925985Z","steps":["trace[638804644] 'process raft request' (duration: 367.528038ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:09:23.926217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.684341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-24T22:09:23.926333Z","caller":"traceutil/trace.go:171","msg":"trace[2088839225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:586; }","duration":"247.862806ms","start":"2026-05-24T22:09:23.67845Z","end":"2026-05-24T22:09:23.926313Z","steps":["trace[2088839225] 'agreement among raft nodes before linearized reading' (duration: 247.65399ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:09:23.926909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T22:09:23.557535Z","time spent":"368.636978ms","remote":"127.0.0.1:52942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T22:10:06.331777Z","caller":"traceutil/trace.go:171","msg":"trace[711743614] transaction","detail":"{read_only:false; response_revision:1153; number_of_response:1; }","duration":"127.535257ms","start":"2026-05-24T22:10:06.204224Z","end":"2026-05-24T22:10:06.33176Z","steps":["trace[711743614] 'process raft request' (duration: 127.419014ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:10:06.35491Z","caller":"traceutil/trace.go:171","msg":"trace[1178359568] transaction","detail":"{read_only:false; response_revision:1154; number_of_response:1; }","duration":"150.191408ms","start":"2026-05-24T22:10:06.204701Z","end":"2026-05-24T22:10:06.354892Z","steps":["trace[1178359568] 'process raft request' (duration: 149.924819ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:10:55.563801Z","caller":"traceutil/trace.go:171","msg":"trace[1778131029] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"210.247072ms","start":"2026-05-24T22:10:55.353525Z","end":"2026-05-24T22:10:55.563772Z","steps":["trace[1778131029] 'process raft request' (duration: 210.053846ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:10:55.589148Z","caller":"traceutil/trace.go:171","msg":"trace[948984533] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"233.045446ms","start":"2026-05-24T22:10:55.356069Z","end":"2026-05-24T22:10:55.589114Z","steps":["trace[948984533] 'process raft request' (duration: 232.851129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:10:55.9138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.645789ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-24T22:10:55.913932Z","caller":"traceutil/trace.go:171","msg":"trace[609789135] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"310.273774ms","start":"2026-05-24T22:10:55.603639Z","end":"2026-05-24T22:10:55.913912Z","steps":["trace[609789135] 'process raft request' (duration: 80.259844ms)","trace[609789135] 'compare' (duration: 229.450984ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T22:10:55.913999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T22:10:55.603621Z","time spent":"310.347975ms","remote":"127.0.0.1:53070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-24T22:10:55.922102Z","caller":"traceutil/trace.go:171","msg":"trace[27997977] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"270.209703ms","start":"2026-05-24T22:10:55.651863Z","end":"2026-05-24T22:10:55.922073Z","steps":["trace[27997977] 'process raft request' (duration: 269.946795ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:10:55.922124Z","caller":"traceutil/trace.go:171","msg":"trace[1327621133] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"268.105544ms","start":"2026-05-24T22:10:55.654001Z","end":"2026-05-24T22:10:55.922107Z","steps":["trace[1327621133] 'process raft request' (duration: 267.96657ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:10:55.922182Z","caller":"traceutil/trace.go:171","msg":"trace[2142423363] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"268.038782ms","start":"2026-05-24T22:10:55.654106Z","end":"2026-05-24T22:10:55.922145Z","steps":["trace[2142423363] 'process raft request' (duration: 267.919098ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:10:55.922327Z","caller":"traceutil/trace.go:171","msg":"trace[1894622261] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"267.195738ms","start":"2026-05-24T22:10:55.655113Z","end":"2026-05-24T22:10:55.922308Z","steps":["trace[1894622261] 'process raft request' (duration: 266.951112ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:11:46.42992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.177575ms","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-05-24T22:11:46.430029Z","caller":"traceutil/trace.go:171","msg":"trace[358014986] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2163; }","duration":"145.34996ms","start":"2026-05-24T22:11:46.284658Z","end":"2026-05-24T22:11:46.430008Z","steps":["trace[358014986] 'range keys from in-memory index tree' (duration: 144.970529ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:11:46.430255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.968738ms","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-05-24T22:11:46.430332Z","caller":"traceutil/trace.go:171","msg":"trace[1293198729] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2163; }","duration":"123.082411ms","start":"2026-05-24T22:11:46.30723Z","end":"2026-05-24T22:11:46.430313Z","steps":["trace[1293198729] 'range keys from in-memory index tree' (duration: 122.815563ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:11:46.647065Z","caller":"traceutil/trace.go:171","msg":"trace[1755364373] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"212.018451ms","start":"2026-05-24T22:11:46.435005Z","end":"2026-05-24T22:11:46.647024Z","steps":["trace[1755364373] 'process raft request' (duration: 211.739443ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:12:39.099801Z","caller":"traceutil/trace.go:171","msg":"trace[1748179503] transaction","detail":"{read_only:false; response_revision:2618; number_of_response:1; }","duration":"158.439052ms","start":"2026-05-24T22:12:38.941329Z","end":"2026-05-24T22:12:39.099768Z","steps":["trace[1748179503] 'process raft request' (duration: 158.207026ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:12:39.109817Z","caller":"traceutil/trace.go:171","msg":"trace[421502668] linearizableReadLoop","detail":"{readStateIndex:2717; appliedIndex:2714; }","duration":"147.922409ms","start":"2026-05-24T22:12:38.96188Z","end":"2026-05-24T22:12:39.109803Z","steps":["trace[421502668] 'read index received' (duration: 137.659602ms)","trace[421502668] 'applied index is now lower than readState.Index' (duration: 10.261677ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T22:12:39.10993Z","caller":"traceutil/trace.go:171","msg":"trace[1773452369] transaction","detail":"{read_only:false; response_revision:2620; number_of_response:1; }","duration":"150.82117ms","start":"2026-05-24T22:12:38.959085Z","end":"2026-05-24T22:12:39.109906Z","steps":["trace[1773452369] 'process raft request' (duration: 150.653835ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:12:39.1099Z","caller":"traceutil/trace.go:171","msg":"trace[474411232] transaction","detail":"{read_only:false; response_revision:2619; number_of_response:1; }","duration":"152.174847ms","start":"2026-05-24T22:12:38.957667Z","end":"2026-05-24T22:12:39.109842Z","steps":["trace[474411232] 'process raft request' (duration: 152.008423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:12:39.110265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.33923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-24T22:12:39.110305Z","caller":"traceutil/trace.go:171","msg":"trace[948059367] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:2621; }","duration":"148.457494ms","start":"2026-05-24T22:12:38.961837Z","end":"2026-05-24T22:12:39.110294Z","steps":["trace[948059367] 'agreement among raft nodes before linearized reading' (duration: 148.316ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:13:12.838762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.522743ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-24T22:13:12.838898Z","caller":"traceutil/trace.go:171","msg":"trace[1062166767] linearizableReadLoop","detail":"{readStateIndex:2928; appliedIndex:2927; }","duration":"109.955699ms","start":"2026-05-24T22:13:12.728924Z","end":"2026-05-24T22:13:12.83888Z","steps":["trace[1062166767] 'read index received' (duration: 61.511µs)","trace[1062166767] 'applied index is now lower than readState.Index' (duration: 109.892998ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T22:13:12.838986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.068333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-24T22:13:12.839017Z","caller":"traceutil/trace.go:171","msg":"trace[1877991213] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:2823; }","duration":"110.139975ms","start":"2026-05-24T22:13:12.728869Z","end":"2026-05-24T22:13:12.839009Z","steps":["trace[1877991213] 'agreement among raft nodes before linearized reading' (duration: 110.059802ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:13:12.839204Z","caller":"traceutil/trace.go:171","msg":"trace[1641361631] transaction","detail":"{read_only:false; response_revision:2823; number_of_response:1; }","duration":"349.609645ms","start":"2026-05-24T22:13:12.489555Z","end":"2026-05-24T22:13:12.839165Z","steps":["trace[1641361631] 'process raft request' (duration: 198.593878ms)","trace[1641361631] 'compare' (duration: 150.3916ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T22:13:12.839402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T22:13:12.489525Z","time spent":"349.76852ms","remote":"127.0.0.1:53070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T22:15:48.89035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.693136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8mnhk\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-05-24T22:15:48.890556Z","caller":"traceutil/trace.go:171","msg":"trace[1371498148] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8mnhk; range_end:; response_count:1; response_revision:3846; }","duration":"137.962454ms","start":"2026-05-24T22:15:48.752568Z","end":"2026-05-24T22:15:48.89053Z","steps":["trace[1371498148] 'range keys from in-memory index tree' (duration: 137.490871ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:17:08.606238Z","caller":"traceutil/trace.go:171","msg":"trace[404318850] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4822; }","duration":"204.466811ms","start":"2026-05-24T22:17:08.401729Z","end":"2026-05-24T22:17:08.606196Z","steps":["trace[404318850] 'process raft request' (duration: 166.169788ms)","trace[404318850] 'compare' (duration: 38.014495ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T22:17:08.636641Z","caller":"traceutil/trace.go:171","msg":"trace[1026502494] transaction","detail":"{read_only:false; response_revision:4823; number_of_response:1; }","duration":"233.918853ms","start":"2026-05-24T22:17:08.402671Z","end":"2026-05-24T22:17:08.63659Z","steps":["trace[1026502494] 'process raft request' (duration: 233.577904ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:17:08.636688Z","caller":"traceutil/trace.go:171","msg":"trace[2108806930] transaction","detail":"{read_only:false; response_revision:4824; number_of_response:1; }","duration":"231.288259ms","start":"2026-05-24T22:17:08.40536Z","end":"2026-05-24T22:17:08.636648Z","steps":["trace[2108806930] 'process raft request' (duration: 231.078493ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:17:08.636881Z","caller":"traceutil/trace.go:171","msg":"trace[305114717] transaction","detail":"{read_only:false; response_revision:4825; number_of_response:1; }","duration":"230.207088ms","start":"2026-05-24T22:17:08.406504Z","end":"2026-05-24T22:17:08.636712Z","steps":["trace[305114717] 'process raft request' (duration: 229.986512ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:17:08.637509Z","caller":"traceutil/trace.go:171","msg":"trace[1647203379] transaction","detail":"{read_only:false; response_revision:4826; number_of_response:1; }","duration":"221.690027ms","start":"2026-05-24T22:17:08.415803Z","end":"2026-05-24T22:17:08.637493Z","steps":["trace[1647203379] 'process raft request' (duration: 220.732901ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:17:08.637498Z","caller":"traceutil/trace.go:171","msg":"trace[320275592] linearizableReadLoop","detail":"{readStateIndex:5003; appliedIndex:5001; }","duration":"232.843063ms","start":"2026-05-24T22:17:08.404619Z","end":"2026-05-24T22:17:08.637462Z","steps":["trace[320275592] 'read index received' (duration: 163.297966ms)","trace[320275592] 'applied index is now lower than readState.Index' (duration: 69.543787ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T22:17:08.637745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.09985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"warn","ts":"2026-05-24T22:17:08.637807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.916947ms","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-05-24T22:17:08.637841Z","caller":"traceutil/trace.go:171","msg":"trace[1909624043] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4826; }","duration":"233.225554ms","start":"2026-05-24T22:17:08.404594Z","end":"2026-05-24T22:17:08.63782Z","steps":["trace[1909624043] 'agreement among raft nodes before linearized reading' (duration: 232.962206ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:17:08.637849Z","caller":"traceutil/trace.go:171","msg":"trace[896704255] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4826; }","duration":"162.015341ms","start":"2026-05-24T22:17:08.47582Z","end":"2026-05-24T22:17:08.637836Z","steps":["trace[896704255] 'agreement among raft nodes before linearized reading' (duration: 161.836176ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:17:17.12515Z","caller":"traceutil/trace.go:171","msg":"trace[1862113495] linearizableReadLoop","detail":"{readStateIndex:5248; appliedIndex:5247; }","duration":"324.451412ms","start":"2026-05-24T22:17:16.800673Z","end":"2026-05-24T22:17:17.125124Z","steps":["trace[1862113495] 'read index received' (duration: 324.286098ms)","trace[1862113495] 'applied index is now lower than readState.Index' (duration: 164.294µs)"],"step_count":2} {"level":"info","ts":"2026-05-24T22:17:17.125283Z","caller":"traceutil/trace.go:171","msg":"trace[817804205] transaction","detail":"{read_only:false; response_revision:5062; number_of_response:1; }","duration":"327.097978ms","start":"2026-05-24T22:17:16.798153Z","end":"2026-05-24T22:17:17.125251Z","steps":["trace[817804205] 'process raft request' (duration: 326.82183ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:17:17.125362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.671899ms","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-05-24T22:17:17.125444Z","caller":"traceutil/trace.go:171","msg":"trace[2012790065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5062; }","duration":"324.801052ms","start":"2026-05-24T22:17:16.800632Z","end":"2026-05-24T22:17:17.125433Z","steps":["trace[2012790065] 'agreement among raft nodes before linearized reading' (duration: 324.594316ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:17:17.125467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T22:17:16.798125Z","time spent":"327.237311ms","remote":"127.0.0.1:53070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T22:17:17.125484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T22:17:16.800614Z","time spent":"324.859894ms","remote":"127.0.0.1:53070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-24T22:17:29.622558Z","caller":"traceutil/trace.go:171","msg":"trace[1397245168] linearizableReadLoop","detail":"{readStateIndex:5500; appliedIndex:5499; }","duration":"109.254187ms","start":"2026-05-24T22:17:29.513268Z","end":"2026-05-24T22:17:29.622522Z","steps":["trace[1397245168] 'read index received' (duration: 55.764556ms)","trace[1397245168] 'applied index is now lower than readState.Index' (duration: 53.488491ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T22:17:29.622733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.459973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T22:17:29.622772Z","caller":"traceutil/trace.go:171","msg":"trace[2064803165] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:5305; }","duration":"109.570486ms","start":"2026-05-24T22:17:29.513192Z","end":"2026-05-24T22:17:29.622763Z","steps":["trace[2064803165] 'agreement among raft nodes before linearized reading' (duration: 109.466863ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:17:29.622587Z","caller":"traceutil/trace.go:171","msg":"trace[1820020191] transaction","detail":"{read_only:false; response_revision:5305; number_of_response:1; }","duration":"144.865268ms","start":"2026-05-24T22:17:29.477677Z","end":"2026-05-24T22:17:29.622543Z","steps":["trace[1820020191] 'process raft request' (duration: 91.319705ms)","trace[1820020191] 'compare' (duration: 53.348477ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T22:17:30.206087Z","caller":"traceutil/trace.go:171","msg":"trace[2060395424] transaction","detail":"{read_only:false; response_revision:5312; number_of_response:1; }","duration":"200.772346ms","start":"2026-05-24T22:17:30.005163Z","end":"2026-05-24T22:17:30.205936Z","steps":["trace[2060395424] 'process raft request' (duration: 200.047486ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:17:30.358224Z","caller":"traceutil/trace.go:171","msg":"trace[571164041] transaction","detail":"{read_only:false; response_revision:5313; number_of_response:1; }","duration":"148.338695ms","start":"2026-05-24T22:17:30.209844Z","end":"2026-05-24T22:17:30.358183Z","steps":["trace[571164041] 'process raft request' (duration: 144.472646ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:17:30.362564Z","caller":"traceutil/trace.go:171","msg":"trace[924898368] transaction","detail":"{read_only:false; response_revision:5314; number_of_response:1; }","duration":"151.988597ms","start":"2026-05-24T22:17:30.210542Z","end":"2026-05-24T22:17:30.362531Z","steps":["trace[924898368] 'process raft request' (duration: 151.168294ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:17:30.362763Z","caller":"traceutil/trace.go:171","msg":"trace[415035117] transaction","detail":"{read_only:false; response_revision:5315; number_of_response:1; }","duration":"123.687042ms","start":"2026-05-24T22:17:30.23904Z","end":"2026-05-24T22:17:30.362727Z","steps":["trace[415035117] 'process raft request' (duration: 123.435545ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:17:38.617046Z","caller":"traceutil/trace.go:171","msg":"trace[1536018198] transaction","detail":"{read_only:false; response_revision:5498; number_of_response:1; }","duration":"224.40244ms","start":"2026-05-24T22:17:38.392607Z","end":"2026-05-24T22:17:38.61701Z","steps":["trace[1536018198] 'process raft request' (duration: 150.307999ms)","trace[1536018198] 'compare' (duration: 73.846924ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T22:17:38.617536Z","caller":"traceutil/trace.go:171","msg":"trace[1313051015] transaction","detail":"{read_only:false; response_revision:5499; number_of_response:1; }","duration":"222.823826ms","start":"2026-05-24T22:17:38.394661Z","end":"2026-05-24T22:17:38.617485Z","steps":["trace[1313051015] 'process raft request' (duration: 222.305802ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:18:38.601719Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2965} {"level":"info","ts":"2026-05-24T22:18:38.671727Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2965,"took":"67.840294ms","hash":3794789272,"current-db-size-bytes":57925632,"current-db-size":"58 MB","current-db-size-in-use-bytes":33730560,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-05-24T22:18:38.671859Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3794789272,"revision":2965,"compact-revision":-1} {"level":"info","ts":"2026-05-24T22:23:38.609412Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6037} {"level":"info","ts":"2026-05-24T22:23:38.711567Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6037,"took":"100.177861ms","hash":226109362,"current-db-size-bytes":57925632,"current-db-size":"58 MB","current-db-size-in-use-bytes":21852160,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-05-24T22:23:38.711627Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":226109362,"revision":6037,"compact-revision":2965} {"level":"warn","ts":"2026-05-24T22:24:08.499683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.787524ms","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-05-24T22:24:08.500454Z","caller":"traceutil/trace.go:171","msg":"trace[1457634669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8418; }","duration":"153.778913ms","start":"2026-05-24T22:24:08.346645Z","end":"2026-05-24T22:24:08.500423Z","steps":["trace[1457634669] 'range keys from in-memory index tree' (duration: 152.520417ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:24:09.442097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.033541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-24T22:24:09.442618Z","caller":"traceutil/trace.go:171","msg":"trace[238372819] transaction","detail":"{read_only:false; response_revision:8422; number_of_response:1; }","duration":"124.509341ms","start":"2026-05-24T22:24:09.318062Z","end":"2026-05-24T22:24:09.442572Z","steps":["trace[238372819] 'process raft request' (duration: 95.048545ms)","trace[238372819] 'compare' (duration: 28.720956ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T22:24:09.443199Z","caller":"traceutil/trace.go:171","msg":"trace[565764518] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:8421; }","duration":"133.253008ms","start":"2026-05-24T22:24:09.308949Z","end":"2026-05-24T22:24:09.442202Z","steps":["trace[565764518] 'count revisions from in-memory index tree' (duration: 132.920578ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:24:37.983267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.07639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-24T22:24:37.983292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.271097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-24T22:24:37.983346Z","caller":"traceutil/trace.go:171","msg":"trace[1140082377] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:8630; }","duration":"221.228675ms","start":"2026-05-24T22:24:37.762102Z","end":"2026-05-24T22:24:37.98333Z","steps":["trace[1140082377] 'count revisions from in-memory index tree' (duration: 220.984957ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:24:37.983377Z","caller":"traceutil/trace.go:171","msg":"trace[169248271] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:8630; }","duration":"128.415741ms","start":"2026-05-24T22:24:37.854943Z","end":"2026-05-24T22:24:37.983358Z","steps":["trace[169248271] 'count revisions from in-memory index tree' (duration: 128.206886ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:24:41.478545Z","caller":"traceutil/trace.go:171","msg":"trace[1628158113] transaction","detail":"{read_only:false; response_revision:8646; number_of_response:1; }","duration":"125.14555ms","start":"2026-05-24T22:24:41.353348Z","end":"2026-05-24T22:24:41.478493Z","steps":["trace[1628158113] 'process raft request' (duration: 124.860612ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:24:41.711737Z","caller":"traceutil/trace.go:171","msg":"trace[1010773562] transaction","detail":"{read_only:false; response_revision:8647; number_of_response:1; }","duration":"147.124176ms","start":"2026-05-24T22:24:41.564568Z","end":"2026-05-24T22:24:41.711692Z","steps":["trace[1010773562] 'process raft request' (duration: 146.866579ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:24:42.003918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.5139ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-24T22:24:42.004142Z","caller":"traceutil/trace.go:171","msg":"trace[1470131602] linearizableReadLoop","detail":"{readStateIndex:8957; appliedIndex:8954; }","duration":"119.074739ms","start":"2026-05-24T22:24:41.885049Z","end":"2026-05-24T22:24:42.004124Z","steps":["trace[1470131602] 'read index received' (duration: 113.330528ms)","trace[1470131602] 'applied index is now lower than readState.Index' (duration: 5.743351ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T22:24:42.004291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.255935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.156\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-24T22:24:42.004323Z","caller":"traceutil/trace.go:171","msg":"trace[57267210] range","detail":"{range_begin:/registry/masterleases/199.204.45.156; range_end:; response_count:1; response_revision:8650; }","duration":"119.338828ms","start":"2026-05-24T22:24:41.884972Z","end":"2026-05-24T22:24:42.004311Z","steps":["trace[57267210] 'agreement among raft nodes before linearized reading' (duration: 119.202503ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:24:42.004416Z","caller":"traceutil/trace.go:171","msg":"trace[1902984686] transaction","detail":"{read_only:false; response_revision:8649; number_of_response:1; }","duration":"288.287396ms","start":"2026-05-24T22:24:41.716104Z","end":"2026-05-24T22:24:42.004392Z","steps":["trace[1902984686] 'process raft request' (duration: 287.926095ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:24:42.004428Z","caller":"traceutil/trace.go:171","msg":"trace[1153242596] transaction","detail":"{read_only:false; response_revision:8650; number_of_response:1; }","duration":"282.443791ms","start":"2026-05-24T22:24:41.721968Z","end":"2026-05-24T22:24:42.004412Z","steps":["trace[1153242596] 'process raft request' (duration: 282.122051ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:24:42.004318Z","caller":"traceutil/trace.go:171","msg":"trace[1645276855] transaction","detail":"{read_only:false; response_revision:8648; number_of_response:1; }","duration":"288.172953ms","start":"2026-05-24T22:24:41.716106Z","end":"2026-05-24T22:24:42.004279Z","steps":["trace[1645276855] 'process raft request' (duration: 167.214669ms)","trace[1645276855] 'compare' (duration: 120.394217ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T22:25:09.712833Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002432.wal"} {"level":"info","ts":"2026-05-24T22:26:28.843444Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5ac240a6daec2148","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-24T22:26:28.849168Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-24T22:26:28.849304Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-24T22:28:19.322158Z","caller":"traceutil/trace.go:171","msg":"trace[2106111232] transaction","detail":"{read_only:false; response_revision:10509; number_of_response:1; }","duration":"117.623799ms","start":"2026-05-24T22:28:19.204507Z","end":"2026-05-24T22:28:19.322131Z","steps":["trace[2106111232] 'process raft request' (duration: 117.445333ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:28:19.322753Z","caller":"traceutil/trace.go:171","msg":"trace[1047023911] linearizableReadLoop","detail":"{readStateIndex:10876; appliedIndex:10874; }","duration":"115.171007ms","start":"2026-05-24T22:28:19.207549Z","end":"2026-05-24T22:28:19.32272Z","steps":["trace[1047023911] 'read index received' (duration: 114.384675ms)","trace[1047023911] 'applied index is now lower than readState.Index' (duration: 784.822µs)"],"step_count":2} {"level":"info","ts":"2026-05-24T22:28:19.322876Z","caller":"traceutil/trace.go:171","msg":"trace[1105234709] transaction","detail":"{read_only:false; response_revision:10510; number_of_response:1; }","duration":"116.903947ms","start":"2026-05-24T22:28:19.205924Z","end":"2026-05-24T22:28:19.322827Z","steps":["trace[1105234709] 'process raft request' (duration: 116.63556ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:28:19.323103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.523767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/staffeln-db-init-hszn4\" ","response":"range_response_count:1 size:7343"} {"level":"info","ts":"2026-05-24T22:28:19.323182Z","caller":"traceutil/trace.go:171","msg":"trace[1466355337] range","detail":"{range_begin:/registry/pods/openstack/staffeln-db-init-hszn4; range_end:; response_count:1; response_revision:10510; }","duration":"115.651971ms","start":"2026-05-24T22:28:19.207514Z","end":"2026-05-24T22:28:19.323165Z","steps":["trace[1466355337] 'agreement among raft nodes before linearized reading' (duration: 115.365633ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:28:38.615769Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8109} {"level":"info","ts":"2026-05-24T22:28:38.679299Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8109,"took":"61.505236ms","hash":1053517604,"current-db-size-bytes":57925632,"current-db-size":"58 MB","current-db-size-in-use-bytes":29519872,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-24T22:28:38.679361Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1053517604,"revision":8109,"compact-revision":6037} {"level":"warn","ts":"2026-05-24T22:29:25.808035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.300156ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-24T22:29:25.808158Z","caller":"traceutil/trace.go:171","msg":"trace[607620098] linearizableReadLoop","detail":"{readStateIndex:11585; appliedIndex:11584; }","duration":"153.451536ms","start":"2026-05-24T22:29:25.654688Z","end":"2026-05-24T22:29:25.808139Z","steps":["trace[607620098] 'read index received' (duration: 17.879802ms)","trace[607620098] 'applied index is now lower than readState.Index' (duration: 135.570324ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T22:29:25.80818Z","caller":"traceutil/trace.go:171","msg":"trace[881221756] transaction","detail":"{read_only:false; response_revision:11202; number_of_response:1; }","duration":"153.54891ms","start":"2026-05-24T22:29:25.654596Z","end":"2026-05-24T22:29:25.808145Z","steps":["trace[881221756] 'process raft request' (duration: 17.980286ms)","trace[881221756] 'compare' (duration: 135.186863ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T22:29:25.808312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.619812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/cinder-backup-6bbf57bc6d-6cmp2.18b2a0eeb4d9b5a4\" ","response":"range_response_count:1 size:804"} {"level":"info","ts":"2026-05-24T22:29:25.808355Z","caller":"traceutil/trace.go:171","msg":"trace[1926024081] range","detail":"{range_begin:/registry/events/openstack/cinder-backup-6bbf57bc6d-6cmp2.18b2a0eeb4d9b5a4; range_end:; response_count:1; response_revision:11202; }","duration":"153.681983ms","start":"2026-05-24T22:29:25.654658Z","end":"2026-05-24T22:29:25.808339Z","steps":["trace[1926024081] 'agreement among raft nodes before linearized reading' (duration: 153.548449ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:29:25.819986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.180554ms","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-05-24T22:29:25.820041Z","caller":"traceutil/trace.go:171","msg":"trace[1354328544] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:11205; }","duration":"149.276567ms","start":"2026-05-24T22:29:25.670751Z","end":"2026-05-24T22:29:25.820027Z","steps":["trace[1354328544] 'agreement among raft nodes before linearized reading' (duration: 149.075101ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:29:25.820068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.620794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-24T22:29:25.82014Z","caller":"traceutil/trace.go:171","msg":"trace[834663091] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11205; }","duration":"136.701706ms","start":"2026-05-24T22:29:25.683422Z","end":"2026-05-24T22:29:25.820124Z","steps":["trace[834663091] 'agreement among raft nodes before linearized reading' (duration: 136.499161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:29:25.820091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.491032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-24T22:29:25.820362Z","caller":"traceutil/trace.go:171","msg":"trace[1395868182] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:11205; }","duration":"103.818981ms","start":"2026-05-24T22:29:25.716509Z","end":"2026-05-24T22:29:25.820328Z","steps":["trace[1395868182] 'agreement among raft nodes before linearized reading' (duration: 103.329637ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:29:43.034051Z","caller":"traceutil/trace.go:171","msg":"trace[1223699835] linearizableReadLoop","detail":"{readStateIndex:11685; appliedIndex:11684; }","duration":"158.391859ms","start":"2026-05-24T22:29:42.87563Z","end":"2026-05-24T22:29:43.034022Z","steps":["trace[1223699835] 'read index received' (duration: 158.217014ms)","trace[1223699835] 'applied index is now lower than readState.Index' (duration: 173.865µs)"],"step_count":2} {"level":"info","ts":"2026-05-24T22:29:43.034109Z","caller":"traceutil/trace.go:171","msg":"trace[173171355] transaction","detail":"{read_only:false; response_revision:11297; number_of_response:1; }","duration":"163.444744ms","start":"2026-05-24T22:29:42.870626Z","end":"2026-05-24T22:29:43.034071Z","steps":["trace[173171355] 'process raft request' (duration: 163.235808ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:29:43.034232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.495712ms","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-05-24T22:29:43.034278Z","caller":"traceutil/trace.go:171","msg":"trace[378852052] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:11297; }","duration":"158.567684ms","start":"2026-05-24T22:29:42.875696Z","end":"2026-05-24T22:29:43.034264Z","steps":["trace[378852052] 'agreement among raft nodes before linearized reading' (duration: 158.489602ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:29:43.034456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.006309ms","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-05-24T22:29:43.034447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.719202ms","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-05-24T22:29:43.034493Z","caller":"traceutil/trace.go:171","msg":"trace[162994487] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:11297; }","duration":"157.06157ms","start":"2026-05-24T22:29:42.877423Z","end":"2026-05-24T22:29:43.034485Z","steps":["trace[162994487] 'agreement among raft nodes before linearized reading' (duration: 157.004639ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:29:43.034537Z","caller":"traceutil/trace.go:171","msg":"trace[1481468550] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:11297; }","duration":"155.847596ms","start":"2026-05-24T22:29:42.878668Z","end":"2026-05-24T22:29:43.034516Z","steps":["trace[1481468550] 'agreement among raft nodes before linearized reading' (duration: 155.566488ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:29:43.034581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.605175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-24T22:29:43.034626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.338217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T22:29:43.034663Z","caller":"traceutil/trace.go:171","msg":"trace[1593127378] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:11297; }","duration":"158.403918ms","start":"2026-05-24T22:29:42.876251Z","end":"2026-05-24T22:29:43.034654Z","steps":["trace[1593127378] 'agreement among raft nodes before linearized reading' (duration: 158.355507ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:29:43.034674Z","caller":"traceutil/trace.go:171","msg":"trace[48559152] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:11297; }","duration":"158.732529ms","start":"2026-05-24T22:29:42.87592Z","end":"2026-05-24T22:29:43.034653Z","steps":["trace[48559152] 'agreement among raft nodes before linearized reading' (duration: 158.545364ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:29:43.034751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.159532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-24T22:29:43.034946Z","caller":"traceutil/trace.go:171","msg":"trace[1978277378] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:11297; }","duration":"111.40536ms","start":"2026-05-24T22:29:42.923483Z","end":"2026-05-24T22:29:43.034888Z","steps":["trace[1978277378] 'agreement among raft nodes before linearized reading' (duration: 110.846444ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:29:43.035307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.635224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-05-24T22:29:43.035371Z","caller":"traceutil/trace.go:171","msg":"trace[1359200719] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:11297; }","duration":"159.766178ms","start":"2026-05-24T22:29:42.87559Z","end":"2026-05-24T22:29:43.035356Z","steps":["trace[1359200719] 'agreement among raft nodes before linearized reading' (duration: 158.583684ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:29:44.023057Z","caller":"traceutil/trace.go:171","msg":"trace[842950476] transaction","detail":"{read_only:false; response_revision:11303; number_of_response:1; }","duration":"146.546138ms","start":"2026-05-24T22:29:43.876476Z","end":"2026-05-24T22:29:44.023022Z","steps":["trace[842950476] 'process raft request' (duration: 128.009325ms)","trace[842950476] 'compare' (duration: 18.355888ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T22:29:44.060594Z","caller":"traceutil/trace.go:171","msg":"trace[1625504306] transaction","detail":"{read_only:false; response_revision:11304; number_of_response:1; }","duration":"181.42885ms","start":"2026-05-24T22:29:43.879131Z","end":"2026-05-24T22:29:44.06056Z","steps":["trace[1625504306] 'process raft request' (duration: 181.230694ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:29:44.060749Z","caller":"traceutil/trace.go:171","msg":"trace[591787222] linearizableReadLoop","detail":"{readStateIndex:11693; appliedIndex:11690; }","duration":"173.932495ms","start":"2026-05-24T22:29:43.886788Z","end":"2026-05-24T22:29:44.06072Z","steps":["trace[591787222] 'read index received' (duration: 117.710821ms)","trace[591787222] 'applied index is now lower than readState.Index' (duration: 56.220654ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T22:29:44.060914Z","caller":"traceutil/trace.go:171","msg":"trace[291549306] transaction","detail":"{read_only:false; response_revision:11305; number_of_response:1; }","duration":"181.694107ms","start":"2026-05-24T22:29:43.8792Z","end":"2026-05-24T22:29:44.060894Z","steps":["trace[291549306] 'process raft request' (duration: 181.304556ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:29:44.061028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.668526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-24T22:29:44.061073Z","caller":"traceutil/trace.go:171","msg":"trace[1426486960] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:11305; }","duration":"151.752738ms","start":"2026-05-24T22:29:43.909307Z","end":"2026-05-24T22:29:44.061059Z","steps":["trace[1426486960] 'agreement among raft nodes before linearized reading' (duration: 151.655915ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:29:44.061151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.351878ms","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-05-24T22:29:44.061235Z","caller":"traceutil/trace.go:171","msg":"trace[1976211899] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11305; }","duration":"174.480541ms","start":"2026-05-24T22:29:43.886735Z","end":"2026-05-24T22:29:44.061215Z","steps":["trace[1976211899] 'agreement among raft nodes before linearized reading' (duration: 174.268234ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:29:44.061259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.725388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-24T22:29:44.061364Z","caller":"traceutil/trace.go:171","msg":"trace[1327730485] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11305; }","duration":"143.888713ms","start":"2026-05-24T22:29:43.917453Z","end":"2026-05-24T22:29:44.061342Z","steps":["trace[1327730485] 'agreement among raft nodes before linearized reading' (duration: 143.546272ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:33:38.621258Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10714} {"level":"info","ts":"2026-05-24T22:33:38.707687Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10714,"took":"84.336439ms","hash":4177017611,"current-db-size-bytes":57925632,"current-db-size":"58 MB","current-db-size-in-use-bytes":27160576,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-05-24T22:33:38.707781Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4177017611,"revision":10714,"compact-revision":8109} {"level":"warn","ts":"2026-05-24T22:36:07.282562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.083443ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-24T22:36:07.282875Z","caller":"traceutil/trace.go:171","msg":"trace[614756199] transaction","detail":"{read_only:false; response_revision:13870; number_of_response:1; }","duration":"176.610372ms","start":"2026-05-24T22:36:07.106246Z","end":"2026-05-24T22:36:07.282856Z","steps":["trace[614756199] 'process raft request' (duration: 61.149707ms)","trace[614756199] 'compare' (duration: 114.845577ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T22:36:07.282896Z","caller":"traceutil/trace.go:171","msg":"trace[1717984134] linearizableReadLoop","detail":"{readStateIndex:14346; appliedIndex:14345; }","duration":"148.214514ms","start":"2026-05-24T22:36:07.134655Z","end":"2026-05-24T22:36:07.28287Z","steps":["trace[1717984134] 'read index received' (duration: 32.78688ms)","trace[1717984134] 'applied index is now lower than readState.Index' (duration: 115.426344ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T22:36:07.284873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.222401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T22:36:07.284915Z","caller":"traceutil/trace.go:171","msg":"trace[1834059014] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13870; }","duration":"150.302443ms","start":"2026-05-24T22:36:07.134601Z","end":"2026-05-24T22:36:07.284904Z","steps":["trace[1834059014] 'agreement among raft nodes before linearized reading' (duration: 148.368469ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:36:15.881006Z","caller":"traceutil/trace.go:171","msg":"trace[1060325656] linearizableReadLoop","detail":"{readStateIndex:14412; appliedIndex:14411; }","duration":"190.640327ms","start":"2026-05-24T22:36:15.690322Z","end":"2026-05-24T22:36:15.880962Z","steps":["trace[1060325656] 'read index received' (duration: 189.993469ms)","trace[1060325656] 'applied index is now lower than readState.Index' (duration: 645.688µs)"],"step_count":2} {"level":"warn","ts":"2026-05-24T22:36:15.881458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.028157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-kv5hb\" ","response":"range_response_count:1 size:12364"} {"level":"info","ts":"2026-05-24T22:36:15.881523Z","caller":"traceutil/trace.go:171","msg":"trace[1231161250] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-kv5hb; range_end:; response_count:1; response_revision:13932; }","duration":"191.225123ms","start":"2026-05-24T22:36:15.690286Z","end":"2026-05-24T22:36:15.881511Z","steps":["trace[1231161250] 'agreement among raft nodes before linearized reading' (duration: 190.881873ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:36:15.882007Z","caller":"traceutil/trace.go:171","msg":"trace[1251096547] transaction","detail":"{read_only:false; response_revision:13932; number_of_response:1; }","duration":"196.926713ms","start":"2026-05-24T22:36:15.68505Z","end":"2026-05-24T22:36:15.881977Z","steps":["trace[1251096547] 'process raft request' (duration: 195.403241ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T22:36:25.252787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.646729ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-24T22:36:25.252931Z","caller":"traceutil/trace.go:171","msg":"trace[1917590769] linearizableReadLoop","detail":"{readStateIndex:14583; appliedIndex:14582; }","duration":"117.740127ms","start":"2026-05-24T22:36:25.135169Z","end":"2026-05-24T22:36:25.252909Z","steps":["trace[1917590769] 'read index received' (duration: 48.681µs)","trace[1917590769] 'applied index is now lower than readState.Index' (duration: 117.690146ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T22:36:25.25307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.903693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T22:36:25.253099Z","caller":"traceutil/trace.go:171","msg":"trace[789513925] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14100; }","duration":"117.975984ms","start":"2026-05-24T22:36:25.135114Z","end":"2026-05-24T22:36:25.25309Z","steps":["trace[789513925] 'agreement among raft nodes before linearized reading' (duration: 117.891872ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:36:25.253009Z","caller":"traceutil/trace.go:171","msg":"trace[1662925170] transaction","detail":"{read_only:false; response_revision:14100; number_of_response:1; }","duration":"266.294282ms","start":"2026-05-24T22:36:24.986633Z","end":"2026-05-24T22:36:25.252928Z","steps":["trace[1662925170] 'process raft request' (duration: 113.421827ms)","trace[1662925170] 'compare' (duration: 152.480004ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T22:36:25.414859Z","caller":"traceutil/trace.go:171","msg":"trace[1375854554] transaction","detail":"{read_only:false; response_revision:14101; number_of_response:1; }","duration":"155.515049ms","start":"2026-05-24T22:36:25.259295Z","end":"2026-05-24T22:36:25.41481Z","steps":["trace[1375854554] 'process raft request' (duration: 155.255422ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:38:38.627038Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12820} {"level":"info","ts":"2026-05-24T22:38:38.707029Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12820,"took":"77.404816ms","hash":44264866,"current-db-size-bytes":57925632,"current-db-size":"58 MB","current-db-size-in-use-bytes":30531584,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-24T22:38:38.707082Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":44264866,"revision":12820,"compact-revision":10714} {"level":"info","ts":"2026-05-24T22:43:38.63479Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15400} {"level":"info","ts":"2026-05-24T22:43:38.733024Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15400,"took":"94.215966ms","hash":3987643206,"current-db-size-bytes":57925632,"current-db-size":"58 MB","current-db-size-in-use-bytes":31707136,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-24T22:43:38.733082Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3987643206,"revision":15400,"compact-revision":12820} {"level":"warn","ts":"2026-05-24T22:43:42.441317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.735799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"} {"level":"info","ts":"2026-05-24T22:43:42.44151Z","caller":"traceutil/trace.go:171","msg":"trace[167310177] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17695; }","duration":"132.004347ms","start":"2026-05-24T22:43:42.309478Z","end":"2026-05-24T22:43:42.441482Z","steps":["trace[167310177] 'range keys from in-memory index tree' (duration: 131.478042ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:43:47.159541Z","caller":"traceutil/trace.go:171","msg":"trace[1661596712] transaction","detail":"{read_only:false; response_revision:17716; number_of_response:1; }","duration":"236.872202ms","start":"2026-05-24T22:43:46.922656Z","end":"2026-05-24T22:43:47.159529Z","steps":["trace[1661596712] 'process raft request' (duration: 236.781839ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:43:47.159795Z","caller":"traceutil/trace.go:171","msg":"trace[1949127832] linearizableReadLoop","detail":"{readStateIndex:18317; appliedIndex:18317; }","duration":"170.737514ms","start":"2026-05-24T22:43:46.989052Z","end":"2026-05-24T22:43:47.159789Z","steps":["trace[1949127832] 'read index received' (duration: 170.734804ms)","trace[1949127832] 'applied index is now lower than readState.Index' (duration: 2.37µs)"],"step_count":2} {"level":"warn","ts":"2026-05-24T22:43:47.159878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.825107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:703"} {"level":"info","ts":"2026-05-24T22:43:47.1599Z","caller":"traceutil/trace.go:171","msg":"trace[2121138492] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:17716; }","duration":"170.889919ms","start":"2026-05-24T22:43:46.989003Z","end":"2026-05-24T22:43:47.159892Z","steps":["trace[2121138492] 'agreement among raft nodes before linearized reading' (duration: 170.810617ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:43:48.368273Z","caller":"traceutil/trace.go:171","msg":"trace[1319482008] transaction","detail":"{read_only:false; response_revision:17729; number_of_response:1; }","duration":"129.111415ms","start":"2026-05-24T22:43:48.239128Z","end":"2026-05-24T22:43:48.368239Z","steps":["trace[1319482008] 'process raft request' (duration: 113.852938ms)","trace[1319482008] 'compare' (duration: 15.010901ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T22:43:48.409601Z","caller":"traceutil/trace.go:171","msg":"trace[1789652857] transaction","detail":"{read_only:false; response_revision:17731; number_of_response:1; }","duration":"157.593726ms","start":"2026-05-24T22:43:48.25198Z","end":"2026-05-24T22:43:48.409574Z","steps":["trace[1789652857] 'process raft request' (duration: 157.521944ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:43:48.409668Z","caller":"traceutil/trace.go:171","msg":"trace[633328486] transaction","detail":"{read_only:false; response_revision:17730; number_of_response:1; }","duration":"169.176481ms","start":"2026-05-24T22:43:48.240453Z","end":"2026-05-24T22:43:48.409629Z","steps":["trace[633328486] 'process raft request' (duration: 168.873713ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T22:48:38.641332Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17663} {"level":"info","ts":"2026-05-24T22:48:38.731332Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17663,"took":"86.807138ms","hash":2563178689,"current-db-size-bytes":57925632,"current-db-size":"58 MB","current-db-size-in-use-bytes":27185152,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-05-24T22:48:38.731409Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2563178689,"revision":17663,"compact-revision":15400} {"level":"info","ts":"2026-05-24T22:48:40.188395Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5ac240a6daec2148","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-24T22:48:40.193347Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-05-24T22:48:40.193486Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}