{"level":"warn","ts":"2026-05-24T12:58:39.966628Z","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-24T12:58:39.966749Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.186:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.186:2380","--initial-cluster=instance=https://162.253.55.186:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.186:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.186: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-24T12:58:39.966827Z","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-24T12:58:39.966842Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.186:2380"]} {"level":"info","ts":"2026-05-24T12:58:39.966865Z","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-24T12:58:39.967517Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"]} {"level":"info","ts":"2026-05-24T12:58:39.967603Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.186:2380"],"listen-peer-urls":["https://162.253.55.186:2380"],"advertise-client-urls":["https://162.253.55.186:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.186: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-24T12:58:39.972338Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.408899ms"} {"level":"info","ts":"2026-05-24T12:58:39.978915Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"612d5169b08bb96b","cluster-id":"20ec8eafba602517"} {"level":"info","ts":"2026-05-24T12:58:39.979105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=()"} {"level":"info","ts":"2026-05-24T12:58:39.979159Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became follower at term 0"} {"level":"info","ts":"2026-05-24T12:58:39.97918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 612d5169b08bb96b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-24T12:58:39.979221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became follower at term 1"} {"level":"info","ts":"2026-05-24T12:58:39.979282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=(7002342510006352235)"} {"level":"warn","ts":"2026-05-24T12:58:39.984507Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-24T12:58:39.985799Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-24T12:58:39.986943Z","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-24T12:58:39.989284Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"612d5169b08bb96b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-24T12:58:39.989426Z","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-24T12:58:39.989535Z","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-24T12:58:39.989551Z","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-24T12:58:39.989492Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"612d5169b08bb96b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-24T12:58:39.991286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b switched to configuration voters=(7002342510006352235)"} {"level":"info","ts":"2026-05-24T12:58:39.991551Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"20ec8eafba602517","local-member-id":"612d5169b08bb96b","added-peer-id":"612d5169b08bb96b","added-peer-peer-urls":["https://162.253.55.186:2380"]} {"level":"info","ts":"2026-05-24T12:58:39.994659Z","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-24T12:58:39.9948Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.186:2380"} {"level":"info","ts":"2026-05-24T12:58:39.994886Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.186:2380"} {"level":"info","ts":"2026-05-24T12:58:39.994988Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"612d5169b08bb96b","initial-advertise-peer-urls":["https://162.253.55.186:2380"],"listen-peer-urls":["https://162.253.55.186:2380"],"advertise-client-urls":["https://162.253.55.186:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.186:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-24T12:58:39.995046Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-24T12:58:40.07985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b is starting a new election at term 1"} {"level":"info","ts":"2026-05-24T12:58:40.07991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became pre-candidate at term 1"} {"level":"info","ts":"2026-05-24T12:58:40.079938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b received MsgPreVoteResp from 612d5169b08bb96b at term 1"} {"level":"info","ts":"2026-05-24T12:58:40.079956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became candidate at term 2"} {"level":"info","ts":"2026-05-24T12:58:40.079965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b received MsgVoteResp from 612d5169b08bb96b at term 2"} {"level":"info","ts":"2026-05-24T12:58:40.079978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"612d5169b08bb96b became leader at term 2"} {"level":"info","ts":"2026-05-24T12:58:40.079993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 612d5169b08bb96b elected leader 612d5169b08bb96b at term 2"} {"level":"info","ts":"2026-05-24T12:58:40.080951Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"612d5169b08bb96b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.186:2379]}","request-path":"/0/members/612d5169b08bb96b/attributes","cluster-id":"20ec8eafba602517","publish-timeout":"7s"} {"level":"info","ts":"2026-05-24T12:58:40.080966Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-24T12:58:40.081004Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-24T12:58:40.081102Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-24T12:58:40.081249Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-24T12:58:40.081294Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-24T12:58:40.082057Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"20ec8eafba602517","local-member-id":"612d5169b08bb96b","cluster-version":"3.5"} {"level":"info","ts":"2026-05-24T12:58:40.082195Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-24T12:58:40.082233Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-24T12:58:40.083726Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-24T12:58:40.084478Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.186:2379"} {"level":"info","ts":"2026-05-24T12:59:03.326984Z","caller":"traceutil/trace.go:171","msg":"trace[1591133695] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"262.889458ms","start":"2026-05-24T12:59:03.06405Z","end":"2026-05-24T12:59:03.326939Z","steps":["trace[1591133695] 'process raft request' (duration: 178.417196ms)","trace[1591133695] 'compare' (duration: 84.3273ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T12:59:23.29569Z","caller":"traceutil/trace.go:171","msg":"trace[966968786] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"346.502754ms","start":"2026-05-24T12:59:22.949161Z","end":"2026-05-24T12:59:23.295664Z","steps":["trace[966968786] 'read index received' (duration: 345.012434ms)","trace[966968786] 'applied index is now lower than readState.Index' (duration: 1.489239ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T12:59:23.295776Z","caller":"traceutil/trace.go:171","msg":"trace[781819626] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"516.970564ms","start":"2026-05-24T12:59:22.778762Z","end":"2026-05-24T12:59:23.295733Z","steps":["trace[781819626] 'process raft request' (duration: 516.142267ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T12:59:23.296051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.868732ms","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-24T12:59:23.296133Z","caller":"traceutil/trace.go:171","msg":"trace[692019540] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:619; }","duration":"346.967224ms","start":"2026-05-24T12:59:22.949151Z","end":"2026-05-24T12:59:23.296118Z","steps":["trace[692019540] 'agreement among raft nodes before linearized reading' (duration: 346.646516ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T12:59:23.296211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T12:59:22.949056Z","time spent":"347.141527ms","remote":"127.0.0.1:59224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-24T12:59:23.296345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T12:59:22.778742Z","time spent":"517.104966ms","remote":"127.0.0.1:59052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-24T12:59:23.302387Z","caller":"traceutil/trace.go:171","msg":"trace[1810060492] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"199.401358ms","start":"2026-05-24T12:59:23.102973Z","end":"2026-05-24T12:59:23.302374Z","steps":["trace[1810060492] 'process raft request' (duration: 199.303626ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T12:59:23.819916Z","caller":"traceutil/trace.go:171","msg":"trace[836701730] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"220.588007ms","start":"2026-05-24T12:59:23.599282Z","end":"2026-05-24T12:59:23.81987Z","steps":["trace[836701730] 'read index received' (duration: 220.514885ms)","trace[836701730] 'applied index is now lower than readState.Index' (duration: 71.962µs)"],"step_count":2} {"level":"info","ts":"2026-05-24T12:59:23.819992Z","caller":"traceutil/trace.go:171","msg":"trace[1384667309] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"384.487845ms","start":"2026-05-24T12:59:23.435467Z","end":"2026-05-24T12:59:23.819954Z","steps":["trace[1384667309] 'process raft request' (duration: 384.213068ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T12:59:23.820187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.887043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.186\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-24T12:59:23.820327Z","caller":"traceutil/trace.go:171","msg":"trace[1322214377] range","detail":"{range_begin:/registry/masterleases/162.253.55.186; range_end:; response_count:1; response_revision:622; }","duration":"221.063817ms","start":"2026-05-24T12:59:23.599242Z","end":"2026-05-24T12:59:23.820306Z","steps":["trace[1322214377] 'agreement among raft nodes before linearized reading' (duration: 220.854103ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T12:59:23.820591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T12:59:23.435437Z","time spent":"384.659059ms","remote":"127.0.0.1:59130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T12:59:23.837693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.227998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T12:59:23.837775Z","caller":"traceutil/trace.go:171","msg":"trace[935470586] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"111.363921ms","start":"2026-05-24T12:59:23.726393Z","end":"2026-05-24T12:59:23.837757Z","steps":["trace[935470586] 'agreement among raft nodes before linearized reading' (duration: 111.214828ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T12:59:39.307197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.427419ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-24T13:00:05.886709Z","caller":"traceutil/trace.go:171","msg":"trace[807240655] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"121.614968ms","start":"2026-05-24T13:00:05.765062Z","end":"2026-05-24T13:00:05.886677Z","steps":["trace[807240655] 'process raft request' (duration: 121.426785ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:00:53.038297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.191153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5a2c5226-94e5-44a5-a814-6f1e6fd9b0ea\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-24T13:00:53.038428Z","caller":"traceutil/trace.go:171","msg":"trace[1365648554] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5a2c5226-94e5-44a5-a814-6f1e6fd9b0ea; range_end:; response_count:1; response_revision:1851; }","duration":"150.342886ms","start":"2026-05-24T13:00:52.888059Z","end":"2026-05-24T13:00:53.038402Z","steps":["trace[1365648554] 'range keys from in-memory index tree' (duration: 149.930328ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:00:53.167578Z","caller":"traceutil/trace.go:171","msg":"trace[812540564] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"121.258178ms","start":"2026-05-24T13:00:53.046293Z","end":"2026-05-24T13:00:53.167551Z","steps":["trace[812540564] 'process raft request' (duration: 121.084295ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:01:38.014118Z","caller":"traceutil/trace.go:171","msg":"trace[627828253] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"104.760408ms","start":"2026-05-24T13:01:37.90933Z","end":"2026-05-24T13:01:38.014091Z","steps":["trace[627828253] 'process raft request' (duration: 104.610715ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:01:43.605516Z","caller":"traceutil/trace.go:171","msg":"trace[388102092] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"118.959833ms","start":"2026-05-24T13:01:43.486499Z","end":"2026-05-24T13:01:43.605459Z","steps":["trace[388102092] 'process raft request' (duration: 118.705217ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:01:44.252057Z","caller":"traceutil/trace.go:171","msg":"trace[1603094007] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"218.762993ms","start":"2026-05-24T13:01:44.033264Z","end":"2026-05-24T13:01:44.252027Z","steps":["trace[1603094007] 'process raft request' (duration: 218.576179ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:01:44.443168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.687925ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-24T13:01:44.443402Z","caller":"traceutil/trace.go:171","msg":"trace[883846482] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"176.324033ms","start":"2026-05-24T13:01:44.267056Z","end":"2026-05-24T13:01:44.44338Z","steps":["trace[883846482] 'process raft request' (duration: 176.245631ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:01:44.44345Z","caller":"traceutil/trace.go:171","msg":"trace[266450070] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"404.786764ms","start":"2026-05-24T13:01:44.038638Z","end":"2026-05-24T13:01:44.443425Z","steps":["trace[266450070] 'process raft request' (duration: 300.723782ms)","trace[266450070] 'compare' (duration: 103.448399ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T13:01:44.443446Z","caller":"traceutil/trace.go:171","msg":"trace[676590468] linearizableReadLoop","detail":"{readStateIndex:2269; appliedIndex:2267; }","duration":"345.690237ms","start":"2026-05-24T13:01:44.097698Z","end":"2026-05-24T13:01:44.443388Z","steps":["trace[676590468] 'read index received' (duration: 154.175308ms)","trace[676590468] 'applied index is now lower than readState.Index' (duration: 191.510149ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T13:01:44.443587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T13:01:44.038606Z","time spent":"404.899026ms","remote":"127.0.0.1:59224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T13:01:44.443623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.921722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-24T13:01:44.443666Z","caller":"traceutil/trace.go:171","msg":"trace[938938577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2188; }","duration":"346.010054ms","start":"2026-05-24T13:01:44.097646Z","end":"2026-05-24T13:01:44.443656Z","steps":["trace[938938577] 'agreement among raft nodes before linearized reading' (duration: 345.84775ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:01:44.443709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T13:01:44.097626Z","time spent":"346.074655ms","remote":"127.0.0.1:59224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-24T13:01:44.443751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.278886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-24T13:01:44.443828Z","caller":"traceutil/trace.go:171","msg":"trace[871722981] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:2188; }","duration":"131.389958ms","start":"2026-05-24T13:01:44.312428Z","end":"2026-05-24T13:01:44.443818Z","steps":["trace[871722981] 'agreement among raft nodes before linearized reading' (duration: 131.276766ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:02:39.562599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.74849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T13:02:39.562716Z","caller":"traceutil/trace.go:171","msg":"trace[351926155] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2655; }","duration":"129.888373ms","start":"2026-05-24T13:02:39.432803Z","end":"2026-05-24T13:02:39.562691Z","steps":["trace[351926155] 'count revisions from in-memory index tree' (duration: 129.679169ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:05:49.490706Z","caller":"traceutil/trace.go:171","msg":"trace[980791223] transaction","detail":"{read_only:false; response_revision:3884; number_of_response:1; }","duration":"170.703808ms","start":"2026-05-24T13:05:49.319975Z","end":"2026-05-24T13:05:49.490679Z","steps":["trace[980791223] 'process raft request' (duration: 170.520115ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:05:49.490905Z","caller":"traceutil/trace.go:171","msg":"trace[1748641704] transaction","detail":"{read_only:false; response_revision:3885; number_of_response:1; }","duration":"125.879453ms","start":"2026-05-24T13:05:49.364981Z","end":"2026-05-24T13:05:49.490861Z","steps":["trace[1748641704] 'process raft request' (duration: 125.659149ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:07:13.348166Z","caller":"traceutil/trace.go:171","msg":"trace[234546362] linearizableReadLoop","detail":"{readStateIndex:5261; appliedIndex:5260; }","duration":"133.809082ms","start":"2026-05-24T13:07:13.214333Z","end":"2026-05-24T13:07:13.348142Z","steps":["trace[234546362] 'read index received' (duration: 133.615778ms)","trace[234546362] 'applied index is now lower than readState.Index' (duration: 191.914µs)"],"step_count":2} {"level":"info","ts":"2026-05-24T13:07:13.348448Z","caller":"traceutil/trace.go:171","msg":"trace[1850166467] transaction","detail":"{read_only:false; response_revision:5069; number_of_response:1; }","duration":"175.203764ms","start":"2026-05-24T13:07:13.173208Z","end":"2026-05-24T13:07:13.348412Z","steps":["trace[1850166467] 'process raft request' (duration: 174.793635ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:07:13.348767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.352233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3c603b54-3725-4971-b1d4-208c22bf4cc9\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-05-24T13:07:13.349456Z","caller":"traceutil/trace.go:171","msg":"trace[1778764309] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3c603b54-3725-4971-b1d4-208c22bf4cc9; range_end:; response_count:1; response_revision:5069; }","duration":"135.159889ms","start":"2026-05-24T13:07:13.214267Z","end":"2026-05-24T13:07:13.349427Z","steps":["trace[1778764309] 'agreement among raft nodes before linearized reading' (duration: 134.106787ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:07:25.698188Z","caller":"traceutil/trace.go:171","msg":"trace[1336989876] transaction","detail":"{read_only:false; response_revision:5306; number_of_response:1; }","duration":"273.793055ms","start":"2026-05-24T13:07:25.424371Z","end":"2026-05-24T13:07:25.698164Z","steps":["trace[1336989876] 'process raft request' (duration: 192.669416ms)","trace[1336989876] 'compare' (duration: 80.308904ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T13:07:25.698425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.178344ms","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-05-24T13:07:25.698516Z","caller":"traceutil/trace.go:171","msg":"trace[1724368105] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5306; }","duration":"270.296477ms","start":"2026-05-24T13:07:25.428202Z","end":"2026-05-24T13:07:25.698498Z","steps":["trace[1724368105] 'agreement among raft nodes before linearized reading' (duration: 270.072332ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:07:25.697847Z","caller":"traceutil/trace.go:171","msg":"trace[1766199101] linearizableReadLoop","detail":"{readStateIndex:5507; appliedIndex:5506; }","duration":"269.590893ms","start":"2026-05-24T13:07:25.428225Z","end":"2026-05-24T13:07:25.697816Z","steps":["trace[1766199101] 'read index received' (duration: 188.82966ms)","trace[1766199101] 'applied index is now lower than readState.Index' (duration: 80.760013ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T13:07:25.701345Z","caller":"traceutil/trace.go:171","msg":"trace[204578586] transaction","detail":"{read_only:false; response_revision:5307; number_of_response:1; }","duration":"169.735187ms","start":"2026-05-24T13:07:25.531356Z","end":"2026-05-24T13:07:25.701091Z","steps":["trace[204578586] 'process raft request' (duration: 169.586294ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:07:33.10006Z","caller":"traceutil/trace.go:171","msg":"trace[1794623669] linearizableReadLoop","detail":"{readStateIndex:5682; appliedIndex:5681; }","duration":"105.834704ms","start":"2026-05-24T13:07:32.994196Z","end":"2026-05-24T13:07:33.100031Z","steps":["trace[1794623669] 'read index received' (duration: 105.646861ms)","trace[1794623669] 'applied index is now lower than readState.Index' (duration: 186.913µs)"],"step_count":2} {"level":"info","ts":"2026-05-24T13:07:33.100137Z","caller":"traceutil/trace.go:171","msg":"trace[1580618826] transaction","detail":"{read_only:false; response_revision:5477; number_of_response:1; }","duration":"110.284541ms","start":"2026-05-24T13:07:32.989827Z","end":"2026-05-24T13:07:33.100112Z","steps":["trace[1580618826] 'process raft request' (duration: 109.992195ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:07:33.100393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.177201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nm9f6\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-05-24T13:07:33.100509Z","caller":"traceutil/trace.go:171","msg":"trace[175436253] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nm9f6; range_end:; response_count:1; response_revision:5477; }","duration":"106.362514ms","start":"2026-05-24T13:07:32.994118Z","end":"2026-05-24T13:07:33.10048Z","steps":["trace[175436253] 'agreement among raft nodes before linearized reading' (duration: 106.052448ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:07:33.317432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.934929ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-24T13:07:33.317555Z","caller":"traceutil/trace.go:171","msg":"trace[860508673] transaction","detail":"{read_only:false; response_revision:5478; number_of_response:1; }","duration":"203.05521ms","start":"2026-05-24T13:07:33.114478Z","end":"2026-05-24T13:07:33.317533Z","steps":["trace[860508673] 'process raft request' (duration: 77.916317ms)","trace[860508673] 'compare' (duration: 124.794817ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T13:08:24.260606Z","caller":"traceutil/trace.go:171","msg":"trace[262306058] transaction","detail":"{read_only:false; response_revision:5973; number_of_response:1; }","duration":"115.504327ms","start":"2026-05-24T13:08:24.145075Z","end":"2026-05-24T13:08:24.26058Z","steps":["trace[262306058] 'process raft request' (duration: 115.340684ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:08:40.51192Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3009} {"level":"info","ts":"2026-05-24T13:08:40.605846Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3009,"took":"90.79927ms","hash":1111818651,"current-db-size-bytes":59084800,"current-db-size":"59 MB","current-db-size-in-use-bytes":31805440,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-24T13:08:40.605967Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1111818651,"revision":3009,"compact-revision":-1} {"level":"info","ts":"2026-05-24T13:13:35.314257Z","caller":"traceutil/trace.go:171","msg":"trace[377338640] transaction","detail":"{read_only:false; response_revision:8288; number_of_response:1; }","duration":"187.692827ms","start":"2026-05-24T13:13:35.126515Z","end":"2026-05-24T13:13:35.314207Z","steps":["trace[377338640] 'process raft request' (duration: 160.410584ms)","trace[377338640] 'compare' (duration: 27.043148ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T13:13:35.314354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.026966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-24T13:13:35.314344Z","caller":"traceutil/trace.go:171","msg":"trace[1059528305] transaction","detail":"{read_only:false; response_revision:8289; number_of_response:1; }","duration":"105.853755ms","start":"2026-05-24T13:13:35.208429Z","end":"2026-05-24T13:13:35.314282Z","steps":["trace[1059528305] 'process raft request' (duration: 105.688762ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:13:35.314433Z","caller":"traceutil/trace.go:171","msg":"trace[452420389] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:8290; }","duration":"148.127729ms","start":"2026-05-24T13:13:35.166294Z","end":"2026-05-24T13:13:35.314421Z","steps":["trace[452420389] 'agreement among raft nodes before linearized reading' (duration: 147.976685ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:13:35.31426Z","caller":"traceutil/trace.go:171","msg":"trace[574853096] linearizableReadLoop","detail":"{readStateIndex:8581; appliedIndex:8580; }","duration":"147.920454ms","start":"2026-05-24T13:13:35.166307Z","end":"2026-05-24T13:13:35.314228Z","steps":["trace[574853096] 'read index received' (duration: 120.632841ms)","trace[574853096] 'applied index is now lower than readState.Index' (duration: 27.284093ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T13:13:35.314775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.778515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nm9f6\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-05-24T13:13:35.314824Z","caller":"traceutil/trace.go:171","msg":"trace[378783466] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nm9f6; range_end:; response_count:1; response_revision:8290; }","duration":"104.875527ms","start":"2026-05-24T13:13:35.209931Z","end":"2026-05-24T13:13:35.314807Z","steps":["trace[378783466] 'agreement among raft nodes before linearized reading' (duration: 104.721064ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:13:40.519752Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6095} {"level":"info","ts":"2026-05-24T13:13:40.623726Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6095,"took":"100.765951ms","hash":1827546185,"current-db-size-bytes":59084800,"current-db-size":"59 MB","current-db-size-in-use-bytes":23781376,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-05-24T13:13:40.623811Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1827546185,"revision":6095,"compact-revision":3009} {"level":"info","ts":"2026-05-24T13:14:15.800218Z","caller":"traceutil/trace.go:171","msg":"trace[1251903977] transaction","detail":"{read_only:false; response_revision:8555; number_of_response:1; }","duration":"266.702138ms","start":"2026-05-24T13:14:15.53349Z","end":"2026-05-24T13:14:15.800192Z","steps":["trace[1251903977] 'process raft request' (duration: 266.541115ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:14:15.98433Z","caller":"traceutil/trace.go:171","msg":"trace[87198280] transaction","detail":"{read_only:false; response_revision:8556; number_of_response:1; }","duration":"446.710825ms","start":"2026-05-24T13:14:15.537586Z","end":"2026-05-24T13:14:15.984297Z","steps":["trace[87198280] 'process raft request' (duration: 446.47188ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:14:15.984388Z","caller":"traceutil/trace.go:171","msg":"trace[2026832167] linearizableReadLoop","detail":"{readStateIndex:8862; appliedIndex:8859; }","duration":"374.720528ms","start":"2026-05-24T13:14:15.609641Z","end":"2026-05-24T13:14:15.984362Z","steps":["trace[2026832167] 'read index received' (duration: 190.357381ms)","trace[2026832167] 'applied index is now lower than readState.Index' (duration: 184.361917ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T13:14:15.98448Z","caller":"traceutil/trace.go:171","msg":"trace[1846012239] transaction","detail":"{read_only:false; response_revision:8558; number_of_response:1; }","duration":"322.159203ms","start":"2026-05-24T13:14:15.662296Z","end":"2026-05-24T13:14:15.984455Z","steps":["trace[1846012239] 'process raft request' (duration: 321.969029ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:14:15.984547Z","caller":"traceutil/trace.go:171","msg":"trace[1369154387] transaction","detail":"{read_only:false; response_revision:8557; number_of_response:1; }","duration":"445.920719ms","start":"2026-05-24T13:14:15.538582Z","end":"2026-05-24T13:14:15.984503Z","steps":["trace[1369154387] 'process raft request' (duration: 445.626573ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:14:15.984581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.922952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nm9f6\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-05-24T13:14:15.984614Z","caller":"traceutil/trace.go:171","msg":"trace[1724936566] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nm9f6; range_end:; response_count:1; response_revision:8558; }","duration":"375.012814ms","start":"2026-05-24T13:14:15.609592Z","end":"2026-05-24T13:14:15.984605Z","steps":["trace[1724936566] 'agreement among raft nodes before linearized reading' (duration: 374.876021ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:14:15.984653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T13:14:15.609571Z","time spent":"375.075526ms","remote":"127.0.0.1:59130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6552,"request content":"key:\"/registry/pods/openstack/keepalived-nm9f6\" "} {"level":"warn","ts":"2026-05-24T13:14:15.984692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T13:14:15.53857Z","time spent":"446.039391ms","remote":"127.0.0.1:59224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T13:14:15.984767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T13:14:15.662265Z","time spent":"322.294776ms","remote":"127.0.0.1:59114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19368,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T13:14:15.985159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-24T13:14:15.537573Z","time spent":"447.555573ms","remote":"127.0.0.1:59224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-24T13:14:15.990232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.846131ms","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-05-24T13:14:15.990292Z","caller":"traceutil/trace.go:171","msg":"trace[571654073] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8559; }","duration":"174.929023ms","start":"2026-05-24T13:14:15.815347Z","end":"2026-05-24T13:14:15.990276Z","steps":["trace[571654073] 'agreement among raft nodes before linearized reading' (duration: 174.783759ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:14:15.990465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.905818ms","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-24T13:14:15.990492Z","caller":"traceutil/trace.go:171","msg":"trace[1740867832] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8559; }","duration":"182.945188ms","start":"2026-05-24T13:14:15.80754Z","end":"2026-05-24T13:14:15.990485Z","steps":["trace[1740867832] 'agreement among raft nodes before linearized reading' (duration: 182.861877ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:14:15.990606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.631594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T13:14:15.990636Z","caller":"traceutil/trace.go:171","msg":"trace[2099174968] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:8559; }","duration":"199.693164ms","start":"2026-05-24T13:14:15.790933Z","end":"2026-05-24T13:14:15.990626Z","steps":["trace[2099174968] 'agreement among raft nodes before linearized reading' (duration: 199.646143ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:14:15.990741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.462763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T13:14:15.990811Z","caller":"traceutil/trace.go:171","msg":"trace[2015013528] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8559; }","duration":"250.580106ms","start":"2026-05-24T13:14:15.740215Z","end":"2026-05-24T13:14:15.990795Z","steps":["trace[2015013528] 'agreement among raft nodes before linearized reading' (duration: 250.447623ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:14:28.189279Z","caller":"traceutil/trace.go:171","msg":"trace[1383895583] transaction","detail":"{read_only:false; response_revision:8660; number_of_response:1; }","duration":"157.132253ms","start":"2026-05-24T13:14:28.032118Z","end":"2026-05-24T13:14:28.18925Z","steps":["trace[1383895583] 'process raft request' (duration: 156.941719ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:14:28.309324Z","caller":"traceutil/trace.go:171","msg":"trace[789804953] linearizableReadLoop","detail":"{readStateIndex:8971; appliedIndex:8969; }","duration":"247.062794ms","start":"2026-05-24T13:14:28.062226Z","end":"2026-05-24T13:14:28.309289Z","steps":["trace[789804953] 'read index received' (duration: 126.995248ms)","trace[789804953] 'applied index is now lower than readState.Index' (duration: 120.065876ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T13:14:28.309416Z","caller":"traceutil/trace.go:171","msg":"trace[550907673] transaction","detail":"{read_only:false; response_revision:8661; number_of_response:1; }","duration":"267.826055ms","start":"2026-05-24T13:14:28.041555Z","end":"2026-05-24T13:14:28.309381Z","steps":["trace[550907673] 'process raft request' (duration: 259.264618ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:14:28.309623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.378071ms","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-24T13:14:28.309668Z","caller":"traceutil/trace.go:171","msg":"trace[1041841518] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8661; }","duration":"247.494644ms","start":"2026-05-24T13:14:28.062163Z","end":"2026-05-24T13:14:28.309657Z","steps":["trace[1041841518] 'agreement among raft nodes before linearized reading' (duration: 247.29576ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:14:28.310009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.125914ms","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":"warn","ts":"2026-05-24T13:14:28.310053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.720947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-05-24T13:14:28.310076Z","caller":"traceutil/trace.go:171","msg":"trace[85101967] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8661; }","duration":"243.211935ms","start":"2026-05-24T13:14:28.06685Z","end":"2026-05-24T13:14:28.310062Z","steps":["trace[85101967] 'agreement among raft nodes before linearized reading' (duration: 242.897098ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:14:28.31002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.927363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T13:14:28.310339Z","caller":"traceutil/trace.go:171","msg":"trace[629803915] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:8661; }","duration":"207.295991ms","start":"2026-05-24T13:14:28.103023Z","end":"2026-05-24T13:14:28.310319Z","steps":["trace[629803915] 'agreement among raft nodes before linearized reading' (duration: 206.685649ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:14:28.310101Z","caller":"traceutil/trace.go:171","msg":"trace[770715241] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8661; }","duration":"103.820039ms","start":"2026-05-24T13:14:28.206264Z","end":"2026-05-24T13:14:28.310084Z","steps":["trace[770715241] 'agreement among raft nodes before linearized reading' (duration: 103.457782ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:14:28.31001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.339689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nm9f6\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-05-24T13:14:28.31059Z","caller":"traceutil/trace.go:171","msg":"trace[63614102] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nm9f6; range_end:; response_count:1; response_revision:8661; }","duration":"246.928431ms","start":"2026-05-24T13:14:28.063642Z","end":"2026-05-24T13:14:28.31057Z","steps":["trace[63614102] 'agreement among raft nodes before linearized reading' (duration: 246.039023ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:14:28.867925Z","caller":"traceutil/trace.go:171","msg":"trace[1378685804] transaction","detail":"{read_only:false; response_revision:8668; number_of_response:1; }","duration":"100.498029ms","start":"2026-05-24T13:14:28.76735Z","end":"2026-05-24T13:14:28.867848Z","steps":["trace[1378685804] 'process raft request' (duration: 100.323606ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:14:29.310739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.92527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-24T13:14:29.310942Z","caller":"traceutil/trace.go:171","msg":"trace[275575823] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8669; }","duration":"217.122976ms","start":"2026-05-24T13:14:29.093752Z","end":"2026-05-24T13:14:29.310875Z","steps":["trace[275575823] 'range keys from in-memory index tree' (duration: 216.749847ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:14:29.329163Z","caller":"traceutil/trace.go:171","msg":"trace[1028366712] linearizableReadLoop","detail":"{readStateIndex:8980; appliedIndex:8979; }","duration":"174.137335ms","start":"2026-05-24T13:14:29.154987Z","end":"2026-05-24T13:14:29.329125Z","steps":["trace[1028366712] 'read index received' (duration: 118.83417ms)","trace[1028366712] 'applied index is now lower than readState.Index' (duration: 55.293884ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T13:14:29.329457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.444621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-05-24T13:14:29.329501Z","caller":"traceutil/trace.go:171","msg":"trace[1401208437] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8670; }","duration":"174.509302ms","start":"2026-05-24T13:14:29.154981Z","end":"2026-05-24T13:14:29.32949Z","steps":["trace[1401208437] 'agreement among raft nodes before linearized reading' (duration: 174.313468ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:14:29.329547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.830799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5146"} {"level":"info","ts":"2026-05-24T13:14:29.32966Z","caller":"traceutil/trace.go:171","msg":"trace[1511746421] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8670; }","duration":"102.996212ms","start":"2026-05-24T13:14:29.226641Z","end":"2026-05-24T13:14:29.329637Z","steps":["trace[1511746421] 'agreement among raft nodes before linearized reading' (duration: 102.729917ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:14:40.515095Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000236b.wal"} {"level":"warn","ts":"2026-05-24T13:15:46.789157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.24197ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-24T13:15:46.789281Z","caller":"traceutil/trace.go:171","msg":"trace[1752004562] linearizableReadLoop","detail":"{readStateIndex:9754; appliedIndex:9753; }","duration":"145.445297ms","start":"2026-05-24T13:15:46.643819Z","end":"2026-05-24T13:15:46.789265Z","steps":["trace[1752004562] 'read index received' (duration: 26.926201ms)","trace[1752004562] 'applied index is now lower than readState.Index' (duration: 118.517766ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T13:15:46.789317Z","caller":"traceutil/trace.go:171","msg":"trace[1727232505] transaction","detail":"{read_only:false; response_revision:9425; number_of_response:1; }","duration":"212.197125ms","start":"2026-05-24T13:15:46.577086Z","end":"2026-05-24T13:15:46.789283Z","steps":["trace[1727232505] 'process raft request' (duration: 93.7219ms)","trace[1727232505] 'compare' (duration: 118.096538ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T13:15:46.789434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.60268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-24T13:15:46.789523Z","caller":"traceutil/trace.go:171","msg":"trace[1397580701] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:9425; }","duration":"145.736572ms","start":"2026-05-24T13:15:46.643764Z","end":"2026-05-24T13:15:46.789501Z","steps":["trace[1397580701] 'agreement among raft nodes before linearized reading' (duration: 145.59426ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:16:19.538444Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"612d5169b08bb96b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-24T13:16:19.544608Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-24T13:16:19.54482Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-24T13:18:40.52719Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8312} {"level":"info","ts":"2026-05-24T13:18:40.607258Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8312,"took":"77.239014ms","hash":1164434107,"current-db-size-bytes":59084800,"current-db-size":"59 MB","current-db-size-in-use-bytes":26480640,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-24T13:18:40.607338Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1164434107,"revision":8312,"compact-revision":6095} {"level":"info","ts":"2026-05-24T13:19:08.62613Z","caller":"traceutil/trace.go:171","msg":"trace[406901984] transaction","detail":"{read_only:false; response_revision:11148; number_of_response:1; }","duration":"113.334499ms","start":"2026-05-24T13:19:08.512751Z","end":"2026-05-24T13:19:08.626086Z","steps":["trace[406901984] 'process raft request' (duration: 86.665413ms)","trace[406901984] 'compare' (duration: 26.527923ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T13:19:26.487528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.524802ms","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-24T13:19:26.487631Z","caller":"traceutil/trace.go:171","msg":"trace[524282413] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:11246; }","duration":"192.669515ms","start":"2026-05-24T13:19:26.294941Z","end":"2026-05-24T13:19:26.487611Z","steps":["trace[524282413] 'range keys from in-memory index tree' (duration: 192.47546ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:19:26.487622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.374058ms","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-24T13:19:26.487631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.664865ms","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-24T13:19:26.487652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.07606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nm9f6\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-05-24T13:19:26.487741Z","caller":"traceutil/trace.go:171","msg":"trace[604001279] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:11246; }","duration":"192.799937ms","start":"2026-05-24T13:19:26.294916Z","end":"2026-05-24T13:19:26.487716Z","steps":["trace[604001279] 'range keys from in-memory index tree' (duration: 192.562252ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:19:26.487734Z","caller":"traceutil/trace.go:171","msg":"trace[306204923] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:11246; }","duration":"192.543782ms","start":"2026-05-24T13:19:26.295161Z","end":"2026-05-24T13:19:26.487705Z","steps":["trace[306204923] 'range keys from in-memory index tree' (duration: 192.232006ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:19:26.487763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.276896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:666"} {"level":"warn","ts":"2026-05-24T13:19:26.487765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.572702ms","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-24T13:19:26.48782Z","caller":"traceutil/trace.go:171","msg":"trace[928683425] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nm9f6; range_end:; response_count:1; response_revision:11246; }","duration":"167.223473ms","start":"2026-05-24T13:19:26.320546Z","end":"2026-05-24T13:19:26.487769Z","steps":["trace[928683425] 'range keys from in-memory index tree' (duration: 166.907216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:19:26.487723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.548503ms","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-24T13:19:26.487944Z","caller":"traceutil/trace.go:171","msg":"trace[942719046] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:11246; }","duration":"192.780157ms","start":"2026-05-24T13:19:26.295092Z","end":"2026-05-24T13:19:26.487872Z","steps":["trace[942719046] 'range keys from in-memory index tree' (duration: 192.46995ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:19:26.487927Z","caller":"traceutil/trace.go:171","msg":"trace[905648215] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:11246; }","duration":"192.395029ms","start":"2026-05-24T13:19:26.295459Z","end":"2026-05-24T13:19:26.487854Z","steps":["trace[905648215] 'range keys from in-memory index tree' (duration: 192.062502ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:19:26.488539Z","caller":"traceutil/trace.go:171","msg":"trace[747353774] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:11246; }","duration":"188.88277ms","start":"2026-05-24T13:19:26.29916Z","end":"2026-05-24T13:19:26.488043Z","steps":["trace[747353774] 'range keys from in-memory index tree' (duration: 188.328718ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:23:40.533671Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10800} {"level":"info","ts":"2026-05-24T13:23:40.611549Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10800,"took":"75.499261ms","hash":1616767069,"current-db-size-bytes":59084800,"current-db-size":"59 MB","current-db-size-in-use-bytes":27377664,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-05-24T13:23:40.6116Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1616767069,"revision":10800,"compact-revision":8312} {"level":"info","ts":"2026-05-24T13:26:01.440328Z","caller":"traceutil/trace.go:171","msg":"trace[1394655100] transaction","detail":"{read_only:false; response_revision:13894; number_of_response:1; }","duration":"285.818951ms","start":"2026-05-24T13:26:01.154488Z","end":"2026-05-24T13:26:01.440307Z","steps":["trace[1394655100] 'process raft request' (duration: 285.714029ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:26:22.289689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.018808ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-24T13:26:22.289843Z","caller":"traceutil/trace.go:171","msg":"trace[1570258010] linearizableReadLoop","detail":"{readStateIndex:14686; appliedIndex:14685; }","duration":"135.408086ms","start":"2026-05-24T13:26:22.154408Z","end":"2026-05-24T13:26:22.289816Z","steps":["trace[1570258010] 'read index received' (duration: 31.631µs)","trace[1570258010] 'applied index is now lower than readState.Index' (duration: 135.375205ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T13:26:22.289892Z","caller":"traceutil/trace.go:171","msg":"trace[2132983042] transaction","detail":"{read_only:false; response_revision:14196; number_of_response:1; }","duration":"159.236343ms","start":"2026-05-24T13:26:22.130629Z","end":"2026-05-24T13:26:22.289865Z","steps":["trace[2132983042] 'process raft request' (duration: 16.930519ms)","trace[2132983042] 'compare' (duration: 141.865445ms)"],"step_count":2} {"level":"warn","ts":"2026-05-24T13:26:22.290223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.807594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nm9f6\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-05-24T13:26:22.290309Z","caller":"traceutil/trace.go:171","msg":"trace[1021437397] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nm9f6; range_end:; response_count:1; response_revision:14196; }","duration":"135.939066ms","start":"2026-05-24T13:26:22.154349Z","end":"2026-05-24T13:26:22.290288Z","steps":["trace[1021437397] 'agreement among raft nodes before linearized reading' (duration: 135.553679ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:26:22.567462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.898804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-04250a18-9254-4912-8b18-47a3906341a4\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-05-24T13:26:22.567569Z","caller":"traceutil/trace.go:171","msg":"trace[519150491] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-04250a18-9254-4912-8b18-47a3906341a4; range_end:; response_count:1; response_revision:14196; }","duration":"129.068428ms","start":"2026-05-24T13:26:22.438475Z","end":"2026-05-24T13:26:22.567544Z","steps":["trace[519150491] 'range keys from in-memory index tree' (duration: 128.63718ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:27:14.346765Z","caller":"traceutil/trace.go:171","msg":"trace[221618035] transaction","detail":"{read_only:false; response_revision:14827; number_of_response:1; }","duration":"102.378452ms","start":"2026-05-24T13:27:14.244361Z","end":"2026-05-24T13:27:14.346739Z","steps":["trace[221618035] 'process raft request' (duration: 102.015075ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:27:48.577833Z","caller":"traceutil/trace.go:171","msg":"trace[1896321241] transaction","detail":"{read_only:false; response_revision:15005; number_of_response:1; }","duration":"127.478284ms","start":"2026-05-24T13:27:48.450329Z","end":"2026-05-24T13:27:48.577808Z","steps":["trace[1896321241] 'process raft request' (duration: 127.130967ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:27:48.734871Z","caller":"traceutil/trace.go:171","msg":"trace[1141982799] linearizableReadLoop","detail":"{readStateIndex:15519; appliedIndex:15517; }","duration":"150.571734ms","start":"2026-05-24T13:27:48.584274Z","end":"2026-05-24T13:27:48.734845Z","steps":["trace[1141982799] 'read index received' (duration: 21.097631ms)","trace[1141982799] 'applied index is now lower than readState.Index' (duration: 129.472653ms)"],"step_count":2} {"level":"info","ts":"2026-05-24T13:27:48.735113Z","caller":"traceutil/trace.go:171","msg":"trace[1118598929] transaction","detail":"{read_only:false; response_revision:15007; number_of_response:1; }","duration":"152.764148ms","start":"2026-05-24T13:27:48.582336Z","end":"2026-05-24T13:27:48.7351Z","steps":["trace[1118598929] 'process raft request' (duration: 149.053305ms)"],"step_count":1} {"level":"warn","ts":"2026-05-24T13:27:48.736193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.897541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:76 size:737441"} {"level":"info","ts":"2026-05-24T13:27:48.736255Z","caller":"traceutil/trace.go:171","msg":"trace[461710255] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:76; response_revision:15007; }","duration":"151.985003ms","start":"2026-05-24T13:27:48.584254Z","end":"2026-05-24T13:27:48.736239Z","steps":["trace[461710255] 'agreement among raft nodes before linearized reading' (duration: 151.174987ms)"],"step_count":1} {"level":"info","ts":"2026-05-24T13:28:40.540499Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12880} {"level":"info","ts":"2026-05-24T13:28:40.618841Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12880,"took":"75.67673ms","hash":2171368109,"current-db-size-bytes":59084800,"current-db-size":"59 MB","current-db-size-in-use-bytes":30502912,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-24T13:28:40.618916Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2171368109,"revision":12880,"compact-revision":10800} {"level":"info","ts":"2026-05-24T13:33:40.54761Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15336} {"level":"info","ts":"2026-05-24T13:33:40.642271Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15336,"took":"91.135342ms","hash":1620557335,"current-db-size-bytes":59084800,"current-db-size":"59 MB","current-db-size-in-use-bytes":31625216,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-24T13:33:40.642351Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1620557335,"revision":15336,"compact-revision":12880} {"level":"info","ts":"2026-05-24T13:38:40.55498Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17587} {"level":"info","ts":"2026-05-24T13:38:40.649578Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17587,"took":"90.720067ms","hash":1235213487,"current-db-size-bytes":59084800,"current-db-size":"59 MB","current-db-size-in-use-bytes":26398720,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-24T13:38:40.649683Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1235213487,"revision":17587,"compact-revision":15336} {"level":"info","ts":"2026-05-24T13:39:13.993175Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"612d5169b08bb96b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-24T13:39:13.999285Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-05-24T13:39:13.999435Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}