{"level":"warn","ts":"2026-09-24T02:00:36.355584Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-24T02:00:36.355692Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.189: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.189:2380","--initial-cluster=instance=https://162.253.55.189:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.189:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.189: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-09-24T02:00:36.355768Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-24T02:00:36.355783Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.189:2380"]} {"level":"info","ts":"2026-09-24T02:00:36.355806Z","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-09-24T02:00:36.356599Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.189:2379"]} {"level":"info","ts":"2026-09-24T02:00:36.356696Z","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.189:2380"],"listen-peer-urls":["https://162.253.55.189:2380"],"advertise-client-urls":["https://162.253.55.189:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.189:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.189: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-09-24T02:00:36.363816Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.871593ms"} {"level":"info","ts":"2026-09-24T02:00:36.370863Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f14c7d724df9ef94","cluster-id":"f7bde5cbb4d65447"} {"level":"info","ts":"2026-09-24T02:00:36.370954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f14c7d724df9ef94 switched to configuration voters=()"} {"level":"info","ts":"2026-09-24T02:00:36.370994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f14c7d724df9ef94 became follower at term 0"} {"level":"info","ts":"2026-09-24T02:00:36.371004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f14c7d724df9ef94 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-24T02:00:36.371017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f14c7d724df9ef94 became follower at term 1"} {"level":"info","ts":"2026-09-24T02:00:36.371058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f14c7d724df9ef94 switched to configuration voters=(17387410191258611604)"} {"level":"warn","ts":"2026-09-24T02:00:36.389093Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-24T02:00:36.39318Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-24T02:00:36.39466Z","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-09-24T02:00:36.397272Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f14c7d724df9ef94","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-24T02:00:36.397915Z","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-09-24T02:00:36.398101Z","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-09-24T02:00:36.398129Z","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-09-24T02:00:36.398026Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f14c7d724df9ef94","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-24T02:00:36.400317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f14c7d724df9ef94 switched to configuration voters=(17387410191258611604)"} {"level":"info","ts":"2026-09-24T02:00:36.401048Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f7bde5cbb4d65447","local-member-id":"f14c7d724df9ef94","added-peer-id":"f14c7d724df9ef94","added-peer-peer-urls":["https://162.253.55.189:2380"]} {"level":"info","ts":"2026-09-24T02:00:36.40284Z","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-09-24T02:00:36.403143Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f14c7d724df9ef94","initial-advertise-peer-urls":["https://162.253.55.189:2380"],"listen-peer-urls":["https://162.253.55.189:2380"],"advertise-client-urls":["https://162.253.55.189:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.189:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-24T02:00:36.403187Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-24T02:00:36.403396Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.189:2380"} {"level":"info","ts":"2026-09-24T02:00:36.403423Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.189:2380"} {"level":"info","ts":"2026-09-24T02:00:37.171293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f14c7d724df9ef94 is starting a new election at term 1"} {"level":"info","ts":"2026-09-24T02:00:37.171381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f14c7d724df9ef94 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-24T02:00:37.171427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f14c7d724df9ef94 received MsgPreVoteResp from f14c7d724df9ef94 at term 1"} {"level":"info","ts":"2026-09-24T02:00:37.171473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f14c7d724df9ef94 became candidate at term 2"} {"level":"info","ts":"2026-09-24T02:00:37.171484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f14c7d724df9ef94 received MsgVoteResp from f14c7d724df9ef94 at term 2"} {"level":"info","ts":"2026-09-24T02:00:37.171501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f14c7d724df9ef94 became leader at term 2"} {"level":"info","ts":"2026-09-24T02:00:37.171517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f14c7d724df9ef94 elected leader f14c7d724df9ef94 at term 2"} {"level":"info","ts":"2026-09-24T02:00:37.176551Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f14c7d724df9ef94","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.189:2379]}","request-path":"/0/members/f14c7d724df9ef94/attributes","cluster-id":"f7bde5cbb4d65447","publish-timeout":"7s"} {"level":"info","ts":"2026-09-24T02:00:37.176567Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-24T02:00:37.176798Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-24T02:00:37.176852Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-24T02:00:37.177481Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-24T02:00:37.177688Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-24T02:00:37.180533Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.189:2379"} {"level":"info","ts":"2026-09-24T02:00:37.180934Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-24T02:00:37.18097Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f7bde5cbb4d65447","local-member-id":"f14c7d724df9ef94","cluster-version":"3.5"} {"level":"info","ts":"2026-09-24T02:00:37.181123Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-24T02:00:37.181161Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-24T02:01:03.324385Z","caller":"traceutil/trace.go:171","msg":"trace[1669476864] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"100.072983ms","start":"2026-09-24T02:01:03.224279Z","end":"2026-09-24T02:01:03.324352Z","steps":["trace[1669476864] 'process raft request' (duration: 35.914955ms)","trace[1669476864] 'compare' (duration: 64.047186ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:01:25.239529Z","caller":"traceutil/trace.go:171","msg":"trace[1939709405] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"112.547894ms","start":"2026-09-24T02:01:25.126891Z","end":"2026-09-24T02:01:25.239439Z","steps":["trace[1939709405] 'process raft request' (duration: 112.426932ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:01:25.782241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.645339ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-24T02:01:25.782403Z","caller":"traceutil/trace.go:171","msg":"trace[1405402409] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"424.818884ms","start":"2026-09-24T02:01:25.357562Z","end":"2026-09-24T02:01:25.782381Z","steps":["trace[1405402409] 'process raft request' (duration: 265.09542ms)","trace[1405402409] 'compare' (duration: 158.477076ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:01:25.782506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:01:25.35754Z","time spent":"424.904216ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:01:25.7949Z","caller":"traceutil/trace.go:171","msg":"trace[1886203063] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:667; }","duration":"371.467496ms","start":"2026-09-24T02:01:25.423403Z","end":"2026-09-24T02:01:25.794871Z","steps":["trace[1886203063] 'read index received' (duration: 199.170582ms)","trace[1886203063] 'applied index is now lower than readState.Index' (duration: 172.295894ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:01:25.795082Z","caller":"traceutil/trace.go:171","msg":"trace[1969479079] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"371.937015ms","start":"2026-09-24T02:01:25.423102Z","end":"2026-09-24T02:01:25.795039Z","steps":["trace[1969479079] 'process raft request' (duration: 371.659119ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:01:25.79513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.700801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-24T02:01:25.795167Z","caller":"traceutil/trace.go:171","msg":"trace[1508998952] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:648; }","duration":"371.795843ms","start":"2026-09-24T02:01:25.423358Z","end":"2026-09-24T02:01:25.795154Z","steps":["trace[1508998952] 'agreement among raft nodes before linearized reading' (duration: 371.613169ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:01:25.795248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:01:25.423338Z","time spent":"371.900735ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-24T02:01:25.79525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:01:25.423072Z","time spent":"372.09195ms","remote":"127.0.0.1:47886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-24T02:01:26.321696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.289628ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-24T02:01:26.322037Z","caller":"traceutil/trace.go:171","msg":"trace[112537767] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"453.257855ms","start":"2026-09-24T02:01:25.868717Z","end":"2026-09-24T02:01:26.321975Z","steps":["trace[112537767] 'process raft request' (duration: 296.578518ms)","trace[112537767] 'compare' (duration: 155.964331ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:01:26.322258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:01:25.868684Z","time spent":"453.46556ms","remote":"127.0.0.1:47720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:01:26.328996Z","caller":"traceutil/trace.go:171","msg":"trace[1949481443] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:670; }","duration":"315.261936ms","start":"2026-09-24T02:01:26.013666Z","end":"2026-09-24T02:01:26.328928Z","steps":["trace[1949481443] 'read index received' (duration: 151.644785ms)","trace[1949481443] 'applied index is now lower than readState.Index' (duration: 163.612821ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:01:26.329093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.414539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-24T02:01:26.329177Z","caller":"traceutil/trace.go:171","msg":"trace[150271217] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:650; }","duration":"315.550402ms","start":"2026-09-24T02:01:26.013611Z","end":"2026-09-24T02:01:26.329161Z","steps":["trace[150271217] 'agreement among raft nodes before linearized reading' (duration: 315.419689ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:01:26.329271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:01:26.013581Z","time spent":"315.656655ms","remote":"127.0.0.1:47550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-24T02:01:26.329636Z","caller":"traceutil/trace.go:171","msg":"trace[81475945] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"112.421211ms","start":"2026-09-24T02:01:26.21719Z","end":"2026-09-24T02:01:26.329611Z","steps":["trace[81475945] 'process raft request' (duration: 111.780037ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:02:14.186386Z","caller":"traceutil/trace.go:171","msg":"trace[1625015754] linearizableReadLoop","detail":"{readStateIndex:1259; appliedIndex:1258; }","duration":"139.087434ms","start":"2026-09-24T02:02:14.047276Z","end":"2026-09-24T02:02:14.186364Z","steps":["trace[1625015754] 'read index received' (duration: 138.952391ms)","trace[1625015754] 'applied index is now lower than readState.Index' (duration: 134.163µs)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:02:14.186468Z","caller":"traceutil/trace.go:171","msg":"trace[553409326] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"165.081803ms","start":"2026-09-24T02:02:14.021357Z","end":"2026-09-24T02:02:14.186438Z","steps":["trace[553409326] 'process raft request' (duration: 164.846527ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:02:14.186721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.430852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-09-24T02:02:14.186771Z","caller":"traceutil/trace.go:171","msg":"trace[958968254] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1225; }","duration":"139.564486ms","start":"2026-09-24T02:02:14.047195Z","end":"2026-09-24T02:02:14.186759Z","steps":["trace[958968254] 'agreement among raft nodes before linearized reading' (duration: 139.380992ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:03:02.328903Z","caller":"traceutil/trace.go:171","msg":"trace[360686975] linearizableReadLoop","detail":"{readStateIndex:1972; appliedIndex:1971; }","duration":"155.387936ms","start":"2026-09-24T02:03:02.173489Z","end":"2026-09-24T02:03:02.328877Z","steps":["trace[360686975] 'read index received' (duration: 155.234232ms)","trace[360686975] 'applied index is now lower than readState.Index' (duration: 152.754µs)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:03:02.329074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.56889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-24T02:03:02.329119Z","caller":"traceutil/trace.go:171","msg":"trace[1307714891] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1901; }","duration":"155.680673ms","start":"2026-09-24T02:03:02.173423Z","end":"2026-09-24T02:03:02.329104Z","steps":["trace[1307714891] 'agreement among raft nodes before linearized reading' (duration: 155.591071ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:03:02.329074Z","caller":"traceutil/trace.go:171","msg":"trace[35259498] transaction","detail":"{read_only:false; response_revision:1901; number_of_response:1; }","duration":"215.283942ms","start":"2026-09-24T02:03:02.113724Z","end":"2026-09-24T02:03:02.329008Z","steps":["trace[35259498] 'process raft request' (duration: 214.986525ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:03:02.329737Z","caller":"traceutil/trace.go:171","msg":"trace[1979850456] transaction","detail":"{read_only:false; response_revision:1902; number_of_response:1; }","duration":"131.003372ms","start":"2026-09-24T02:03:02.198699Z","end":"2026-09-24T02:03:02.329702Z","steps":["trace[1979850456] 'process raft request' (duration: 130.801687ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:03:02.329841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.573884ms","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-09-24T02:03:02.329902Z","caller":"traceutil/trace.go:171","msg":"trace[244550879] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1902; }","duration":"148.675376ms","start":"2026-09-24T02:03:02.181213Z","end":"2026-09-24T02:03:02.329889Z","steps":["trace[244550879] 'agreement among raft nodes before linearized reading' (duration: 148.460021ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:03:10.749934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.447647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11986"} {"level":"info","ts":"2026-09-24T02:03:10.750059Z","caller":"traceutil/trace.go:171","msg":"trace[500383019] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1989; }","duration":"103.6086ms","start":"2026-09-24T02:03:10.646425Z","end":"2026-09-24T02:03:10.750034Z","steps":["trace[500383019] 'range keys from in-memory index tree' (duration: 103.242592ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:03:16.255983Z","caller":"traceutil/trace.go:171","msg":"trace[30750072] transaction","detail":"{read_only:false; response_revision:2019; number_of_response:1; }","duration":"109.951862ms","start":"2026-09-24T02:03:16.146003Z","end":"2026-09-24T02:03:16.255955Z","steps":["trace[30750072] 'process raft request' (duration: 109.754748ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:03:16.511572Z","caller":"traceutil/trace.go:171","msg":"trace[2057948739] transaction","detail":"{read_only:false; response_revision:2020; number_of_response:1; }","duration":"131.36226ms","start":"2026-09-24T02:03:16.380186Z","end":"2026-09-24T02:03:16.511548Z","steps":["trace[2057948739] 'process raft request' (duration: 131.160965ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:03:16.525495Z","caller":"traceutil/trace.go:171","msg":"trace[755510660] linearizableReadLoop","detail":"{readStateIndex:2095; appliedIndex:2093; }","duration":"114.514103ms","start":"2026-09-24T02:03:16.410956Z","end":"2026-09-24T02:03:16.52547Z","steps":["trace[755510660] 'read index received' (duration: 100.349527ms)","trace[755510660] 'applied index is now lower than readState.Index' (duration: 14.163175ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:03:16.525639Z","caller":"traceutil/trace.go:171","msg":"trace[1992040346] transaction","detail":"{read_only:false; response_revision:2021; number_of_response:1; }","duration":"121.215044ms","start":"2026-09-24T02:03:16.404403Z","end":"2026-09-24T02:03:16.525618Z","steps":["trace[1992040346] 'process raft request' (duration: 120.939137ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:03:16.525742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.762599ms","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-09-24T02:03:16.525774Z","caller":"traceutil/trace.go:171","msg":"trace[1711204435] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2021; }","duration":"114.864411ms","start":"2026-09-24T02:03:16.4109Z","end":"2026-09-24T02:03:16.525764Z","steps":["trace[1711204435] 'agreement among raft nodes before linearized reading' (duration: 114.699437ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:03:46.186808Z","caller":"traceutil/trace.go:171","msg":"trace[1690122912] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"100.958775ms","start":"2026-09-24T02:03:46.085825Z","end":"2026-09-24T02:03:46.186784Z","steps":["trace[1690122912] 'process raft request' (duration: 100.775621ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:03:51.605477Z","caller":"traceutil/trace.go:171","msg":"trace[2034730786] transaction","detail":"{read_only:false; response_revision:2228; number_of_response:1; }","duration":"133.009421ms","start":"2026-09-24T02:03:51.47244Z","end":"2026-09-24T02:03:51.605449Z","steps":["trace[2034730786] 'process raft request' (duration: 132.848508ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:03:52.324056Z","caller":"traceutil/trace.go:171","msg":"trace[324927727] transaction","detail":"{read_only:false; response_revision:2229; number_of_response:1; }","duration":"111.373676ms","start":"2026-09-24T02:03:52.212657Z","end":"2026-09-24T02:03:52.32403Z","steps":["trace[324927727] 'process raft request' (duration: 111.250704ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:05:34.285723Z","caller":"traceutil/trace.go:171","msg":"trace[576996618] transaction","detail":"{read_only:false; response_revision:2974; number_of_response:1; }","duration":"108.771131ms","start":"2026-09-24T02:05:34.17693Z","end":"2026-09-24T02:05:34.285701Z","steps":["trace[576996618] 'process raft request' (duration: 108.622307ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:08:53.330891Z","caller":"traceutil/trace.go:171","msg":"trace[1087926408] transaction","detail":"{read_only:false; response_revision:4220; number_of_response:1; }","duration":"143.531257ms","start":"2026-09-24T02:08:53.187317Z","end":"2026-09-24T02:08:53.330848Z","steps":["trace[1087926408] 'process raft request' (duration: 143.23748ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:10:22.116658Z","caller":"traceutil/trace.go:171","msg":"trace[1098026626] linearizableReadLoop","detail":"{readStateIndex:5489; appliedIndex:5488; }","duration":"120.073926ms","start":"2026-09-24T02:10:21.996556Z","end":"2026-09-24T02:10:22.11663Z","steps":["trace[1098026626] 'read index received' (duration: 119.831921ms)","trace[1098026626] 'applied index is now lower than readState.Index' (duration: 241.045µs)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:10:22.116708Z","caller":"traceutil/trace.go:171","msg":"trace[13228292] transaction","detail":"{read_only:false; response_revision:5287; number_of_response:1; }","duration":"122.364357ms","start":"2026-09-24T02:10:21.99433Z","end":"2026-09-24T02:10:22.116695Z","steps":["trace[13228292] 'process raft request' (duration: 122.127381ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:10:22.116938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.357182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-09-24T02:10:22.117026Z","caller":"traceutil/trace.go:171","msg":"trace[762933996] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5287; }","duration":"120.506235ms","start":"2026-09-24T02:10:21.996497Z","end":"2026-09-24T02:10:22.117004Z","steps":["trace[762933996] 'agreement among raft nodes before linearized reading' (duration: 120.23793ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:10:24.828937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.636092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-24T02:10:24.829016Z","caller":"traceutil/trace.go:171","msg":"trace[150312999] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:5407; }","duration":"218.764435ms","start":"2026-09-24T02:10:24.610232Z","end":"2026-09-24T02:10:24.828996Z","steps":["trace[150312999] 'count revisions from in-memory index tree' (duration: 218.483628ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:10:24.829259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.974367ms","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-09-24T02:10:24.829288Z","caller":"traceutil/trace.go:171","msg":"trace[550486651] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:5407; }","duration":"174.045929ms","start":"2026-09-24T02:10:24.655234Z","end":"2026-09-24T02:10:24.82928Z","steps":["trace[550486651] 'count revisions from in-memory index tree' (duration: 173.891945ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:10:24.829463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.262068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"} {"level":"info","ts":"2026-09-24T02:10:24.829493Z","caller":"traceutil/trace.go:171","msg":"trace[1359265878] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:5407; }","duration":"150.290748ms","start":"2026-09-24T02:10:24.679191Z","end":"2026-09-24T02:10:24.829482Z","steps":["trace[1359265878] 'range keys from in-memory index tree' (duration: 150.120635ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:10:37.212345Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2990} {"level":"info","ts":"2026-09-24T02:10:37.306429Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2990,"took":"92.530102ms","hash":369225292,"current-db-size-bytes":56270848,"current-db-size":"56 MB","current-db-size-in-use-bytes":30879744,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-24T02:10:37.306851Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":369225292,"revision":2990,"compact-revision":-1} {"level":"info","ts":"2026-09-24T02:10:40.447044Z","caller":"traceutil/trace.go:171","msg":"trace[11900985] transaction","detail":"{read_only:false; response_revision:5690; number_of_response:1; }","duration":"136.119823ms","start":"2026-09-24T02:10:40.310899Z","end":"2026-09-24T02:10:40.447019Z","steps":["trace[11900985] 'process raft request' (duration: 77.767812ms)","trace[11900985] 'compare' (duration: 58.149327ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:10:40.450797Z","caller":"traceutil/trace.go:171","msg":"trace[1975779480] transaction","detail":"{read_only:false; response_revision:5691; number_of_response:1; }","duration":"139.531879ms","start":"2026-09-24T02:10:40.311231Z","end":"2026-09-24T02:10:40.450763Z","steps":["trace[1975779480] 'process raft request' (duration: 139.287904ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:11:16.455633Z","caller":"traceutil/trace.go:171","msg":"trace[614202918] transaction","detail":"{read_only:false; response_revision:6022; number_of_response:1; }","duration":"123.916901ms","start":"2026-09-24T02:11:16.331689Z","end":"2026-09-24T02:11:16.455606Z","steps":["trace[614202918] 'process raft request' (duration: 123.733437ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:11:45.658766Z","caller":"traceutil/trace.go:171","msg":"trace[1245184490] transaction","detail":"{read_only:false; response_revision:6262; number_of_response:1; }","duration":"108.224941ms","start":"2026-09-24T02:11:45.550486Z","end":"2026-09-24T02:11:45.65871Z","steps":["trace[1245184490] 'process raft request' (duration: 85.491895ms)","trace[1245184490] 'compare' (duration: 22.43591ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:11:45.658878Z","caller":"traceutil/trace.go:171","msg":"trace[1034618488] transaction","detail":"{read_only:false; response_revision:6263; number_of_response:1; }","duration":"108.249022ms","start":"2026-09-24T02:11:45.55062Z","end":"2026-09-24T02:11:45.658869Z","steps":["trace[1034618488] 'process raft request' (duration: 107.932185ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:11:45.658813Z","caller":"traceutil/trace.go:171","msg":"trace[321093213] transaction","detail":"{read_only:false; response_revision:6264; number_of_response:1; }","duration":"107.68597ms","start":"2026-09-24T02:11:45.551098Z","end":"2026-09-24T02:11:45.658784Z","steps":["trace[321093213] 'process raft request' (duration: 107.546607ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:15:37.219459Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5633} {"level":"info","ts":"2026-09-24T02:15:37.301901Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5633,"took":"80.66821ms","hash":1061444755,"current-db-size-bytes":56270848,"current-db-size":"56 MB","current-db-size-in-use-bytes":27582464,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-24T02:15:37.301972Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1061444755,"revision":5633,"compact-revision":2990} {"level":"info","ts":"2026-09-24T02:17:53.153309Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002455.wal"} {"level":"info","ts":"2026-09-24T02:17:57.174549Z","caller":"traceutil/trace.go:171","msg":"trace[2007446597] transaction","detail":"{read_only:false; response_revision:9001; number_of_response:1; }","duration":"258.044943ms","start":"2026-09-24T02:17:56.916459Z","end":"2026-09-24T02:17:57.174504Z","steps":["trace[2007446597] 'process raft request' (duration: 257.876749ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:17:57.185823Z","caller":"traceutil/trace.go:171","msg":"trace[250243071] transaction","detail":"{read_only:false; response_revision:9002; number_of_response:1; }","duration":"142.350244ms","start":"2026-09-24T02:17:57.04344Z","end":"2026-09-24T02:17:57.185791Z","steps":["trace[250243071] 'process raft request' (duration: 142.206481ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:18:09.488554Z","caller":"traceutil/trace.go:171","msg":"trace[273693783] linearizableReadLoop","detail":"{readStateIndex:9389; appliedIndex:9388; }","duration":"130.360987ms","start":"2026-09-24T02:18:09.358145Z","end":"2026-09-24T02:18:09.488506Z","steps":["trace[273693783] 'read index received' (duration: 115.178648ms)","trace[273693783] 'applied index is now lower than readState.Index' (duration: 15.181009ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:18:09.488704Z","caller":"traceutil/trace.go:171","msg":"trace[1143630829] transaction","detail":"{read_only:false; response_revision:9064; number_of_response:1; }","duration":"259.983157ms","start":"2026-09-24T02:18:09.228697Z","end":"2026-09-24T02:18:09.48868Z","steps":["trace[1143630829] 'process raft request' (duration: 244.608763ms)","trace[1143630829] 'compare' (duration: 15.026087ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:18:09.488872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.295721ms","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-09-24T02:18:09.488943Z","caller":"traceutil/trace.go:171","msg":"trace[586158316] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9064; }","duration":"128.452085ms","start":"2026-09-24T02:18:09.360473Z","end":"2026-09-24T02:18:09.488926Z","steps":["trace[586158316] 'agreement among raft nodes before linearized reading' (duration: 128.275991ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:18:09.489154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.998941ms","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-09-24T02:18:09.489226Z","caller":"traceutil/trace.go:171","msg":"trace[788162272] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9064; }","duration":"131.113634ms","start":"2026-09-24T02:18:09.358094Z","end":"2026-09-24T02:18:09.489208Z","steps":["trace[788162272] 'agreement among raft nodes before linearized reading' (duration: 130.92473ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:18:09.489215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.863237ms","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-09-24T02:18:09.48929Z","caller":"traceutil/trace.go:171","msg":"trace[814206413] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9064; }","duration":"117.98896ms","start":"2026-09-24T02:18:09.371284Z","end":"2026-09-24T02:18:09.489273Z","steps":["trace[814206413] 'agreement among raft nodes before linearized reading' (duration: 117.741375ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:18:41.978102Z","caller":"traceutil/trace.go:171","msg":"trace[791101301] linearizableReadLoop","detail":"{readStateIndex:9629; appliedIndex:9628; }","duration":"118.170935ms","start":"2026-09-24T02:18:41.859906Z","end":"2026-09-24T02:18:41.978077Z","steps":["trace[791101301] 'read index received' (duration: 31.38491ms)","trace[791101301] 'applied index is now lower than readState.Index' (duration: 86.784575ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:18:41.978214Z","caller":"traceutil/trace.go:171","msg":"trace[838014368] transaction","detail":"{read_only:false; response_revision:9294; number_of_response:1; }","duration":"151.392155ms","start":"2026-09-24T02:18:41.82678Z","end":"2026-09-24T02:18:41.978172Z","steps":["trace[838014368] 'process raft request' (duration: 64.540229ms)","trace[838014368] 'compare' (duration: 86.639551ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:18:41.978461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.435861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-j9ghd\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-09-24T02:18:41.978581Z","caller":"traceutil/trace.go:171","msg":"trace[1012329077] range","detail":"{range_begin:/registry/pods/openstack/keepalived-j9ghd; range_end:; response_count:1; response_revision:9294; }","duration":"118.673287ms","start":"2026-09-24T02:18:41.859892Z","end":"2026-09-24T02:18:41.978565Z","steps":["trace[1012329077] 'agreement among raft nodes before linearized reading' (duration: 118.330048ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:18:52.439577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.903556ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-24T02:18:52.4397Z","caller":"traceutil/trace.go:171","msg":"trace[1325080932] transaction","detail":"{read_only:false; response_revision:9359; number_of_response:1; }","duration":"205.896811ms","start":"2026-09-24T02:18:52.233782Z","end":"2026-09-24T02:18:52.439679Z","steps":["trace[1325080932] 'process raft request' (duration: 101.77368ms)","trace[1325080932] 'compare' (duration: 103.761873ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:19:19.552665Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f14c7d724df9ef94","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-24T02:19:19.561884Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-09-24T02:19:19.562091Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-09-24T02:20:37.226544Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7863} {"level":"info","ts":"2026-09-24T02:20:37.295003Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7863,"took":"66.016575ms","hash":3751091212,"current-db-size-bytes":56270848,"current-db-size":"56 MB","current-db-size-in-use-bytes":27582464,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-24T02:20:37.295075Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3751091212,"revision":7863,"compact-revision":5633} {"level":"info","ts":"2026-09-24T02:25:37.233971Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10348} {"level":"info","ts":"2026-09-24T02:25:37.325989Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10348,"took":"88.821972ms","hash":3407082369,"current-db-size-bytes":56270848,"current-db-size":"56 MB","current-db-size-in-use-bytes":26296320,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-09-24T02:25:37.326083Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3407082369,"revision":10348,"compact-revision":7863} {"level":"info","ts":"2026-09-24T02:25:54.261222Z","caller":"traceutil/trace.go:171","msg":"trace[166104684] linearizableReadLoop","detail":"{readStateIndex:13047; appliedIndex:13046; }","duration":"196.557259ms","start":"2026-09-24T02:25:54.064642Z","end":"2026-09-24T02:25:54.261199Z","steps":["trace[166104684] 'read index received' (duration: 180.655413ms)","trace[166104684] 'applied index is now lower than readState.Index' (duration: 15.900686ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:25:54.261504Z","caller":"traceutil/trace.go:171","msg":"trace[1611766361] transaction","detail":"{read_only:false; response_revision:12608; number_of_response:1; }","duration":"241.45162ms","start":"2026-09-24T02:25:54.020038Z","end":"2026-09-24T02:25:54.26149Z","steps":["trace[1611766361] 'process raft request' (duration: 225.100385ms)","trace[1611766361] 'compare' (duration: 15.966277ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:25:54.261755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.09879ms","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-09-24T02:25:54.261792Z","caller":"traceutil/trace.go:171","msg":"trace[1766707817] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12608; }","duration":"197.186043ms","start":"2026-09-24T02:25:54.064595Z","end":"2026-09-24T02:25:54.261781Z","steps":["trace[1766707817] 'agreement among raft nodes before linearized reading' (duration: 197.061191ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:25:54.281051Z","caller":"traceutil/trace.go:171","msg":"trace[632606721] transaction","detail":"{read_only:false; response_revision:12609; number_of_response:1; }","duration":"212.581116ms","start":"2026-09-24T02:25:54.068437Z","end":"2026-09-24T02:25:54.281018Z","steps":["trace[632606721] 'process raft request' (duration: 212.263799ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:30:37.243706Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12513} {"level":"info","ts":"2026-09-24T02:30:37.323318Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12513,"took":"77.439294ms","hash":3141164476,"current-db-size-bytes":56270848,"current-db-size":"56 MB","current-db-size-in-use-bytes":27340800,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-24T02:30:37.323386Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3141164476,"revision":12513,"compact-revision":10348} {"level":"warn","ts":"2026-09-24T02:33:34.594447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.668583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-24T02:33:34.594551Z","caller":"traceutil/trace.go:171","msg":"trace[1502249022] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:15701; }","duration":"206.831137ms","start":"2026-09-24T02:33:34.387703Z","end":"2026-09-24T02:33:34.594534Z","steps":["trace[1502249022] 'count revisions from in-memory index tree' (duration: 206.563061ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:33:34.720544Z","caller":"traceutil/trace.go:171","msg":"trace[1966312721] transaction","detail":"{read_only:false; response_revision:15702; number_of_response:1; }","duration":"122.353009ms","start":"2026-09-24T02:33:34.598128Z","end":"2026-09-24T02:33:34.720481Z","steps":["trace[1966312721] 'process raft request' (duration: 122.146555ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:33:34.770666Z","caller":"traceutil/trace.go:171","msg":"trace[599087781] transaction","detail":"{read_only:false; response_revision:15703; number_of_response:1; }","duration":"171.86976ms","start":"2026-09-24T02:33:34.598753Z","end":"2026-09-24T02:33:34.770622Z","steps":["trace[599087781] 'process raft request' (duration: 171.654425ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:33:34.770943Z","caller":"traceutil/trace.go:171","msg":"trace[1151004498] linearizableReadLoop","detail":"{readStateIndex:16252; appliedIndex:16248; }","duration":"169.357224ms","start":"2026-09-24T02:33:34.601566Z","end":"2026-09-24T02:33:34.770924Z","steps":["trace[1151004498] 'read index received' (duration: 118.76855ms)","trace[1151004498] 'applied index is now lower than readState.Index' (duration: 50.587844ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:33:34.770969Z","caller":"traceutil/trace.go:171","msg":"trace[778882224] transaction","detail":"{read_only:false; response_revision:15705; number_of_response:1; }","duration":"169.413296ms","start":"2026-09-24T02:33:34.601524Z","end":"2026-09-24T02:33:34.770937Z","steps":["trace[778882224] 'process raft request' (duration: 169.315553ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:33:34.771127Z","caller":"traceutil/trace.go:171","msg":"trace[674337014] transaction","detail":"{read_only:false; response_revision:15704; number_of_response:1; }","duration":"172.196856ms","start":"2026-09-24T02:33:34.598921Z","end":"2026-09-24T02:33:34.771118Z","steps":["trace[674337014] 'process raft request' (duration: 171.659874ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:33:34.771169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.582169ms","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":"warn","ts":"2026-09-24T02:33:34.771231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.736757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-24T02:33:34.771266Z","caller":"traceutil/trace.go:171","msg":"trace[999778133] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15705; }","duration":"169.65816ms","start":"2026-09-24T02:33:34.601537Z","end":"2026-09-24T02:33:34.771196Z","steps":["trace[999778133] 'agreement among raft nodes before linearized reading' (duration: 169.505737ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:33:34.771276Z","caller":"traceutil/trace.go:171","msg":"trace[472522972] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:15705; }","duration":"153.858069ms","start":"2026-09-24T02:33:34.617403Z","end":"2026-09-24T02:33:34.771261Z","steps":["trace[472522972] 'agreement among raft nodes before linearized reading' (duration: 153.736586ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:34:43.310601Z","caller":"traceutil/trace.go:171","msg":"trace[1759188812] transaction","detail":"{read_only:false; response_revision:16626; number_of_response:1; }","duration":"129.398665ms","start":"2026-09-24T02:34:43.181168Z","end":"2026-09-24T02:34:43.310566Z","steps":["trace[1759188812] 'process raft request' (duration: 76.171592ms)","trace[1759188812] 'compare' (duration: 53.075379ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:35:37.250438Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14539} {"level":"info","ts":"2026-09-24T02:35:37.333701Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14539,"took":"80.306625ms","hash":4189051349,"current-db-size-bytes":56270848,"current-db-size":"56 MB","current-db-size-in-use-bytes":29716480,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-09-24T02:35:37.333854Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4189051349,"revision":14539,"compact-revision":12513} {"level":"info","ts":"2026-09-24T02:40:37.25749Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16905} {"level":"info","ts":"2026-09-24T02:40:37.360907Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16905,"took":"99.952896ms","hash":3528851009,"current-db-size-bytes":56270848,"current-db-size":"56 MB","current-db-size-in-use-bytes":30859264,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-24T02:40:37.360985Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3528851009,"revision":16905,"compact-revision":14539} {"level":"info","ts":"2026-09-24T02:40:51.942163Z","caller":"traceutil/trace.go:171","msg":"trace[1029841318] transaction","detail":"{read_only:false; response_revision:19267; number_of_response:1; }","duration":"158.250799ms","start":"2026-09-24T02:40:51.783881Z","end":"2026-09-24T02:40:51.942131Z","steps":["trace[1029841318] 'process raft request' (duration: 158.087556ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:40:51.97488Z","caller":"traceutil/trace.go:171","msg":"trace[1917100779] transaction","detail":"{read_only:false; response_revision:19268; number_of_response:1; }","duration":"189.07348ms","start":"2026-09-24T02:40:51.785788Z","end":"2026-09-24T02:40:51.974861Z","steps":["trace[1917100779] 'process raft request' (duration: 188.997859ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:40:58.221352Z","caller":"traceutil/trace.go:171","msg":"trace[1224639193] linearizableReadLoop","detail":"{readStateIndex:19972; appliedIndex:19971; }","duration":"205.016116ms","start":"2026-09-24T02:40:58.01631Z","end":"2026-09-24T02:40:58.221326Z","steps":["trace[1224639193] 'read index received' (duration: 204.871972ms)","trace[1224639193] 'applied index is now lower than readState.Index' (duration: 142.894µs)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:40:58.221503Z","caller":"traceutil/trace.go:171","msg":"trace[308426910] transaction","detail":"{read_only:false; response_revision:19308; number_of_response:1; }","duration":"205.58383ms","start":"2026-09-24T02:40:58.015888Z","end":"2026-09-24T02:40:58.221472Z","steps":["trace[308426910] 'process raft request' (duration: 205.307643ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:40:58.221644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.248542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:40:58.221692Z","caller":"traceutil/trace.go:171","msg":"trace[1404486481] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:19308; }","duration":"205.401565ms","start":"2026-09-24T02:40:58.016276Z","end":"2026-09-24T02:40:58.221678Z","steps":["trace[1404486481] 'agreement among raft nodes before linearized reading' (duration: 205.195531ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:40:58.222094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.528056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-cph59\" ","response":"range_response_count:1 size:20661"} {"level":"info","ts":"2026-09-24T02:40:58.222144Z","caller":"traceutil/trace.go:171","msg":"trace[725825247] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-cph59; range_end:; response_count:1; response_revision:19308; }","duration":"149.646138ms","start":"2026-09-24T02:40:58.072484Z","end":"2026-09-24T02:40:58.222131Z","steps":["trace[725825247] 'agreement among raft nodes before linearized reading' (duration: 149.479334ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:40:58.542523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.954577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-cp59v\" ","response":"range_response_count:1 size:9711"} {"level":"info","ts":"2026-09-24T02:40:58.542631Z","caller":"traceutil/trace.go:171","msg":"trace[2072358286] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-cp59v; range_end:; response_count:1; response_revision:19309; }","duration":"185.114771ms","start":"2026-09-24T02:40:58.357496Z","end":"2026-09-24T02:40:58.542611Z","steps":["trace[2072358286] 'range keys from in-memory index tree' (duration: 184.742083ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:41:01.145368Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f14c7d724df9ef94","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-24T02:41:01.174719Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-09-24T02:41:01.174839Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-09-24T02:45:37.265665Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19123} {"level":"info","ts":"2026-09-24T02:45:37.368343Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19123,"took":"97.161605ms","hash":4184040552,"current-db-size-bytes":56270848,"current-db-size":"56 MB","current-db-size-in-use-bytes":34570240,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-09-24T02:45:37.368421Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4184040552,"revision":19123,"compact-revision":16905} {"level":"warn","ts":"2026-09-24T02:47:16.071807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.283686ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-09-24T02:47:32.824532Z","caller":"traceutil/trace.go:171","msg":"trace[403874705] transaction","detail":"{read_only:false; response_revision:22278; number_of_response:1; }","duration":"143.574683ms","start":"2026-09-24T02:47:32.68091Z","end":"2026-09-24T02:47:32.824485Z","steps":["trace[403874705] 'process raft request' (duration: 143.337038ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:50:37.275544Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21638} {"level":"info","ts":"2026-09-24T02:50:37.409822Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21638,"took":"130.132253ms","hash":331744894,"current-db-size-bytes":56270848,"current-db-size":"56 MB","current-db-size-in-use-bytes":30810112,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-24T02:50:37.410076Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":331744894,"revision":21638,"compact-revision":19123} {"level":"info","ts":"2026-09-24T02:54:22.507951Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006a9b.wal"} {"level":"warn","ts":"2026-09-24T02:54:40.634014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.522074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11716"} {"level":"info","ts":"2026-09-24T02:54:40.634106Z","caller":"traceutil/trace.go:171","msg":"trace[64611299] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:26669; }","duration":"282.669278ms","start":"2026-09-24T02:54:40.351417Z","end":"2026-09-24T02:54:40.634087Z","steps":["trace[64611299] 'range keys from in-memory index tree' (duration: 282.211267ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:40.647684Z","caller":"traceutil/trace.go:171","msg":"trace[729605068] transaction","detail":"{read_only:false; response_revision:26670; number_of_response:1; }","duration":"197.526901ms","start":"2026-09-24T02:54:40.450128Z","end":"2026-09-24T02:54:40.647654Z","steps":["trace[729605068] 'process raft request' (duration: 197.320236ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:41.765201Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.117709903s","expected-duration":"1s"} {"level":"info","ts":"2026-09-24T02:54:41.765732Z","caller":"traceutil/trace.go:171","msg":"trace[371490002] linearizableReadLoop","detail":"{readStateIndex:27553; appliedIndex:27551; }","duration":"1.137242471s","start":"2026-09-24T02:54:40.628463Z","end":"2026-09-24T02:54:41.765705Z","steps":["trace[371490002] 'read index received' (duration: 19.006126ms)","trace[371490002] 'applied index is now lower than readState.Index' (duration: 1.118235115s)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:54:41.765929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.137442846s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:54:41.7659Z","caller":"traceutil/trace.go:171","msg":"trace[2037375205] transaction","detail":"{read_only:false; response_revision:26671; number_of_response:1; }","duration":"1.229645309s","start":"2026-09-24T02:54:40.536202Z","end":"2026-09-24T02:54:41.765847Z","steps":["trace[2037375205] 'process raft request' (duration: 1.22930241s)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:41.76597Z","caller":"traceutil/trace.go:171","msg":"trace[1276783089] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:26671; }","duration":"1.137550218s","start":"2026-09-24T02:54:40.628405Z","end":"2026-09-24T02:54:41.765955Z","steps":["trace[1276783089] 'agreement among raft nodes before linearized reading' (duration: 1.137429026s)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:41.766005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:40.628374Z","time spent":"1.13762013s","remote":"127.0.0.1:51354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true "} {"level":"warn","ts":"2026-09-24T02:54:41.766096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:40.536173Z","time spent":"1.229811083s","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:42.246776Z","caller":"traceutil/trace.go:171","msg":"trace[1425373612] transaction","detail":"{read_only:false; response_revision:26672; number_of_response:1; }","duration":"1.10776317s","start":"2026-09-24T02:54:41.138994Z","end":"2026-09-24T02:54:42.246757Z","steps":["trace[1425373612] 'process raft request' (duration: 1.107048274s)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:42.246904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:41.138959Z","time spent":"1.107874643s","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:42.247078Z","caller":"traceutil/trace.go:171","msg":"trace[1256121632] transaction","detail":"{read_only:false; response_revision:26673; number_of_response:1; }","duration":"1.025855046s","start":"2026-09-24T02:54:41.221178Z","end":"2026-09-24T02:54:42.247033Z","steps":["trace[1256121632] 'process raft request' (duration: 1.025482138s)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:42.247097Z","caller":"traceutil/trace.go:171","msg":"trace[970182404] transaction","detail":"{read_only:false; response_revision:26674; number_of_response:1; }","duration":"1.021599371s","start":"2026-09-24T02:54:41.225468Z","end":"2026-09-24T02:54:42.247068Z","steps":["trace[970182404] 'process raft request' (duration: 1.021449958s)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:42.247325Z","caller":"traceutil/trace.go:171","msg":"trace[386348442] transaction","detail":"{read_only:false; response_revision:26675; number_of_response:1; }","duration":"1.006942572s","start":"2026-09-24T02:54:41.240375Z","end":"2026-09-24T02:54:42.247318Z","steps":["trace[386348442] 'process raft request' (duration: 1.006651046s)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:42.247319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:41.221137Z","time spent":"1.02603657s","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:42.247318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:41.225436Z","time spent":"1.021742563s","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:42.247363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:41.240361Z","time spent":"1.006982443s","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:42.247734Z","caller":"traceutil/trace.go:171","msg":"trace[1278781074] linearizableReadLoop","detail":"{readStateIndex:27558; appliedIndex:27553; }","duration":"481.90622ms","start":"2026-09-24T02:54:41.7658Z","end":"2026-09-24T02:54:42.247706Z","steps":["trace[1278781074] 'read index received' (duration: 480.627201ms)","trace[1278781074] 'applied index is now lower than readState.Index' (duration: 1.277559ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:54:42.248095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"955.87381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/applicationcredentials/\" range_end:\"/registry/openstack.k-orc.cloud/applicationcredentials0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:54:42.248125Z","caller":"traceutil/trace.go:171","msg":"trace[856385563] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/applicationcredentials/; range_end:/registry/openstack.k-orc.cloud/applicationcredentials0; response_count:0; response_revision:26676; }","duration":"955.971343ms","start":"2026-09-24T02:54:41.292145Z","end":"2026-09-24T02:54:42.248117Z","steps":["trace[856385563] 'agreement among raft nodes before linearized reading' (duration: 955.917462ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:42.248092Z","caller":"traceutil/trace.go:171","msg":"trace[1755421826] transaction","detail":"{read_only:false; response_revision:26676; number_of_response:1; }","duration":"657.772117ms","start":"2026-09-24T02:54:41.590281Z","end":"2026-09-24T02:54:42.248053Z","steps":["trace[1755421826] 'process raft request' (duration: 656.965648ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:42.248209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"756.280692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1989"} {"level":"warn","ts":"2026-09-24T02:54:42.248241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.179578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-09-24T02:54:42.24827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.524098721s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.189\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-09-24T02:54:42.248296Z","caller":"traceutil/trace.go:171","msg":"trace[373956154] range","detail":"{range_begin:/registry/masterleases/162.253.55.189; range_end:; response_count:1; response_revision:26676; }","duration":"1.524167143s","start":"2026-09-24T02:54:40.724121Z","end":"2026-09-24T02:54:42.248288Z","steps":["trace[373956154] 'agreement among raft nodes before linearized reading' (duration: 1.524075441s)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:42.248294Z","caller":"traceutil/trace.go:171","msg":"trace[871189130] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26676; }","duration":"852.256571ms","start":"2026-09-24T02:54:41.396023Z","end":"2026-09-24T02:54:42.248279Z","steps":["trace[871189130] 'agreement among raft nodes before linearized reading' (duration: 852.096247ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:42.248294Z","caller":"traceutil/trace.go:171","msg":"trace[1730240079] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:26676; }","duration":"756.444005ms","start":"2026-09-24T02:54:41.491827Z","end":"2026-09-24T02:54:42.248271Z","steps":["trace[1730240079] 'agreement among raft nodes before linearized reading' (duration: 755.971715ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:42.248314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:40.724093Z","time spent":"1.524217834s","remote":"127.0.0.1:47592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":164,"request content":"key:\"/registry/masterleases/162.253.55.189\" "} {"level":"warn","ts":"2026-09-24T02:54:42.248293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:41.590255Z","time spent":"657.934171ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:42.24833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:41.396009Z","time spent":"852.314163ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-24T02:54:42.248342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:41.491791Z","time spent":"756.541208ms","remote":"127.0.0.1:47732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2013,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-09-24T02:54:42.248205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.233009944s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:54:42.248458Z","caller":"traceutil/trace.go:171","msg":"trace[765926606] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26676; }","duration":"1.233348841s","start":"2026-09-24T02:54:41.015096Z","end":"2026-09-24T02:54:42.248445Z","steps":["trace[765926606] 'agreement among raft nodes before linearized reading' (duration: 1.232980173s)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:42.248497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.360356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-24T02:54:42.248519Z","caller":"traceutil/trace.go:171","msg":"trace[1620633454] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:26676; }","duration":"648.435628ms","start":"2026-09-24T02:54:41.600076Z","end":"2026-09-24T02:54:42.248512Z","steps":["trace[1620633454] 'agreement among raft nodes before linearized reading' (duration: 648.392977ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:42.248506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.603264374s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11716"} {"level":"warn","ts":"2026-09-24T02:54:42.248535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:41.600049Z","time spent":"648.482159ms","remote":"127.0.0.1:47784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":7,"response size":32,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"info","ts":"2026-09-24T02:54:42.248588Z","caller":"traceutil/trace.go:171","msg":"trace[608580186] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:26676; }","duration":"1.603372527s","start":"2026-09-24T02:54:40.645175Z","end":"2026-09-24T02:54:42.248547Z","steps":["trace[608580186] 'agreement among raft nodes before linearized reading' (duration: 1.603173533s)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:42.248644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:40.645147Z","time spent":"1.603483839s","remote":"127.0.0.1:47990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":11740,"request content":"key:\"/registry/deployments/openstack/glance-api\" "} {"level":"warn","ts":"2026-09-24T02:54:42.248602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:41.015029Z","time spent":"1.233559227s","remote":"127.0.0.1:47542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-24T02:54:42.248715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"877.298931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-09-24T02:54:42.248759Z","caller":"traceutil/trace.go:171","msg":"trace[826641956] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26676; }","duration":"877.386253ms","start":"2026-09-24T02:54:41.371368Z","end":"2026-09-24T02:54:42.248754Z","steps":["trace[826641956] 'agreement among raft nodes before linearized reading' (duration: 876.78437ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:42.248775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:41.371344Z","time spent":"877.427593ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-24T02:54:42.248143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:41.292132Z","time spent":"956.006763ms","remote":"127.0.0.1:41744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/applicationcredentials/\" range_end:\"/registry/openstack.k-orc.cloud/applicationcredentials0\" count_only:true "} {"level":"warn","ts":"2026-09-24T02:54:42.249116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.157034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-09-24T02:54:42.249169Z","caller":"traceutil/trace.go:171","msg":"trace[1392835440] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26676; }","duration":"532.251206ms","start":"2026-09-24T02:54:41.716905Z","end":"2026-09-24T02:54:42.249156Z","steps":["trace[1392835440] 'agreement among raft nodes before linearized reading' (duration: 531.556141ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:42.249199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:41.71688Z","time spent":"532.312878ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-24T02:54:42.330587Z","caller":"traceutil/trace.go:171","msg":"trace[837359077] transaction","detail":"{read_only:false; response_revision:26677; number_of_response:1; }","duration":"560.825036ms","start":"2026-09-24T02:54:41.769716Z","end":"2026-09-24T02:54:42.330541Z","steps":["trace[837359077] 'process raft request' (duration: 560.630762ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:42.33075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:41.769685Z","time spent":"560.976838ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:42.330826Z","caller":"traceutil/trace.go:171","msg":"trace[1385114801] transaction","detail":"{read_only:false; response_revision:26678; number_of_response:1; }","duration":"205.702174ms","start":"2026-09-24T02:54:42.125092Z","end":"2026-09-24T02:54:42.330794Z","steps":["trace[1385114801] 'process raft request' (duration: 205.401838ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:42.330981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.780354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-24T02:54:42.331062Z","caller":"traceutil/trace.go:171","msg":"trace[1244714455] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26678; }","duration":"526.910806ms","start":"2026-09-24T02:54:41.804131Z","end":"2026-09-24T02:54:42.331042Z","steps":["trace[1244714455] 'agreement among raft nodes before linearized reading' (duration: 526.710861ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:42.331102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:41.804111Z","time spent":"526.982768ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-24T02:54:42.331182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-09-24T02:54:42.331273Z","caller":"traceutil/trace.go:171","msg":"trace[2140105655] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26678; }","duration":"550.017074ms","start":"2026-09-24T02:54:41.781237Z","end":"2026-09-24T02:54:42.331254Z","steps":["trace[2140105655] 'agreement among raft nodes before linearized reading' (duration: 549.777938ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:42.331325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:41.78122Z","time spent":"550.092395ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-24T02:54:43.000698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.821872ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:42"} {"level":"warn","ts":"2026-09-24T02:54:43.000942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:42.249578Z","time spent":"751.350531ms","remote":"127.0.0.1:47592","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-09-24T02:54:43.001108Z","caller":"traceutil/trace.go:171","msg":"trace[1014011274] linearizableReadLoop","detail":"{readStateIndex:27564; appliedIndex:27560; }","duration":"670.340448ms","start":"2026-09-24T02:54:42.330748Z","end":"2026-09-24T02:54:43.001088Z","steps":["trace[1014011274] 'read index received' (duration: 454.124377ms)","trace[1014011274] 'applied index is now lower than readState.Index' (duration: 216.21473ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:54:43.001245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.104196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:54:43.001278Z","caller":"traceutil/trace.go:171","msg":"trace[78546299] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26681; }","duration":"751.178627ms","start":"2026-09-24T02:54:42.250091Z","end":"2026-09-24T02:54:43.001269Z","steps":["trace[78546299] 'agreement among raft nodes before linearized reading' (duration: 751.052134ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:43.001309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:42.250075Z","time spent":"751.225929ms","remote":"127.0.0.1:47550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-24T02:54:43.001379Z","caller":"traceutil/trace.go:171","msg":"trace[691633157] transaction","detail":"{read_only:false; response_revision:26680; number_of_response:1; }","duration":"747.205779ms","start":"2026-09-24T02:54:42.254133Z","end":"2026-09-24T02:54:43.001339Z","steps":["trace[691633157] 'process raft request' (duration: 746.878191ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:43.001466Z","caller":"traceutil/trace.go:171","msg":"trace[1972925629] transaction","detail":"{read_only:false; response_revision:26681; number_of_response:1; }","duration":"747.274681ms","start":"2026-09-24T02:54:42.254139Z","end":"2026-09-24T02:54:43.001413Z","steps":["trace[1972925629] 'process raft request' (duration: 746.906842ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:43.001484Z","caller":"traceutil/trace.go:171","msg":"trace[876542634] transaction","detail":"{read_only:false; response_revision:26679; number_of_response:1; }","duration":"747.974685ms","start":"2026-09-24T02:54:42.253465Z","end":"2026-09-24T02:54:43.00144Z","steps":["trace[876542634] 'process raft request' (duration: 747.368041ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:43.001538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.24179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/openstack/container-infra\" ","response":"range_response_count:1 size:729"} {"level":"warn","ts":"2026-09-24T02:54:43.001589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"749.435558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/openstack/container-infra-registry\" ","response":"range_response_count:1 size:784"} {"level":"info","ts":"2026-09-24T02:54:43.001645Z","caller":"traceutil/trace.go:171","msg":"trace[1536578544] range","detail":"{range_begin:/registry/ingress/openstack/container-infra; range_end:; response_count:1; response_revision:26681; }","duration":"747.404713ms","start":"2026-09-24T02:54:42.254219Z","end":"2026-09-24T02:54:43.001624Z","steps":["trace[1536578544] 'agreement among raft nodes before linearized reading' (duration: 747.115127ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:43.001662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:42.254106Z","time spent":"747.428363ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:43.00167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:42.253444Z","time spent":"748.134609ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:43.001675Z","caller":"traceutil/trace.go:171","msg":"trace[1119003240] range","detail":"{range_begin:/registry/ingress/openstack/container-infra-registry; range_end:; response_count:1; response_revision:26681; }","duration":"749.576092ms","start":"2026-09-24T02:54:42.252078Z","end":"2026-09-24T02:54:43.001654Z","steps":["trace[1119003240] 'agreement among raft nodes before linearized reading' (duration: 749.292486ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:43.00169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:42.254196Z","time spent":"747.485085ms","remote":"127.0.0.1:47830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":753,"request content":"key:\"/registry/ingress/openstack/container-infra\" "} {"level":"warn","ts":"2026-09-24T02:54:43.001728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:42.252066Z","time spent":"749.652533ms","remote":"127.0.0.1:47830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":808,"request content":"key:\"/registry/ingress/openstack/container-infra-registry\" "} {"level":"warn","ts":"2026-09-24T02:54:43.002126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:42.254113Z","time spent":"747.344132ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:43.095959Z","caller":"traceutil/trace.go:171","msg":"trace[1659515984] transaction","detail":"{read_only:false; response_revision:26682; number_of_response:1; }","duration":"760.490745ms","start":"2026-09-24T02:54:42.335433Z","end":"2026-09-24T02:54:43.095924Z","steps":["trace[1659515984] 'process raft request' (duration: 760.180098ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:43.096189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:42.335393Z","time spent":"760.670699ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:43.096258Z","caller":"traceutil/trace.go:171","msg":"trace[2094655429] transaction","detail":"{read_only:false; response_revision:26684; number_of_response:1; }","duration":"442.906816ms","start":"2026-09-24T02:54:42.65333Z","end":"2026-09-24T02:54:43.096236Z","steps":["trace[2094655429] 'process raft request' (duration: 442.782653ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:43.09629Z","caller":"traceutil/trace.go:171","msg":"trace[1226715762] transaction","detail":"{read_only:false; response_revision:26683; number_of_response:1; }","duration":"760.643918ms","start":"2026-09-24T02:54:42.335613Z","end":"2026-09-24T02:54:43.096256Z","steps":["trace[1226715762] 'process raft request' (duration: 760.248819ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:43.096395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:42.653297Z","time spent":"443.025499ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:43.096509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:42.335589Z","time spent":"760.828463ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:43.659661Z","caller":"traceutil/trace.go:171","msg":"trace[629214989] linearizableReadLoop","detail":"{readStateIndex:27570; appliedIndex:27564; }","duration":"646.577936ms","start":"2026-09-24T02:54:43.013056Z","end":"2026-09-24T02:54:43.659634Z","steps":["trace[629214989] 'read index received' (duration: 82.572448ms)","trace[629214989] 'applied index is now lower than readState.Index' (duration: 564.004158ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:54:43.659746Z","caller":"traceutil/trace.go:171","msg":"trace[322784611] transaction","detail":"{read_only:false; response_revision:26687; number_of_response:1; }","duration":"652.097349ms","start":"2026-09-24T02:54:43.007638Z","end":"2026-09-24T02:54:43.659736Z","steps":["trace[322784611] 'process raft request' (duration: 651.953426ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:43.659731Z","caller":"traceutil/trace.go:171","msg":"trace[883220783] transaction","detail":"{read_only:false; response_revision:26686; number_of_response:1; }","duration":"652.829305ms","start":"2026-09-24T02:54:43.00686Z","end":"2026-09-24T02:54:43.65969Z","steps":["trace[883220783] 'process raft request' (duration: 652.64173ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:43.659666Z","caller":"traceutil/trace.go:171","msg":"trace[1386198258] transaction","detail":"{read_only:false; response_revision:26685; number_of_response:1; }","duration":"655.384133ms","start":"2026-09-24T02:54:43.004245Z","end":"2026-09-24T02:54:43.659629Z","steps":["trace[1386198258] 'process raft request' (duration: 655.065245ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:43.659847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.74909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:54:43.659886Z","caller":"traceutil/trace.go:171","msg":"trace[1356355481] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26687; }","duration":"646.858082ms","start":"2026-09-24T02:54:43.013017Z","end":"2026-09-24T02:54:43.659875Z","steps":["trace[1356355481] 'agreement among raft nodes before linearized reading' (duration: 646.75718ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:43.659892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:43.007616Z","time spent":"652.175672ms","remote":"127.0.0.1:47830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":870,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:43.659922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:43.013001Z","time spent":"646.912923ms","remote":"127.0.0.1:47542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-24T02:54:43.65994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:43.004211Z","time spent":"655.669119ms","remote":"127.0.0.1:47592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":121,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:43.659939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.98308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/volumes/\" range_end:\"/registry/openstack.k-orc.cloud/volumes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-24T02:54:43.659966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:43.006844Z","time spent":"652.988069ms","remote":"127.0.0.1:47830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":925,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:43.660043Z","caller":"traceutil/trace.go:171","msg":"trace[308829037] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/volumes/; range_end:/registry/openstack.k-orc.cloud/volumes0; response_count:0; response_revision:26687; }","duration":"205.107823ms","start":"2026-09-24T02:54:43.454911Z","end":"2026-09-24T02:54:43.660019Z","steps":["trace[308829037] 'agreement among raft nodes before linearized reading' (duration: 204.918918ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:44.281253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.734316ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-24T02:54:44.281369Z","caller":"traceutil/trace.go:171","msg":"trace[437505871] linearizableReadLoop","detail":"{readStateIndex:27573; appliedIndex:27572; }","duration":"274.380142ms","start":"2026-09-24T02:54:44.00697Z","end":"2026-09-24T02:54:44.281351Z","steps":["trace[437505871] 'read index received' (duration: 26.439312ms)","trace[437505871] 'applied index is now lower than readState.Index' (duration: 247.93908ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:54:44.281475Z","caller":"traceutil/trace.go:171","msg":"trace[1805316951] transaction","detail":"{read_only:false; response_revision:26689; number_of_response:1; }","duration":"509.526016ms","start":"2026-09-24T02:54:43.771914Z","end":"2026-09-24T02:54:44.28144Z","steps":["trace[1805316951] 'process raft request' (duration: 261.495414ms)","trace[1805316951] 'compare' (duration: 246.969049ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:54:44.281655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:43.771878Z","time spent":"509.691751ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:44.281729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.766981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/container-infra.18d822364a8ab897\" ","response":"range_response_count:1 size:695"} {"level":"info","ts":"2026-09-24T02:54:44.281776Z","caller":"traceutil/trace.go:171","msg":"trace[2011093769] range","detail":"{range_begin:/registry/events/openstack/container-infra.18d822364a8ab897; range_end:; response_count:1; response_revision:26689; }","duration":"274.862794ms","start":"2026-09-24T02:54:44.006899Z","end":"2026-09-24T02:54:44.281762Z","steps":["trace[2011093769] 'agreement among raft nodes before linearized reading' (duration: 274.717971ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:44.713643Z","caller":"traceutil/trace.go:171","msg":"trace[1297387021] linearizableReadLoop","detail":"{readStateIndex:27578; appliedIndex:27573; }","duration":"432.224187ms","start":"2026-09-24T02:54:44.281395Z","end":"2026-09-24T02:54:44.713619Z","steps":["trace[1297387021] 'read index received' (duration: 5.701409ms)","trace[1297387021] 'applied index is now lower than readState.Index' (duration: 426.521858ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:54:44.713764Z","caller":"traceutil/trace.go:171","msg":"trace[116254876] transaction","detail":"{read_only:false; response_revision:26692; number_of_response:1; }","duration":"457.882481ms","start":"2026-09-24T02:54:44.255867Z","end":"2026-09-24T02:54:44.71375Z","steps":["trace[116254876] 'process raft request' (duration: 457.534634ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:44.713872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:44.255857Z","time spent":"457.931393ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:44.713921Z","caller":"traceutil/trace.go:171","msg":"trace[1353722883] transaction","detail":"{read_only:false; response_revision:26695; number_of_response:1; }","duration":"427.714286ms","start":"2026-09-24T02:54:44.286174Z","end":"2026-09-24T02:54:44.713888Z","steps":["trace[1353722883] 'process raft request' (duration: 427.361459ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:44.713931Z","caller":"traceutil/trace.go:171","msg":"trace[2070444083] transaction","detail":"{read_only:false; response_revision:26693; number_of_response:1; }","duration":"457.619145ms","start":"2026-09-24T02:54:44.256265Z","end":"2026-09-24T02:54:44.713884Z","steps":["trace[2070444083] 'process raft request' (duration: 457.179406ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:44.713956Z","caller":"traceutil/trace.go:171","msg":"trace[1847210422] transaction","detail":"{read_only:false; response_revision:26694; number_of_response:1; }","duration":"457.546233ms","start":"2026-09-24T02:54:44.256374Z","end":"2026-09-24T02:54:44.71392Z","steps":["trace[1847210422] 'process raft request' (duration: 457.124164ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:44.714077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:44.286139Z","time spent":"427.849729ms","remote":"127.0.0.1:47638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":677,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:44.7141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:44.256339Z","time spent":"457.682266ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:44.714057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.331329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-24T02:54:44.714122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:44.25623Z","time spent":"457.787969ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:44.713586Z","caller":"traceutil/trace.go:171","msg":"trace[706063716] transaction","detail":"{read_only:false; response_revision:26691; number_of_response:1; }","duration":"457.726679ms","start":"2026-09-24T02:54:44.255807Z","end":"2026-09-24T02:54:44.713534Z","steps":["trace[706063716] 'process raft request' (duration: 457.429142ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:44.714191Z","caller":"traceutil/trace.go:171","msg":"trace[787581396] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26695; }","duration":"700.538524ms","start":"2026-09-24T02:54:44.013619Z","end":"2026-09-24T02:54:44.714158Z","steps":["trace[787581396] 'agreement among raft nodes before linearized reading' (duration: 700.279739ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:44.714246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:44.013588Z","time spent":"700.648266ms","remote":"127.0.0.1:47542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-24T02:54:44.714262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:44.25576Z","time spent":"458.429884ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:44.718335Z","caller":"traceutil/trace.go:171","msg":"trace[1703243812] transaction","detail":"{read_only:false; response_revision:26696; number_of_response:1; }","duration":"381.047231ms","start":"2026-09-24T02:54:44.337262Z","end":"2026-09-24T02:54:44.71831Z","steps":["trace[1703243812] 'process raft request' (duration: 380.681263ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:44.718481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:44.337235Z","time spent":"381.170324ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:44.718788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.588054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-24T02:54:44.718872Z","caller":"traceutil/trace.go:171","msg":"trace[1179165302] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:26696; }","duration":"281.722837ms","start":"2026-09-24T02:54:44.437128Z","end":"2026-09-24T02:54:44.718851Z","steps":["trace[1179165302] 'agreement among raft nodes before linearized reading' (duration: 281.579334ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:50.621863Z","caller":"traceutil/trace.go:171","msg":"trace[1882526638] linearizableReadLoop","detail":"{readStateIndex:27619; appliedIndex:27618; }","duration":"153.535208ms","start":"2026-09-24T02:54:50.468299Z","end":"2026-09-24T02:54:50.621834Z","steps":["trace[1882526638] 'read index received' (duration: 149.504427ms)","trace[1882526638] 'applied index is now lower than readState.Index' (duration: 4.029091ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:54:50.622043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.729642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-24T02:54:50.622084Z","caller":"traceutil/trace.go:171","msg":"trace[1657441934] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:26734; }","duration":"153.792973ms","start":"2026-09-24T02:54:50.468279Z","end":"2026-09-24T02:54:50.622072Z","steps":["trace[1657441934] 'agreement among raft nodes before linearized reading' (duration: 153.667981ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:50.622087Z","caller":"traceutil/trace.go:171","msg":"trace[579170395] transaction","detail":"{read_only:false; response_revision:26734; number_of_response:1; }","duration":"307.576267ms","start":"2026-09-24T02:54:50.314469Z","end":"2026-09-24T02:54:50.622046Z","steps":["trace[579170395] 'process raft request' (duration: 303.401463ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:50.622281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:50.314455Z","time spent":"307.72439ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:51.355601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.782232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.189\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-09-24T02:54:51.355831Z","caller":"traceutil/trace.go:171","msg":"trace[688998821] range","detail":"{range_begin:/registry/masterleases/162.253.55.189; range_end:; response_count:1; response_revision:26734; }","duration":"631.088768ms","start":"2026-09-24T02:54:50.724714Z","end":"2026-09-24T02:54:51.355803Z","steps":["trace[688998821] 'range keys from in-memory index tree' (duration: 630.569577ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:51.355915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:50.724696Z","time spent":"631.205241ms","remote":"127.0.0.1:47592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":164,"request content":"key:\"/registry/masterleases/162.253.55.189\" "} {"level":"info","ts":"2026-09-24T02:54:51.356024Z","caller":"traceutil/trace.go:171","msg":"trace[1482022398] transaction","detail":"{read_only:false; response_revision:26735; number_of_response:1; }","duration":"614.295022ms","start":"2026-09-24T02:54:50.741607Z","end":"2026-09-24T02:54:51.355902Z","steps":["trace[1482022398] 'process raft request' (duration: 572.6485ms)","trace[1482022398] 'compare' (duration: 41.236023ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:54:51.356886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:50.741577Z","time spent":"615.204393ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:52.101627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.111255ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-24T02:54:52.101866Z","caller":"traceutil/trace.go:171","msg":"trace[1609734017] transaction","detail":"{read_only:false; response_revision:26736; number_of_response:1; }","duration":"1.334935766s","start":"2026-09-24T02:54:50.766891Z","end":"2026-09-24T02:54:52.101827Z","steps":["trace[1609734017] 'process raft request' (duration: 1.123501153s)","trace[1609734017] 'compare' (duration: 209.986591ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:54:52.101969Z","caller":"traceutil/trace.go:171","msg":"trace[1480935677] transaction","detail":"{read_only:false; response_revision:26737; number_of_response:1; }","duration":"1.330911146s","start":"2026-09-24T02:54:50.771027Z","end":"2026-09-24T02:54:52.101938Z","steps":["trace[1480935677] 'process raft request' (duration: 1.330717832s)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:52.101962Z","caller":"traceutil/trace.go:171","msg":"trace[1941348818] transaction","detail":"{read_only:false; response_revision:26738; number_of_response:1; }","duration":"1.330811914s","start":"2026-09-24T02:54:50.771128Z","end":"2026-09-24T02:54:52.101939Z","steps":["trace[1941348818] 'process raft request' (duration: 1.330730172s)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.102129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:50.771014Z","time spent":"1.331027779s","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:52.102163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:50.771096Z","time spent":"1.331027769s","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:52.102221Z","caller":"traceutil/trace.go:171","msg":"trace[1383954171] transaction","detail":"{read_only:false; response_revision:26739; number_of_response:1; }","duration":"1.330301963s","start":"2026-09-24T02:54:50.771886Z","end":"2026-09-24T02:54:52.102188Z","steps":["trace[1383954171] 'process raft request' (duration: 1.330008546s)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:52.102249Z","caller":"traceutil/trace.go:171","msg":"trace[735146037] linearizableReadLoop","detail":"{readStateIndex:27624; appliedIndex:27619; }","duration":"1.087733372s","start":"2026-09-24T02:54:51.014493Z","end":"2026-09-24T02:54:52.102226Z","steps":["trace[735146037] 'read index received' (duration: 299.784291ms)","trace[735146037] 'applied index is now lower than readState.Index' (duration: 787.948141ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:54:52.102375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.087900336s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-24T02:54:52.102396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:50.771824Z","time spent":"1.330471956s","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:52.102412Z","caller":"traceutil/trace.go:171","msg":"trace[1145161449] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26740; }","duration":"1.087980197s","start":"2026-09-24T02:54:51.014421Z","end":"2026-09-24T02:54:52.102401Z","steps":["trace[1145161449] 'agreement among raft nodes before linearized reading' (duration: 1.087892866s)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.102444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:51.014396Z","time spent":"1.088042128s","remote":"127.0.0.1:47542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-24T02:54:52.102363Z","caller":"traceutil/trace.go:171","msg":"trace[287372330] transaction","detail":"{read_only:false; response_revision:26740; number_of_response:1; }","duration":"975.136082ms","start":"2026-09-24T02:54:51.127142Z","end":"2026-09-24T02:54:52.102278Z","steps":["trace[287372330] 'process raft request' (duration: 974.980828ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.102728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:50.766868Z","time spent":"1.335160141s","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:52.102801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:51.1271Z","time spent":"975.424038ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:52.123015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"966.653521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-09-24T02:54:52.123061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.046508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:54:52.123088Z","caller":"traceutil/trace.go:171","msg":"trace[1239212694] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26740; }","duration":"966.777604ms","start":"2026-09-24T02:54:51.156294Z","end":"2026-09-24T02:54:52.123071Z","steps":["trace[1239212694] 'agreement among raft nodes before linearized reading' (duration: 966.60998ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:52.123119Z","caller":"traceutil/trace.go:171","msg":"trace[1447337594] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:26740; }","duration":"388.174901ms","start":"2026-09-24T02:54:51.734926Z","end":"2026-09-24T02:54:52.123101Z","steps":["trace[1447337594] 'agreement among raft nodes before linearized reading' (duration: 388.068288ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.123127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:51.156264Z","time spent":"966.855056ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-24T02:54:52.123098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.024315602s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-09-24T02:54:52.123162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:51.7349Z","time spent":"388.252153ms","remote":"127.0.0.1:43850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-09-24T02:54:52.123095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:51.357689Z","time spent":"765.397006ms","remote":"127.0.0.1:47592","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-09-24T02:54:52.123236Z","caller":"traceutil/trace.go:171","msg":"trace[259447252] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26740; }","duration":"1.024471336s","start":"2026-09-24T02:54:51.098709Z","end":"2026-09-24T02:54:52.12318Z","steps":["trace[259447252] 'agreement among raft nodes before linearized reading' (duration: 1.024139079s)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.12324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.029642652s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-24T02:54:52.123294Z","caller":"traceutil/trace.go:171","msg":"trace[1801654476] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26740; }","duration":"1.029765854s","start":"2026-09-24T02:54:51.093514Z","end":"2026-09-24T02:54:52.12328Z","steps":["trace[1801654476] 'agreement among raft nodes before linearized reading' (duration: 1.029557s)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.1233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:51.098698Z","time spent":"1.024588109s","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-24T02:54:52.123334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:51.093487Z","time spent":"1.029839176s","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-24T02:54:52.123364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.022550483s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/projects/\" range_end:\"/registry/openstack.k-orc.cloud/projects0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:54:52.123426Z","caller":"traceutil/trace.go:171","msg":"trace[1862058409] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/projects/; range_end:/registry/openstack.k-orc.cloud/projects0; response_count:0; response_revision:26740; }","duration":"1.022677555s","start":"2026-09-24T02:54:51.10073Z","end":"2026-09-24T02:54:52.123407Z","steps":["trace[1862058409] 'agreement among raft nodes before linearized reading' (duration: 1.022586573s)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.123465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:51.100686Z","time spent":"1.022769407s","remote":"127.0.0.1:41616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/projects/\" range_end:\"/registry/openstack.k-orc.cloud/projects0\" count_only:true "} {"level":"warn","ts":"2026-09-24T02:54:52.123467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.345163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/glance-api-6895d498cd-5pv85.18d8208f97bd6b57\" ","response":"range_response_count:1 size:2108"} {"level":"info","ts":"2026-09-24T02:54:52.123581Z","caller":"traceutil/trace.go:171","msg":"trace[1510074702] range","detail":"{range_begin:/registry/events/openstack/glance-api-6895d498cd-5pv85.18d8208f97bd6b57; range_end:; response_count:1; response_revision:26740; }","duration":"291.500617ms","start":"2026-09-24T02:54:51.832068Z","end":"2026-09-24T02:54:52.123568Z","steps":["trace[1510074702] 'agreement among raft nodes before linearized reading' (duration: 290.883343ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.123591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.293581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-09-24T02:54:52.123593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.029339915s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-24T02:54:52.123639Z","caller":"traceutil/trace.go:171","msg":"trace[368488667] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26740; }","duration":"965.359303ms","start":"2026-09-24T02:54:51.158265Z","end":"2026-09-24T02:54:52.123624Z","steps":["trace[368488667] 'agreement among raft nodes before linearized reading' (duration: 965.181589ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.123671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:51.158254Z","time spent":"965.410854ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-24T02:54:52.123688Z","caller":"traceutil/trace.go:171","msg":"trace[554591084] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26740; }","duration":"1.029511039s","start":"2026-09-24T02:54:51.094158Z","end":"2026-09-24T02:54:52.123669Z","steps":["trace[554591084] 'agreement among raft nodes before linearized reading' (duration: 1.028721972s)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.123758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:51.09412Z","time spent":"1.029627082s","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-24T02:54:52.280226Z","caller":"traceutil/trace.go:171","msg":"trace[2145588223] transaction","detail":"{read_only:false; response_revision:26741; number_of_response:1; }","duration":"155.067282ms","start":"2026-09-24T02:54:52.125122Z","end":"2026-09-24T02:54:52.280189Z","steps":["trace[2145588223] 'process raft request' (duration: 130.470371ms)","trace[2145588223] 'compare' (duration: 24.402227ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:54:52.452673Z","caller":"traceutil/trace.go:171","msg":"trace[749941671] transaction","detail":"{read_only:false; response_revision:26742; number_of_response:1; }","duration":"325.871365ms","start":"2026-09-24T02:54:52.126764Z","end":"2026-09-24T02:54:52.452635Z","steps":["trace[749941671] 'process raft request' (duration: 305.276964ms)","trace[749941671] 'compare' (duration: 20.207053ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:54:52.452885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:52.126745Z","time spent":"326.023908ms","remote":"127.0.0.1:47638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2092,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:52.453046Z","caller":"traceutil/trace.go:171","msg":"trace[86439587] transaction","detail":"{read_only:false; response_revision:26743; number_of_response:1; }","duration":"324.211308ms","start":"2026-09-24T02:54:52.128793Z","end":"2026-09-24T02:54:52.453004Z","steps":["trace[86439587] 'process raft request' (duration: 323.727927ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:52.453145Z","caller":"traceutil/trace.go:171","msg":"trace[1583653953] transaction","detail":"{read_only:false; response_revision:26745; number_of_response:1; }","duration":"324.189028ms","start":"2026-09-24T02:54:52.128932Z","end":"2026-09-24T02:54:52.453121Z","steps":["trace[1583653953] 'process raft request' (duration: 323.979133ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:52.453181Z","caller":"traceutil/trace.go:171","msg":"trace[1333887942] transaction","detail":"{read_only:false; response_revision:26746; number_of_response:1; }","duration":"324.007705ms","start":"2026-09-24T02:54:52.129141Z","end":"2026-09-24T02:54:52.453149Z","steps":["trace[1333887942] 'process raft request' (duration: 323.886201ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:52.453175Z","caller":"traceutil/trace.go:171","msg":"trace[1518248657] transaction","detail":"{read_only:false; response_revision:26747; number_of_response:1; }","duration":"324.003824ms","start":"2026-09-24T02:54:52.12916Z","end":"2026-09-24T02:54:52.453163Z","steps":["trace[1518248657] 'process raft request' (duration: 323.930042ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.453233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.04223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-09-24T02:54:52.453234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:52.128778Z","time spent":"324.355561ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:52.453282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:52.128922Z","time spent":"324.28228ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:52.453275Z","caller":"traceutil/trace.go:171","msg":"trace[1040963661] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26747; }","duration":"322.112341ms","start":"2026-09-24T02:54:52.131153Z","end":"2026-09-24T02:54:52.453265Z","steps":["trace[1040963661] 'agreement among raft nodes before linearized reading' (duration: 322.027059ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.453279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:52.129132Z","time spent":"324.097927ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:52.453017Z","caller":"traceutil/trace.go:171","msg":"trace[950429232] transaction","detail":"{read_only:false; response_revision:26744; number_of_response:1; }","duration":"324.123095ms","start":"2026-09-24T02:54:52.128825Z","end":"2026-09-24T02:54:52.452948Z","steps":["trace[950429232] 'process raft request' (duration: 323.977202ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.453328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:52.13114Z","time spent":"322.180463ms","remote":"127.0.0.1:47542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-24T02:54:52.453148Z","caller":"traceutil/trace.go:171","msg":"trace[1095411528] linearizableReadLoop","detail":"{readStateIndex:27633; appliedIndex:27626; }","duration":"321.934987ms","start":"2026-09-24T02:54:52.131195Z","end":"2026-09-24T02:54:52.45313Z","steps":["trace[1095411528] 'read index received' (duration: 124.495617ms)","trace[1095411528] 'applied index is now lower than readState.Index' (duration: 197.43859ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:54:52.45334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:52.129141Z","time spent":"324.113957ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:52.453463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:52.128793Z","time spent":"324.572686ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:52.773263Z","caller":"traceutil/trace.go:171","msg":"trace[116959176] transaction","detail":"{read_only:false; response_revision:26748; number_of_response:1; }","duration":"428.216227ms","start":"2026-09-24T02:54:52.345019Z","end":"2026-09-24T02:54:52.773235Z","steps":["trace[116959176] 'process raft request' (duration: 412.944154ms)","trace[116959176] 'compare' (duration: 14.785302ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:54:52.773447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:52.344983Z","time spent":"428.37989ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:52.773468Z","caller":"traceutil/trace.go:171","msg":"trace[414556046] linearizableReadLoop","detail":"{readStateIndex:27635; appliedIndex:27633; }","duration":"319.993804ms","start":"2026-09-24T02:54:52.453447Z","end":"2026-09-24T02:54:52.773441Z","steps":["trace[414556046] 'read index received' (duration: 304.567038ms)","trace[414556046] 'applied index is now lower than readState.Index' (duration: 15.425616ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:54:52.773706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.564879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:54:52.773753Z","caller":"traceutil/trace.go:171","msg":"trace[805850667] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:26749; }","duration":"505.667482ms","start":"2026-09-24T02:54:52.268072Z","end":"2026-09-24T02:54:52.773739Z","steps":["trace[805850667] 'agreement among raft nodes before linearized reading' (duration: 505.571049ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.773785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:52.268053Z","time spent":"505.722472ms","remote":"127.0.0.1:42272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":30,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true "} {"level":"warn","ts":"2026-09-24T02:54:52.77383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.058563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:54:52.77387Z","caller":"traceutil/trace.go:171","msg":"trace[1788497143] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:26749; }","duration":"625.133235ms","start":"2026-09-24T02:54:52.148723Z","end":"2026-09-24T02:54:52.773856Z","steps":["trace[1788497143] 'agreement among raft nodes before linearized reading' (duration: 625.056273ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.773862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.405729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-24T02:54:52.773867Z","caller":"traceutil/trace.go:171","msg":"trace[803153408] transaction","detail":"{read_only:false; response_revision:26749; number_of_response:1; }","duration":"402.041652ms","start":"2026-09-24T02:54:52.371757Z","end":"2026-09-24T02:54:52.773799Z","steps":["trace[803153408] 'process raft request' (duration: 401.388058ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.773911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:52.148705Z","time spent":"625.197606ms","remote":"127.0.0.1:42382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":30,"request content":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true "} {"level":"info","ts":"2026-09-24T02:54:52.773918Z","caller":"traceutil/trace.go:171","msg":"trace[147205054] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26749; }","duration":"385.4723ms","start":"2026-09-24T02:54:52.388431Z","end":"2026-09-24T02:54:52.773903Z","steps":["trace[147205054] 'agreement among raft nodes before linearized reading' (duration: 385.377598ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.773961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:52.388339Z","time spent":"385.612863ms","remote":"127.0.0.1:51320","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":32,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-09-24T02:54:52.77387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.567653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:423"} {"level":"info","ts":"2026-09-24T02:54:52.774071Z","caller":"traceutil/trace.go:171","msg":"trace[329999550] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:26749; }","duration":"490.839509ms","start":"2026-09-24T02:54:52.283177Z","end":"2026-09-24T02:54:52.774016Z","steps":["trace[329999550] 'agreement among raft nodes before linearized reading' (duration: 490.43204ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.774112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:52.37172Z","time spent":"402.287086ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:52.77415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:52.283156Z","time spent":"490.975132ms","remote":"127.0.0.1:47706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":447,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"info","ts":"2026-09-24T02:54:52.774342Z","caller":"traceutil/trace.go:171","msg":"trace[1791269822] transaction","detail":"{read_only:false; response_revision:26750; number_of_response:1; }","duration":"187.652852ms","start":"2026-09-24T02:54:52.586677Z","end":"2026-09-24T02:54:52.774329Z","steps":["trace[1791269822] 'process raft request' (duration: 187.541289ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:52.774598Z","caller":"traceutil/trace.go:171","msg":"trace[899943676] transaction","detail":"{read_only:false; response_revision:26751; number_of_response:1; }","duration":"146.807466ms","start":"2026-09-24T02:54:52.627766Z","end":"2026-09-24T02:54:52.774574Z","steps":["trace[899943676] 'process raft request' (duration: 146.52598ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:52.77463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.808476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:54:52.774667Z","caller":"traceutil/trace.go:171","msg":"trace[142819706] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:26751; }","duration":"238.895858ms","start":"2026-09-24T02:54:52.53576Z","end":"2026-09-24T02:54:52.774656Z","steps":["trace[142819706] 'agreement among raft nodes before linearized reading' (duration: 238.741644ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:53.246039Z","caller":"traceutil/trace.go:171","msg":"trace[464255793] transaction","detail":"{read_only:false; response_revision:26752; number_of_response:1; }","duration":"141.868256ms","start":"2026-09-24T02:54:53.104135Z","end":"2026-09-24T02:54:53.246004Z","steps":["trace[464255793] 'process raft request' (duration: 141.571308ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:54.446328Z","caller":"traceutil/trace.go:171","msg":"trace[1290309197] transaction","detail":"{read_only:false; response_revision:26755; number_of_response:1; }","duration":"338.265734ms","start":"2026-09-24T02:54:54.108033Z","end":"2026-09-24T02:54:54.446298Z","steps":["trace[1290309197] 'process raft request' (duration: 277.511973ms)","trace[1290309197] 'compare' (duration: 60.473875ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:54:54.446503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:54.108001Z","time spent":"338.407476ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:54.446672Z","caller":"traceutil/trace.go:171","msg":"trace[1001998845] transaction","detail":"{read_only:false; response_revision:26756; number_of_response:1; }","duration":"338.608981ms","start":"2026-09-24T02:54:54.108033Z","end":"2026-09-24T02:54:54.446642Z","steps":["trace[1001998845] 'process raft request' (duration: 338.208272ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:54.446838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:54.108002Z","time spent":"338.744443ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:54.446963Z","caller":"traceutil/trace.go:171","msg":"trace[1173208650] transaction","detail":"{read_only:false; response_revision:26757; number_of_response:1; }","duration":"338.517809ms","start":"2026-09-24T02:54:54.108379Z","end":"2026-09-24T02:54:54.446896Z","steps":["trace[1173208650] 'process raft request' (duration: 338.197462ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:54.447038Z","caller":"traceutil/trace.go:171","msg":"trace[1050865469] transaction","detail":"{read_only:false; response_revision:26758; number_of_response:1; }","duration":"338.531619ms","start":"2026-09-24T02:54:54.108458Z","end":"2026-09-24T02:54:54.446989Z","steps":["trace[1050865469] 'process raft request' (duration: 338.340525ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:54.447253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:54.108363Z","time spent":"338.709923ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:54.447526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:54.108428Z","time spent":"338.817475ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:54.781924Z","caller":"traceutil/trace.go:171","msg":"trace[1641940663] transaction","detail":"{read_only:false; response_revision:26760; number_of_response:1; }","duration":"318.357058ms","start":"2026-09-24T02:54:54.463547Z","end":"2026-09-24T02:54:54.781904Z","steps":["trace[1641940663] 'process raft request' (duration: 318.087012ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:54.782043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:54.463526Z","time spent":"318.45612ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:54.782058Z","caller":"traceutil/trace.go:171","msg":"trace[2019712384] transaction","detail":"{read_only:false; response_revision:26761; number_of_response:1; }","duration":"318.084212ms","start":"2026-09-24T02:54:54.463936Z","end":"2026-09-24T02:54:54.782021Z","steps":["trace[2019712384] 'process raft request' (duration: 317.907808ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:54.782265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:54.463922Z","time spent":"318.234695ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:54.783412Z","caller":"traceutil/trace.go:171","msg":"trace[506239692] transaction","detail":"{read_only:false; response_revision:26763; number_of_response:1; }","duration":"319.115055ms","start":"2026-09-24T02:54:54.464239Z","end":"2026-09-24T02:54:54.783354Z","steps":["trace[506239692] 'process raft request' (duration: 318.638664ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:54.783464Z","caller":"traceutil/trace.go:171","msg":"trace[1336938712] transaction","detail":"{read_only:false; response_revision:26762; number_of_response:1; }","duration":"319.287979ms","start":"2026-09-24T02:54:54.464161Z","end":"2026-09-24T02:54:54.783449Z","steps":["trace[1336938712] 'process raft request' (duration: 317.783365ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:54.783688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:54.464138Z","time spent":"319.495723ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:54.783702Z","caller":"traceutil/trace.go:171","msg":"trace[1587805126] transaction","detail":"{read_only:false; response_revision:26764; number_of_response:1; }","duration":"317.1126ms","start":"2026-09-24T02:54:54.466569Z","end":"2026-09-24T02:54:54.783681Z","steps":["trace[1587805126] 'process raft request' (duration: 316.400644ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:54.78379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:54.464231Z","time spent":"319.34779ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:54.783993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:54.466533Z","time spent":"317.307555ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:54:55.102017Z","caller":"traceutil/trace.go:171","msg":"trace[1143373174] transaction","detail":"{read_only:false; response_revision:26766; number_of_response:1; }","duration":"321.13739ms","start":"2026-09-24T02:54:54.78085Z","end":"2026-09-24T02:54:55.101987Z","steps":["trace[1143373174] 'process raft request' (duration: 321.050128ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:55.102023Z","caller":"traceutil/trace.go:171","msg":"trace[941503106] transaction","detail":"{read_only:false; response_revision:26765; number_of_response:1; }","duration":"321.436187ms","start":"2026-09-24T02:54:54.78054Z","end":"2026-09-24T02:54:55.101976Z","steps":["trace[941503106] 'process raft request' (duration: 304.861586ms)","trace[941503106] 'compare' (duration: 15.941307ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:54:55.102194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:54.780817Z","time spent":"321.284053ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:55.102431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:54:54.780517Z","time spent":"321.743183ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:54:55.441479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.3983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-09-24T02:54:55.441575Z","caller":"traceutil/trace.go:171","msg":"trace[1915935979] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26766; }","duration":"235.525153ms","start":"2026-09-24T02:54:55.206011Z","end":"2026-09-24T02:54:55.441537Z","steps":["trace[1915935979] 'range keys from in-memory index tree' (duration: 235.178785ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:55.72136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.400735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:54:55.721454Z","caller":"traceutil/trace.go:171","msg":"trace[1636908764] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26767; }","duration":"145.532048ms","start":"2026-09-24T02:54:55.575892Z","end":"2026-09-24T02:54:55.721424Z","steps":["trace[1636908764] 'range keys from in-memory index tree' (duration: 145.244732ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:56.737868Z","caller":"traceutil/trace.go:171","msg":"trace[922409710] transaction","detail":"{read_only:false; response_revision:26771; number_of_response:1; }","duration":"283.474666ms","start":"2026-09-24T02:54:56.454362Z","end":"2026-09-24T02:54:56.737837Z","steps":["trace[922409710] 'process raft request' (duration: 283.332143ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:56.737914Z","caller":"traceutil/trace.go:171","msg":"trace[1342596253] linearizableReadLoop","detail":"{readStateIndex:27658; appliedIndex:27654; }","duration":"232.035055ms","start":"2026-09-24T02:54:56.50585Z","end":"2026-09-24T02:54:56.737885Z","steps":["trace[1342596253] 'read index received' (duration: 18.279409ms)","trace[1342596253] 'applied index is now lower than readState.Index' (duration: 213.754586ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:54:56.738035Z","caller":"traceutil/trace.go:171","msg":"trace[590679760] transaction","detail":"{read_only:false; response_revision:26772; number_of_response:1; }","duration":"283.584529ms","start":"2026-09-24T02:54:56.454437Z","end":"2026-09-24T02:54:56.738021Z","steps":["trace[590679760] 'process raft request' (duration: 283.343653ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:54:56.737884Z","caller":"traceutil/trace.go:171","msg":"trace[1408883310] transaction","detail":"{read_only:false; response_revision:26770; number_of_response:1; }","duration":"283.521397ms","start":"2026-09-24T02:54:56.454325Z","end":"2026-09-24T02:54:56.737846Z","steps":["trace[1408883310] 'process raft request' (duration: 280.737805ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:56.738329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.471565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-09-24T02:54:56.738373Z","caller":"traceutil/trace.go:171","msg":"trace[1769709799] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26772; }","duration":"232.528676ms","start":"2026-09-24T02:54:56.505831Z","end":"2026-09-24T02:54:56.73836Z","steps":["trace[1769709799] 'agreement among raft nodes before linearized reading' (duration: 232.371823ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:54:56.738398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.572426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-24T02:54:56.738467Z","caller":"traceutil/trace.go:171","msg":"trace[1031950921] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:26772; }","duration":"144.670578ms","start":"2026-09-24T02:54:56.593777Z","end":"2026-09-24T02:54:56.738447Z","steps":["trace[1031950921] 'agreement among raft nodes before linearized reading' (duration: 144.527785ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:02.783965Z","caller":"traceutil/trace.go:171","msg":"trace[424776591] linearizableReadLoop","detail":"{readStateIndex:27716; appliedIndex:27715; }","duration":"207.034585ms","start":"2026-09-24T02:55:02.57691Z","end":"2026-09-24T02:55:02.783944Z","steps":["trace[424776591] 'read index received' (duration: 206.883482ms)","trace[424776591] 'applied index is now lower than readState.Index' (duration: 149.973µs)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:55:02.784092Z","caller":"traceutil/trace.go:171","msg":"trace[229341453] transaction","detail":"{read_only:false; response_revision:26828; number_of_response:1; }","duration":"240.541705ms","start":"2026-09-24T02:55:02.54348Z","end":"2026-09-24T02:55:02.784022Z","steps":["trace[229341453] 'process raft request' (duration: 240.295979ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:02.784127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.195338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:55:02.784297Z","caller":"traceutil/trace.go:171","msg":"trace[1533701893] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:26828; }","duration":"207.422933ms","start":"2026-09-24T02:55:02.576852Z","end":"2026-09-24T02:55:02.784275Z","steps":["trace[1533701893] 'agreement among raft nodes before linearized reading' (duration: 207.204599ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:03.085337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.482832ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-24T02:55:03.085625Z","caller":"traceutil/trace.go:171","msg":"trace[606598935] transaction","detail":"{read_only:false; response_revision:26830; number_of_response:1; }","duration":"324.069606ms","start":"2026-09-24T02:55:02.761538Z","end":"2026-09-24T02:55:03.085607Z","steps":["trace[606598935] 'process raft request' (duration: 323.894152ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:03.08565Z","caller":"traceutil/trace.go:171","msg":"trace[1678521743] transaction","detail":"{read_only:false; response_revision:26829; number_of_response:1; }","duration":"327.772118ms","start":"2026-09-24T02:55:02.757806Z","end":"2026-09-24T02:55:03.085579Z","steps":["trace[1678521743] 'process raft request' (duration: 62.96709ms)","trace[1678521743] 'compare' (duration: 264.097853ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:55:03.08578Z","caller":"traceutil/trace.go:171","msg":"trace[1506995817] linearizableReadLoop","detail":"{readStateIndex:27719; appliedIndex:27716; }","duration":"301.706385ms","start":"2026-09-24T02:55:02.784032Z","end":"2026-09-24T02:55:03.085739Z","steps":["trace[1506995817] 'read index received' (duration: 37.799797ms)","trace[1506995817] 'applied index is now lower than readState.Index' (duration: 263.905358ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:55:03.085851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:02.75778Z","time spent":"327.961272ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:55:03.08603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.500254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-09-24T02:55:03.086029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:02.761524Z","time spent":"324.144087ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:55:03.085891Z","caller":"traceutil/trace.go:171","msg":"trace[1189735626] transaction","detail":"{read_only:false; response_revision:26831; number_of_response:1; }","duration":"321.790984ms","start":"2026-09-24T02:55:02.764089Z","end":"2026-09-24T02:55:03.08588Z","steps":["trace[1189735626] 'process raft request' (duration: 321.485687ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:03.086066Z","caller":"traceutil/trace.go:171","msg":"trace[674024392] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26831; }","duration":"315.551935ms","start":"2026-09-24T02:55:02.770505Z","end":"2026-09-24T02:55:03.086057Z","steps":["trace[674024392] 'agreement among raft nodes before linearized reading' (duration: 315.401422ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:03.086096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:02.77046Z","time spent":"315.628147ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-24T02:55:03.086147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:02.764076Z","time spent":"322.003419ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:55:03.122917Z","caller":"traceutil/trace.go:171","msg":"trace[983304117] transaction","detail":"{read_only:false; response_revision:26832; number_of_response:1; }","duration":"332.172996ms","start":"2026-09-24T02:55:02.790708Z","end":"2026-09-24T02:55:03.122881Z","steps":["trace[983304117] 'process raft request' (duration: 332.040763ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:03.123007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.71265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-09-24T02:55:03.12303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:02.790665Z","time spent":"332.307159ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:55:03.12301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.977421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/domains/\" range_end:\"/registry/openstack.k-orc.cloud/domains0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:55:03.12307Z","caller":"traceutil/trace.go:171","msg":"trace[1223307168] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26832; }","duration":"299.852553ms","start":"2026-09-24T02:55:02.823196Z","end":"2026-09-24T02:55:03.123049Z","steps":["trace[1223307168] 'agreement among raft nodes before linearized reading' (duration: 299.670799ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:03.12309Z","caller":"traceutil/trace.go:171","msg":"trace[1959976122] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/domains/; range_end:/registry/openstack.k-orc.cloud/domains0; response_count:0; response_revision:26832; }","duration":"265.077543ms","start":"2026-09-24T02:55:02.857989Z","end":"2026-09-24T02:55:03.123067Z","steps":["trace[1959976122] 'agreement among raft nodes before linearized reading' (duration: 264.91499ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:03.12341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.534448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:55:03.123452Z","caller":"traceutil/trace.go:171","msg":"trace[969074896] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26832; }","duration":"107.62175ms","start":"2026-09-24T02:55:03.015821Z","end":"2026-09-24T02:55:03.123442Z","steps":["trace[969074896] 'agreement among raft nodes before linearized reading' (duration: 107.553278ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:03.123486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.783881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-09-24T02:55:03.123594Z","caller":"traceutil/trace.go:171","msg":"trace[519938383] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26832; }","duration":"299.932635ms","start":"2026-09-24T02:55:02.823644Z","end":"2026-09-24T02:55:03.123577Z","steps":["trace[519938383] 'agreement among raft nodes before linearized reading' (duration: 299.787741ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:03.123646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:02.823614Z","time spent":"300.019858ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-24T02:55:03.123411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.15345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-09-24T02:55:03.123707Z","caller":"traceutil/trace.go:171","msg":"trace[1183271020] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26832; }","duration":"296.511268ms","start":"2026-09-24T02:55:02.827182Z","end":"2026-09-24T02:55:03.123694Z","steps":["trace[1183271020] 'agreement among raft nodes before linearized reading' (duration: 296.155699ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:03.123896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.238022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-24T02:55:03.123938Z","caller":"traceutil/trace.go:171","msg":"trace[723184609] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26832; }","duration":"300.322544ms","start":"2026-09-24T02:55:02.823606Z","end":"2026-09-24T02:55:03.123929Z","steps":["trace[723184609] 'agreement among raft nodes before linearized reading' (duration: 300.181431ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:03.123965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:02.823582Z","time spent":"300.375066ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-24T02:55:03.84374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.237568ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-24T02:55:03.843847Z","caller":"traceutil/trace.go:171","msg":"trace[197179502] linearizableReadLoop","detail":"{readStateIndex:27721; appliedIndex:27720; }","duration":"718.448736ms","start":"2026-09-24T02:55:03.125379Z","end":"2026-09-24T02:55:03.843828Z","steps":["trace[197179502] 'read index received' (duration: 420.051515ms)","trace[197179502] 'applied index is now lower than readState.Index' (duration: 298.395971ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:55:03.843927Z","caller":"traceutil/trace.go:171","msg":"trace[1926999303] transaction","detail":"{read_only:false; response_revision:26833; number_of_response:1; }","duration":"753.546791ms","start":"2026-09-24T02:55:03.090369Z","end":"2026-09-24T02:55:03.843916Z","steps":["trace[1926999303] 'process raft request' (duration: 455.046727ms)","trace[1926999303] 'compare' (duration: 298.087974ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:55:03.843987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:03.090346Z","time spent":"753.611021ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:55:03.845739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"719.852346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:55:03.845873Z","caller":"traceutil/trace.go:171","msg":"trace[1884344764] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26833; }","duration":"720.504431ms","start":"2026-09-24T02:55:03.125346Z","end":"2026-09-24T02:55:03.84585Z","steps":["trace[1884344764] 'agreement among raft nodes before linearized reading' (duration: 718.761033ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:03.845986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:03.12531Z","time spent":"720.658694ms","remote":"127.0.0.1:47550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-24T02:55:03.88777Z","caller":"traceutil/trace.go:171","msg":"trace[2099751607] transaction","detail":"{read_only:false; response_revision:26834; number_of_response:1; }","duration":"760.092957ms","start":"2026-09-24T02:55:03.127644Z","end":"2026-09-24T02:55:03.887737Z","steps":["trace[2099751607] 'process raft request' (duration: 759.76223ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:03.887823Z","caller":"traceutil/trace.go:171","msg":"trace[1079516969] transaction","detail":"{read_only:false; response_revision:26835; number_of_response:1; }","duration":"760.122627ms","start":"2026-09-24T02:55:03.127664Z","end":"2026-09-24T02:55:03.887787Z","steps":["trace[1079516969] 'process raft request' (duration: 759.920553ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:03.888015Z","caller":"traceutil/trace.go:171","msg":"trace[928240765] transaction","detail":"{read_only:false; response_revision:26839; number_of_response:1; }","duration":"743.976396ms","start":"2026-09-24T02:55:03.143985Z","end":"2026-09-24T02:55:03.887961Z","steps":["trace[928240765] 'process raft request' (duration: 743.851933ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:03.888071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.337627ms","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:6"} {"level":"warn","ts":"2026-09-24T02:55:03.888093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.24426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-24T02:55:03.888109Z","caller":"traceutil/trace.go:171","msg":"trace[2053948175] transaction","detail":"{read_only:false; response_revision:26840; number_of_response:1; }","duration":"407.395691ms","start":"2026-09-24T02:55:03.480688Z","end":"2026-09-24T02:55:03.888084Z","steps":["trace[2053948175] 'process raft request' (duration: 407.184206ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:03.888152Z","caller":"traceutil/trace.go:171","msg":"trace[1091020469] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:26840; }","duration":"245.336012ms","start":"2026-09-24T02:55:03.642799Z","end":"2026-09-24T02:55:03.888135Z","steps":["trace[1091020469] 'agreement among raft nodes before linearized reading' (duration: 245.231219ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:03.888179Z","caller":"traceutil/trace.go:171","msg":"trace[211870963] transaction","detail":"{read_only:false; response_revision:26836; number_of_response:1; }","duration":"760.252691ms","start":"2026-09-24T02:55:03.127917Z","end":"2026-09-24T02:55:03.888169Z","steps":["trace[211870963] 'process raft request' (duration: 759.803911ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:03.888176Z","caller":"traceutil/trace.go:171","msg":"trace[193711086] transaction","detail":"{read_only:false; response_revision:26837; number_of_response:1; }","duration":"758.804427ms","start":"2026-09-24T02:55:03.129344Z","end":"2026-09-24T02:55:03.888149Z","steps":["trace[193711086] 'process raft request' (duration: 758.420829ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:03.888225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:03.480653Z","time spent":"407.514212ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:55:03.888257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:03.127903Z","time spent":"760.301491ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:55:03.888289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:03.129334Z","time spent":"758.90191ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:55:03.888274Z","caller":"traceutil/trace.go:171","msg":"trace[1104080895] transaction","detail":"{read_only:false; response_revision:26838; number_of_response:1; }","duration":"745.96118ms","start":"2026-09-24T02:55:03.14227Z","end":"2026-09-24T02:55:03.888231Z","steps":["trace[1104080895] 'process raft request' (duration: 745.53364ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:03.888136Z","caller":"traceutil/trace.go:171","msg":"trace[1886847949] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:26840; }","duration":"293.442039ms","start":"2026-09-24T02:55:03.594675Z","end":"2026-09-24T02:55:03.888117Z","steps":["trace[1886847949] 'agreement among raft nodes before linearized reading' (duration: 293.370798ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:03.888004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.826296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:55:03.888454Z","caller":"traceutil/trace.go:171","msg":"trace[1822136218] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0; response_count:0; response_revision:26840; }","duration":"331.321908ms","start":"2026-09-24T02:55:03.55711Z","end":"2026-09-24T02:55:03.888432Z","steps":["trace[1822136218] 'agreement among raft nodes before linearized reading' (duration: 330.813966ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:03.888057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:03.127623Z","time spent":"760.226969ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:55:03.888468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:03.142257Z","time spent":"746.110425ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:55:03.888521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:03.557085Z","time spent":"331.414191ms","remote":"127.0.0.1:35548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":142,"response count":0,"response size":30,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0\" count_only:true "} {"level":"warn","ts":"2026-09-24T02:55:03.888531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:03.143974Z","time spent":"744.132169ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:55:03.888722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:03.127642Z","time spent":"760.380313ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:55:08.240826Z","caller":"traceutil/trace.go:171","msg":"trace[45545395] transaction","detail":"{read_only:false; response_revision:26875; number_of_response:1; }","duration":"112.907257ms","start":"2026-09-24T02:55:08.127896Z","end":"2026-09-24T02:55:08.240803Z","steps":["trace[45545395] 'process raft request' (duration: 112.730853ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:08.492239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.238628ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-24T02:55:08.49271Z","caller":"traceutil/trace.go:171","msg":"trace[1543100577] transaction","detail":"{read_only:false; response_revision:26876; number_of_response:1; }","duration":"256.479891ms","start":"2026-09-24T02:55:08.236194Z","end":"2026-09-24T02:55:08.492674Z","steps":["trace[1543100577] 'process raft request' (duration: 124.709241ms)","trace[1543100577] 'compare' (duration: 130.678236ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:55:08.49277Z","caller":"traceutil/trace.go:171","msg":"trace[1835445947] transaction","detail":"{read_only:false; response_revision:26877; number_of_response:1; }","duration":"241.143809ms","start":"2026-09-24T02:55:08.251608Z","end":"2026-09-24T02:55:08.492752Z","steps":["trace[1835445947] 'process raft request' (duration: 240.74466ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:08.492965Z","caller":"traceutil/trace.go:171","msg":"trace[1914217221] transaction","detail":"{read_only:false; response_revision:26878; number_of_response:1; }","duration":"161.553716ms","start":"2026-09-24T02:55:08.331401Z","end":"2026-09-24T02:55:08.492955Z","steps":["trace[1914217221] 'process raft request' (duration: 161.320151ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:08.492946Z","caller":"traceutil/trace.go:171","msg":"trace[320394813] linearizableReadLoop","detail":"{readStateIndex:27767; appliedIndex:27764; }","duration":"122.659456ms","start":"2026-09-24T02:55:08.370244Z","end":"2026-09-24T02:55:08.492904Z","steps":["trace[320394813] 'read index received' (duration: 117.584252ms)","trace[320394813] 'applied index is now lower than readState.Index' (duration: 5.074124ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:55:08.493062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.800849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:55:08.49309Z","caller":"traceutil/trace.go:171","msg":"trace[658967871] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:26878; }","duration":"122.873251ms","start":"2026-09-24T02:55:08.370207Z","end":"2026-09-24T02:55:08.49308Z","steps":["trace[658967871] 'agreement among raft nodes before linearized reading' (duration: 122.793659ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:11.337048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.680318ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-24T02:55:11.33727Z","caller":"traceutil/trace.go:171","msg":"trace[2059445961] transaction","detail":"{read_only:false; response_revision:26949; number_of_response:1; }","duration":"437.874984ms","start":"2026-09-24T02:55:10.899358Z","end":"2026-09-24T02:55:11.337233Z","steps":["trace[2059445961] 'process raft request' (duration: 33.893888ms)","trace[2059445961] 'compare' (duration: 403.439913ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:55:11.337343Z","caller":"traceutil/trace.go:171","msg":"trace[182838677] transaction","detail":"{read_only:false; response_revision:26950; number_of_response:1; }","duration":"206.396051ms","start":"2026-09-24T02:55:11.130916Z","end":"2026-09-24T02:55:11.337312Z","steps":["trace[182838677] 'process raft request' (duration: 206.266428ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:11.337473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:10.89932Z","time spent":"438.047347ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:55:11.337518Z","caller":"traceutil/trace.go:171","msg":"trace[1089474693] linearizableReadLoop","detail":"{readStateIndex:27839; appliedIndex:27838; }","duration":"361.782571ms","start":"2026-09-24T02:55:10.975678Z","end":"2026-09-24T02:55:11.33746Z","steps":["trace[1089474693] 'read index received' (duration: 47.441µs)","trace[1089474693] 'applied index is now lower than readState.Index' (duration: 361.731259ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:55:11.337922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.24286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-09-24T02:55:11.337987Z","caller":"traceutil/trace.go:171","msg":"trace[230392019] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26950; }","duration":"362.368764ms","start":"2026-09-24T02:55:10.975598Z","end":"2026-09-24T02:55:11.337967Z","steps":["trace[230392019] 'agreement among raft nodes before linearized reading' (duration: 362.029626ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:11.338044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:10.975535Z","time spent":"362.494876ms","remote":"127.0.0.1:47720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-09-24T02:55:11.389467Z","caller":"traceutil/trace.go:171","msg":"trace[1840743855] transaction","detail":"{read_only:false; response_revision:26951; number_of_response:1; }","duration":"257.25713ms","start":"2026-09-24T02:55:11.132184Z","end":"2026-09-24T02:55:11.389441Z","steps":["trace[1840743855] 'process raft request' (duration: 256.735808ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:11.389715Z","caller":"traceutil/trace.go:171","msg":"trace[987057008] transaction","detail":"{read_only:false; response_revision:26952; number_of_response:1; }","duration":"257.458904ms","start":"2026-09-24T02:55:11.132247Z","end":"2026-09-24T02:55:11.389706Z","steps":["trace[987057008] 'process raft request' (duration: 256.85283ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:11.389984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.902314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-24T02:55:11.390072Z","caller":"traceutil/trace.go:171","msg":"trace[1133545113] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:26952; }","duration":"145.039096ms","start":"2026-09-24T02:55:11.245011Z","end":"2026-09-24T02:55:11.39005Z","steps":["trace[1133545113] 'agreement among raft nodes before linearized reading' (duration: 144.829662ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:11.390257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.460574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-642876dc-33b2-4b37-9e55-1cf0515ed19c\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-09-24T02:55:11.390347Z","caller":"traceutil/trace.go:171","msg":"trace[199352188] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-642876dc-33b2-4b37-9e55-1cf0515ed19c; range_end:; response_count:1; response_revision:26952; }","duration":"211.565496ms","start":"2026-09-24T02:55:11.17876Z","end":"2026-09-24T02:55:11.390325Z","steps":["trace[199352188] 'agreement among raft nodes before linearized reading' (duration: 211.28832ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:14.059983Z","caller":"traceutil/trace.go:171","msg":"trace[1505329566] transaction","detail":"{read_only:false; response_revision:26983; number_of_response:1; }","duration":"129.053339ms","start":"2026-09-24T02:55:13.930904Z","end":"2026-09-24T02:55:14.059957Z","steps":["trace[1505329566] 'process raft request' (duration: 128.871445ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:14.102659Z","caller":"traceutil/trace.go:171","msg":"trace[1759544695] transaction","detail":"{read_only:false; response_revision:26985; number_of_response:1; }","duration":"168.094603ms","start":"2026-09-24T02:55:13.934538Z","end":"2026-09-24T02:55:14.102633Z","steps":["trace[1759544695] 'process raft request' (duration: 167.9769ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:14.102677Z","caller":"traceutil/trace.go:171","msg":"trace[1937873732] transaction","detail":"{read_only:false; response_revision:26984; number_of_response:1; }","duration":"169.389633ms","start":"2026-09-24T02:55:13.933251Z","end":"2026-09-24T02:55:14.102641Z","steps":["trace[1937873732] 'process raft request' (duration: 169.087807ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:14.102797Z","caller":"traceutil/trace.go:171","msg":"trace[665931829] transaction","detail":"{read_only:false; response_revision:26986; number_of_response:1; }","duration":"150.198913ms","start":"2026-09-24T02:55:13.952573Z","end":"2026-09-24T02:55:14.102772Z","steps":["trace[665931829] 'process raft request' (duration: 150.019129ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:14.102791Z","caller":"traceutil/trace.go:171","msg":"trace[1991613365] linearizableReadLoop","detail":"{readStateIndex:27876; appliedIndex:27872; }","duration":"141.017348ms","start":"2026-09-24T02:55:13.961741Z","end":"2026-09-24T02:55:14.102758Z","steps":["trace[1991613365] 'read index received' (duration: 98.075486ms)","trace[1991613365] 'applied index is now lower than readState.Index' (duration: 42.939802ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:55:14.10311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.284174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-09-24T02:55:14.103112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.555716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-24T02:55:14.103155Z","caller":"traceutil/trace.go:171","msg":"trace[2096289740] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26986; }","duration":"133.356296ms","start":"2026-09-24T02:55:13.969786Z","end":"2026-09-24T02:55:14.103142Z","steps":["trace[2096289740] 'agreement among raft nodes before linearized reading' (duration: 133.252294ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:14.103166Z","caller":"traceutil/trace.go:171","msg":"trace[1653729428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26986; }","duration":"140.660158ms","start":"2026-09-24T02:55:13.962489Z","end":"2026-09-24T02:55:14.103149Z","steps":["trace[1653729428] 'agreement among raft nodes before linearized reading' (duration: 140.470164ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:14.103361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.43207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-09-24T02:55:14.103599Z","caller":"traceutil/trace.go:171","msg":"trace[674179655] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26986; }","duration":"117.768117ms","start":"2026-09-24T02:55:13.985817Z","end":"2026-09-24T02:55:14.103585Z","steps":["trace[674179655] 'agreement among raft nodes before linearized reading' (duration: 117.145503ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:14.103006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.240783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-09-24T02:55:14.103779Z","caller":"traceutil/trace.go:171","msg":"trace[990441570] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26986; }","duration":"142.065421ms","start":"2026-09-24T02:55:13.961703Z","end":"2026-09-24T02:55:14.103768Z","steps":["trace[990441570] 'agreement among raft nodes before linearized reading' (duration: 141.136461ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:19.072987Z","caller":"traceutil/trace.go:171","msg":"trace[595778382] linearizableReadLoop","detail":"{readStateIndex:27930; appliedIndex:27929; }","duration":"182.894884ms","start":"2026-09-24T02:55:18.89007Z","end":"2026-09-24T02:55:19.072965Z","steps":["trace[595778382] 'read index received' (duration: 182.69432ms)","trace[595778382] 'applied index is now lower than readState.Index' (duration: 199.644µs)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:55:19.073028Z","caller":"traceutil/trace.go:171","msg":"trace[1912299828] transaction","detail":"{read_only:false; response_revision:27038; number_of_response:1; }","duration":"269.102914ms","start":"2026-09-24T02:55:18.803896Z","end":"2026-09-24T02:55:19.072999Z","steps":["trace[1912299828] 'process raft request' (duration: 268.90044ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:19.07317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.085638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-09-24T02:55:19.073211Z","caller":"traceutil/trace.go:171","msg":"trace[412434776] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:27038; }","duration":"183.18006ms","start":"2026-09-24T02:55:18.89002Z","end":"2026-09-24T02:55:19.0732Z","steps":["trace[412434776] 'agreement among raft nodes before linearized reading' (duration: 183.031297ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:19.090103Z","caller":"traceutil/trace.go:171","msg":"trace[1221250071] transaction","detail":"{read_only:false; response_revision:27039; number_of_response:1; }","duration":"198.915373ms","start":"2026-09-24T02:55:18.891172Z","end":"2026-09-24T02:55:19.090087Z","steps":["trace[1221250071] 'process raft request' (duration: 198.836992ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:19.394425Z","caller":"traceutil/trace.go:171","msg":"trace[677891226] transaction","detail":"{read_only:false; response_revision:27040; number_of_response:1; }","duration":"316.021725ms","start":"2026-09-24T02:55:19.078377Z","end":"2026-09-24T02:55:19.394399Z","steps":["trace[677891226] 'process raft request' (duration: 315.78987ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:19.394686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:19.078353Z","time spent":"316.24218ms","remote":"127.0.0.1:47806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1490,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:55:19.394724Z","caller":"traceutil/trace.go:171","msg":"trace[2108870808] transaction","detail":"{read_only:false; response_revision:27041; number_of_response:1; }","duration":"313.994559ms","start":"2026-09-24T02:55:19.080707Z","end":"2026-09-24T02:55:19.394701Z","steps":["trace[2108870808] 'process raft request' (duration: 313.631751ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:19.394832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:19.080691Z","time spent":"314.093501ms","remote":"127.0.0.1:47706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":885,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:55:19.394878Z","caller":"traceutil/trace.go:171","msg":"trace[601856323] transaction","detail":"{read_only:false; response_revision:27043; number_of_response:1; }","duration":"309.012048ms","start":"2026-09-24T02:55:19.085834Z","end":"2026-09-24T02:55:19.394846Z","steps":["trace[601856323] 'process raft request' (duration: 308.927616ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:19.394912Z","caller":"traceutil/trace.go:171","msg":"trace[906117777] transaction","detail":"{read_only:false; response_revision:27042; number_of_response:1; }","duration":"309.14032ms","start":"2026-09-24T02:55:19.085734Z","end":"2026-09-24T02:55:19.394874Z","steps":["trace[906117777] 'process raft request' (duration: 308.903485ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:19.39505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:19.085812Z","time spent":"309.138971ms","remote":"127.0.0.1:47806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1415,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:55:19.395082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:19.085717Z","time spent":"309.276844ms","remote":"127.0.0.1:47706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:55:26.357424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.520613ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-09-24T02:55:26.358201Z","caller":"traceutil/trace.go:171","msg":"trace[8668582] transaction","detail":"{read_only:false; response_revision:27098; number_of_response:1; }","duration":"255.353777ms","start":"2026-09-24T02:55:26.102813Z","end":"2026-09-24T02:55:26.358166Z","steps":["trace[8668582] 'process raft request' (duration: 254.707552ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:26.503039Z","caller":"traceutil/trace.go:171","msg":"trace[576457937] linearizableReadLoop","detail":"{readStateIndex:27994; appliedIndex:27990; }","duration":"351.746094ms","start":"2026-09-24T02:55:26.151256Z","end":"2026-09-24T02:55:26.503002Z","steps":["trace[576457937] 'read index received' (duration: 96.580812ms)","trace[576457937] 'applied index is now lower than readState.Index' (duration: 255.163922ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:55:26.503061Z","caller":"traceutil/trace.go:171","msg":"trace[303608002] transaction","detail":"{read_only:false; response_revision:27099; number_of_response:1; }","duration":"358.925756ms","start":"2026-09-24T02:55:26.144099Z","end":"2026-09-24T02:55:26.503024Z","steps":["trace[303608002] 'process raft request' (duration: 358.593818ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:26.503107Z","caller":"traceutil/trace.go:171","msg":"trace[191415238] transaction","detail":"{read_only:false; response_revision:27100; number_of_response:1; }","duration":"357.609446ms","start":"2026-09-24T02:55:26.145456Z","end":"2026-09-24T02:55:26.503065Z","steps":["trace[191415238] 'process raft request' (duration: 357.489133ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:26.503262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:26.144071Z","time spent":"359.064868ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-24T02:55:26.503364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.084041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-09-24T02:55:26.503338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:26.145443Z","time spent":"357.745668ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:55:26.503412Z","caller":"traceutil/trace.go:171","msg":"trace[151971406] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27100; }","duration":"352.217095ms","start":"2026-09-24T02:55:26.15118Z","end":"2026-09-24T02:55:26.503397Z","steps":["trace[151971406] 'agreement among raft nodes before linearized reading' (duration: 351.99889ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:26.503457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:26.151151Z","time spent":"352.295166ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-24T02:55:26.50347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.112113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:55:26.503512Z","caller":"traceutil/trace.go:171","msg":"trace[1241840978] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:27100; }","duration":"348.209015ms","start":"2026-09-24T02:55:26.15529Z","end":"2026-09-24T02:55:26.503499Z","steps":["trace[1241840978] 'agreement among raft nodes before linearized reading' (duration: 348.128783ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:26.503541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:26.155261Z","time spent":"348.271817ms","remote":"127.0.0.1:43842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-09-24T02:55:26.50378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.169724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-09-24T02:55:26.503767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.324237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-09-24T02:55:26.503776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.026402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-09-24T02:55:26.503828Z","caller":"traceutil/trace.go:171","msg":"trace[1800355752] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27100; }","duration":"339.289367ms","start":"2026-09-24T02:55:26.164521Z","end":"2026-09-24T02:55:26.503811Z","steps":["trace[1800355752] 'agreement among raft nodes before linearized reading' (duration: 339.168473ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:26.503838Z","caller":"traceutil/trace.go:171","msg":"trace[1213762090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27100; }","duration":"331.452941ms","start":"2026-09-24T02:55:26.172369Z","end":"2026-09-24T02:55:26.503822Z","steps":["trace[1213762090] 'agreement among raft nodes before linearized reading' (duration: 331.217085ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:26.503862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:26.164496Z","time spent":"339.358428ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-24T02:55:26.503875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:26.172342Z","time spent":"331.524082ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-24T02:55:26.503916Z","caller":"traceutil/trace.go:171","msg":"trace[1025249736] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27100; }","duration":"331.167014ms","start":"2026-09-24T02:55:26.172664Z","end":"2026-09-24T02:55:26.503831Z","steps":["trace[1025249736] 'agreement among raft nodes before linearized reading' (duration: 330.959789ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:26.503967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:26.172628Z","time spent":"331.327628ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-24T02:55:26.503979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.492365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-24T02:55:26.504012Z","caller":"traceutil/trace.go:171","msg":"trace[1125210841] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:27100; }","duration":"336.556395ms","start":"2026-09-24T02:55:26.167446Z","end":"2026-09-24T02:55:26.504002Z","steps":["trace[1125210841] 'agreement among raft nodes before linearized reading' (duration: 336.405842ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:26.504041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:55:26.167395Z","time spent":"336.640347ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-24T02:55:26.690443Z","caller":"traceutil/trace.go:171","msg":"trace[1450694895] transaction","detail":"{read_only:false; response_revision:27106; number_of_response:1; }","duration":"119.992046ms","start":"2026-09-24T02:55:26.570422Z","end":"2026-09-24T02:55:26.690414Z","steps":["trace[1450694895] 'process raft request' (duration: 119.815902ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:30.840686Z","caller":"traceutil/trace.go:171","msg":"trace[1572106454] transaction","detail":"{read_only:false; response_revision:27136; number_of_response:1; }","duration":"192.01697ms","start":"2026-09-24T02:55:30.648611Z","end":"2026-09-24T02:55:30.840628Z","steps":["trace[1572106454] 'process raft request' (duration: 191.546048ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:30.840901Z","caller":"traceutil/trace.go:171","msg":"trace[1284725636] transaction","detail":"{read_only:false; response_revision:27137; number_of_response:1; }","duration":"192.081331ms","start":"2026-09-24T02:55:30.648745Z","end":"2026-09-24T02:55:30.840826Z","steps":["trace[1284725636] 'process raft request' (duration: 191.691602ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:30.841897Z","caller":"traceutil/trace.go:171","msg":"trace[1926060599] linearizableReadLoop","detail":"{readStateIndex:28033; appliedIndex:28028; }","duration":"155.611433ms","start":"2026-09-24T02:55:30.686268Z","end":"2026-09-24T02:55:30.841879Z","steps":["trace[1926060599] 'read index received' (duration: 179.814µs)","trace[1926060599] 'applied index is now lower than readState.Index' (duration: 155.429149ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:55:30.841933Z","caller":"traceutil/trace.go:171","msg":"trace[487680169] transaction","detail":"{read_only:false; response_revision:27139; number_of_response:1; }","duration":"193.065663ms","start":"2026-09-24T02:55:30.648833Z","end":"2026-09-24T02:55:30.841899Z","steps":["trace[487680169] 'process raft request' (duration: 192.824437ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:30.84221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.9109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-09-24T02:55:30.842274Z","caller":"traceutil/trace.go:171","msg":"trace[510218645] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:27139; }","duration":"156.061183ms","start":"2026-09-24T02:55:30.686194Z","end":"2026-09-24T02:55:30.842255Z","steps":["trace[510218645] 'agreement among raft nodes before linearized reading' (duration: 155.793517ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:30.841803Z","caller":"traceutil/trace.go:171","msg":"trace[937699435] transaction","detail":"{read_only:false; response_revision:27138; number_of_response:1; }","duration":"193.005231ms","start":"2026-09-24T02:55:30.64877Z","end":"2026-09-24T02:55:30.841775Z","steps":["trace[937699435] 'process raft request' (duration: 192.678494ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:30.924937Z","caller":"traceutil/trace.go:171","msg":"trace[1713085077] transaction","detail":"{read_only:false; response_revision:27140; number_of_response:1; }","duration":"222.913661ms","start":"2026-09-24T02:55:30.701988Z","end":"2026-09-24T02:55:30.924901Z","steps":["trace[1713085077] 'process raft request' (duration: 196.415517ms)","trace[1713085077] 'compare' (duration: 26.361101ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:55:30.925071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.959967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.189\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-09-24T02:55:30.925156Z","caller":"traceutil/trace.go:171","msg":"trace[971489682] range","detail":"{range_begin:/registry/masterleases/162.253.55.189; range_end:; response_count:1; response_revision:27140; }","duration":"196.1019ms","start":"2026-09-24T02:55:30.729039Z","end":"2026-09-24T02:55:30.925141Z","steps":["trace[971489682] 'agreement among raft nodes before linearized reading' (duration: 195.845165ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:36.889223Z","caller":"traceutil/trace.go:171","msg":"trace[20260776] transaction","detail":"{read_only:false; response_revision:27185; number_of_response:1; }","duration":"170.525658ms","start":"2026-09-24T02:55:36.718669Z","end":"2026-09-24T02:55:36.889195Z","steps":["trace[20260776] 'process raft request' (duration: 143.543074ms)","trace[20260776] 'compare' (duration: 26.712768ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:55:36.922414Z","caller":"traceutil/trace.go:171","msg":"trace[429885823] linearizableReadLoop","detail":"{readStateIndex:28082; appliedIndex:28080; }","duration":"114.008363ms","start":"2026-09-24T02:55:36.808368Z","end":"2026-09-24T02:55:36.922376Z","steps":["trace[429885823] 'read index received' (duration: 53.859016ms)","trace[429885823] 'applied index is now lower than readState.Index' (duration: 60.148237ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:55:36.922747Z","caller":"traceutil/trace.go:171","msg":"trace[909548107] transaction","detail":"{read_only:false; response_revision:27186; number_of_response:1; }","duration":"163.670444ms","start":"2026-09-24T02:55:36.759063Z","end":"2026-09-24T02:55:36.922733Z","steps":["trace[909548107] 'process raft request' (duration: 163.161603ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:36.922988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.602096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-24T02:55:36.923023Z","caller":"traceutil/trace.go:171","msg":"trace[1618038077] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:27186; }","duration":"114.697518ms","start":"2026-09-24T02:55:36.808314Z","end":"2026-09-24T02:55:36.923012Z","steps":["trace[1618038077] 'agreement among raft nodes before linearized reading' (duration: 114.611976ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:37.351061Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23793} {"level":"info","ts":"2026-09-24T02:55:37.492296Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23793,"took":"135.510993ms","hash":2315935430,"current-db-size-bytes":59604992,"current-db-size":"60 MB","current-db-size-in-use-bytes":45613056,"current-db-size-in-use":"46 MB"} {"level":"info","ts":"2026-09-24T02:55:37.49237Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2315935430,"revision":23793,"compact-revision":21638} {"level":"info","ts":"2026-09-24T02:55:39.006656Z","caller":"traceutil/trace.go:171","msg":"trace[2001482541] transaction","detail":"{read_only:false; response_revision:27205; number_of_response:1; }","duration":"108.133432ms","start":"2026-09-24T02:55:38.898496Z","end":"2026-09-24T02:55:39.00663Z","steps":["trace[2001482541] 'process raft request' (duration: 107.926907ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:39.194301Z","caller":"traceutil/trace.go:171","msg":"trace[958421228] transaction","detail":"{read_only:false; response_revision:27207; number_of_response:1; }","duration":"162.739233ms","start":"2026-09-24T02:55:39.03153Z","end":"2026-09-24T02:55:39.194269Z","steps":["trace[958421228] 'process raft request' (duration: 145.651211ms)","trace[958421228] 'compare' (duration: 16.933179ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:55:39.239399Z","caller":"traceutil/trace.go:171","msg":"trace[583383236] transaction","detail":"{read_only:false; response_revision:27208; number_of_response:1; }","duration":"207.24587ms","start":"2026-09-24T02:55:39.032102Z","end":"2026-09-24T02:55:39.239347Z","steps":["trace[583383236] 'process raft request' (duration: 206.910402ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:39.239499Z","caller":"traceutil/trace.go:171","msg":"trace[18894187] transaction","detail":"{read_only:false; response_revision:27210; number_of_response:1; }","duration":"195.586899ms","start":"2026-09-24T02:55:39.043882Z","end":"2026-09-24T02:55:39.239469Z","steps":["trace[18894187] 'process raft request' (duration: 195.508267ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:39.239505Z","caller":"traceutil/trace.go:171","msg":"trace[427540398] transaction","detail":"{read_only:false; response_revision:27209; number_of_response:1; }","duration":"207.286ms","start":"2026-09-24T02:55:39.032182Z","end":"2026-09-24T02:55:39.239468Z","steps":["trace[427540398] 'process raft request' (duration: 206.994624ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:39.239711Z","caller":"traceutil/trace.go:171","msg":"trace[1155191613] transaction","detail":"{read_only:false; response_revision:27211; number_of_response:1; }","duration":"189.537803ms","start":"2026-09-24T02:55:39.050159Z","end":"2026-09-24T02:55:39.239697Z","steps":["trace[1155191613] 'process raft request' (duration: 189.272797ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:40.915625Z","caller":"traceutil/trace.go:171","msg":"trace[1026963747] linearizableReadLoop","detail":"{readStateIndex:28116; appliedIndex:28115; }","duration":"184.804128ms","start":"2026-09-24T02:55:40.730793Z","end":"2026-09-24T02:55:40.915597Z","steps":["trace[1026963747] 'read index received' (duration: 184.535652ms)","trace[1026963747] 'applied index is now lower than readState.Index' (duration: 267.236µs)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:55:40.91576Z","caller":"traceutil/trace.go:171","msg":"trace[420709873] transaction","detail":"{read_only:false; response_revision:27219; number_of_response:1; }","duration":"222.367909ms","start":"2026-09-24T02:55:40.693348Z","end":"2026-09-24T02:55:40.915716Z","steps":["trace[420709873] 'process raft request' (duration: 222.030621ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:40.91588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.075174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.189\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-09-24T02:55:40.915924Z","caller":"traceutil/trace.go:171","msg":"trace[1011321597] range","detail":"{range_begin:/registry/masterleases/162.253.55.189; range_end:; response_count:1; response_revision:27219; }","duration":"185.171366ms","start":"2026-09-24T02:55:40.730741Z","end":"2026-09-24T02:55:40.915913Z","steps":["trace[1011321597] 'agreement among raft nodes before linearized reading' (duration: 184.983592ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:40.916499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.173369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" ","response":"range_response_count:1 size:1312"} {"level":"info","ts":"2026-09-24T02:55:40.916595Z","caller":"traceutil/trace.go:171","msg":"trace[417364117] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-manila-default-user; range_end:; response_count:1; response_revision:27219; }","duration":"153.341782ms","start":"2026-09-24T02:55:40.763235Z","end":"2026-09-24T02:55:40.916577Z","steps":["trace[417364117] 'agreement among raft nodes before linearized reading' (duration: 152.518544ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:43.212674Z","caller":"traceutil/trace.go:171","msg":"trace[1918442331] transaction","detail":"{read_only:false; response_revision:27234; number_of_response:1; }","duration":"179.343485ms","start":"2026-09-24T02:55:43.033285Z","end":"2026-09-24T02:55:43.212629Z","steps":["trace[1918442331] 'process raft request' (duration: 176.211785ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:43.217841Z","caller":"traceutil/trace.go:171","msg":"trace[385728049] linearizableReadLoop","detail":"{readStateIndex:28133; appliedIndex:28131; }","duration":"151.709726ms","start":"2026-09-24T02:55:43.066111Z","end":"2026-09-24T02:55:43.217821Z","steps":["trace[385728049] 'read index received' (duration: 143.567054ms)","trace[385728049] 'applied index is now lower than readState.Index' (duration: 8.140582ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:55:43.218039Z","caller":"traceutil/trace.go:171","msg":"trace[1052755286] transaction","detail":"{read_only:false; response_revision:27235; number_of_response:1; }","duration":"181.049864ms","start":"2026-09-24T02:55:43.036934Z","end":"2026-09-24T02:55:43.217984Z","steps":["trace[1052755286] 'process raft request' (duration: 180.770557ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:43.218138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.015574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-24T02:55:43.218252Z","caller":"traceutil/trace.go:171","msg":"trace[775671335] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:27235; }","duration":"148.174898ms","start":"2026-09-24T02:55:43.070038Z","end":"2026-09-24T02:55:43.218212Z","steps":["trace[775671335] 'agreement among raft nodes before linearized reading' (duration: 147.971323ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:55:43.219369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.23624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:32 size:276062"} {"level":"info","ts":"2026-09-24T02:55:43.219428Z","caller":"traceutil/trace.go:171","msg":"trace[575176706] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:32; response_revision:27235; }","duration":"153.350452ms","start":"2026-09-24T02:55:43.066063Z","end":"2026-09-24T02:55:43.219414Z","steps":["trace[575176706] 'agreement among raft nodes before linearized reading' (duration: 151.87753ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:55:47.5355Z","caller":"traceutil/trace.go:171","msg":"trace[1859861288] transaction","detail":"{read_only:false; response_revision:27268; number_of_response:1; }","duration":"170.64134ms","start":"2026-09-24T02:55:47.364831Z","end":"2026-09-24T02:55:47.535472Z","steps":["trace[1859861288] 'process raft request' (duration: 80.36992ms)","trace[1859861288] 'compare' (duration: 90.084486ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:56:03.218573Z","caller":"traceutil/trace.go:171","msg":"trace[1242084665] transaction","detail":"{read_only:false; response_revision:27378; number_of_response:1; }","duration":"128.739942ms","start":"2026-09-24T02:56:03.089781Z","end":"2026-09-24T02:56:03.218521Z","steps":["trace[1242084665] 'process raft request' (duration: 128.527697ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:56:08.721601Z","caller":"traceutil/trace.go:171","msg":"trace[1118386731] transaction","detail":"{read_only:false; response_revision:27431; number_of_response:1; }","duration":"194.768661ms","start":"2026-09-24T02:56:08.526806Z","end":"2026-09-24T02:56:08.721574Z","steps":["trace[1118386731] 'process raft request' (duration: 194.528496ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:56:08.930825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.120216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:56:08.930927Z","caller":"traceutil/trace.go:171","msg":"trace[2043252578] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:27431; }","duration":"202.26891ms","start":"2026-09-24T02:56:08.728636Z","end":"2026-09-24T02:56:08.930905Z","steps":["trace[2043252578] 'range keys from in-memory index tree' (duration: 202.052445ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:56:08.942839Z","caller":"traceutil/trace.go:171","msg":"trace[1811878867] transaction","detail":"{read_only:false; response_revision:27432; number_of_response:1; }","duration":"191.196771ms","start":"2026-09-24T02:56:08.751605Z","end":"2026-09-24T02:56:08.942802Z","steps":["trace[1811878867] 'process raft request' (duration: 191.019817ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:56:09.193597Z","caller":"traceutil/trace.go:171","msg":"trace[361979321] transaction","detail":"{read_only:false; response_revision:27433; number_of_response:1; }","duration":"112.805405ms","start":"2026-09-24T02:56:09.080763Z","end":"2026-09-24T02:56:09.193568Z","steps":["trace[361979321] 'process raft request' (duration: 93.928214ms)","trace[361979321] 'compare' (duration: 18.733808ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:56:09.53143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.895546ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-24T02:56:09.531622Z","caller":"traceutil/trace.go:171","msg":"trace[871823480] transaction","detail":"{read_only:false; response_revision:27434; number_of_response:1; }","duration":"274.834832ms","start":"2026-09-24T02:56:09.256766Z","end":"2026-09-24T02:56:09.5316Z","steps":["trace[871823480] 'process raft request' (duration: 95.679541ms)","trace[871823480] 'compare' (duration: 178.722712ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:56:09.531823Z","caller":"traceutil/trace.go:171","msg":"trace[144708538] linearizableReadLoop","detail":"{readStateIndex:28339; appliedIndex:28337; }","duration":"173.023323ms","start":"2026-09-24T02:56:09.358758Z","end":"2026-09-24T02:56:09.531781Z","steps":["trace[144708538] 'read index received' (duration: 118.008661ms)","trace[144708538] 'applied index is now lower than readState.Index' (duration: 55.013302ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:56:09.531913Z","caller":"traceutil/trace.go:171","msg":"trace[1161703617] transaction","detail":"{read_only:false; response_revision:27435; number_of_response:1; }","duration":"202.205757ms","start":"2026-09-24T02:56:09.329646Z","end":"2026-09-24T02:56:09.531852Z","steps":["trace[1161703617] 'process raft request' (duration: 201.88643ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:56:09.532076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.29634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-09-24T02:56:09.532113Z","caller":"traceutil/trace.go:171","msg":"trace[185841900] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27435; }","duration":"173.390322ms","start":"2026-09-24T02:56:09.358712Z","end":"2026-09-24T02:56:09.532103Z","steps":["trace[185841900] 'agreement among raft nodes before linearized reading' (duration: 173.205227ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:56:09.818514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.129655ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-09-24T02:56:09.818663Z","caller":"traceutil/trace.go:171","msg":"trace[1770909] transaction","detail":"{read_only:false; response_revision:27436; number_of_response:1; }","duration":"438.938927ms","start":"2026-09-24T02:56:09.379688Z","end":"2026-09-24T02:56:09.818627Z","steps":["trace[1770909] 'process raft request' (duration: 307.546705ms)","trace[1770909] 'compare' (duration: 131.009403ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:56:09.818748Z","caller":"traceutil/trace.go:171","msg":"trace[1938591854] transaction","detail":"{read_only:false; response_revision:27438; number_of_response:1; }","duration":"136.328732ms","start":"2026-09-24T02:56:09.682406Z","end":"2026-09-24T02:56:09.818735Z","steps":["trace[1938591854] 'process raft request' (duration: 136.288722ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:56:09.818766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:56:09.379667Z","time spent":"439.05214ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-24T02:56:09.818761Z","caller":"traceutil/trace.go:171","msg":"trace[1805968569] linearizableReadLoop","detail":"{readStateIndex:28340; appliedIndex:28339; }","duration":"286.830542ms","start":"2026-09-24T02:56:09.531894Z","end":"2026-09-24T02:56:09.818724Z","steps":["trace[1805968569] 'read index received' (duration: 155.353739ms)","trace[1805968569] 'applied index is now lower than readState.Index' (duration: 131.473773ms)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:56:09.818998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.892924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-09-24T02:56:09.818991Z","caller":"traceutil/trace.go:171","msg":"trace[1328347304] transaction","detail":"{read_only:false; response_revision:27437; number_of_response:1; }","duration":"281.750428ms","start":"2026-09-24T02:56:09.53721Z","end":"2026-09-24T02:56:09.81896Z","steps":["trace[1328347304] 'process raft request' (duration: 281.431161ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:56:09.819032Z","caller":"traceutil/trace.go:171","msg":"trace[2118960395] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27438; }","duration":"349.924535ms","start":"2026-09-24T02:56:09.469095Z","end":"2026-09-24T02:56:09.81902Z","steps":["trace[2118960395] 'agreement among raft nodes before linearized reading' (duration: 349.765771ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:56:09.819065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:56:09.469037Z","time spent":"350.021307ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-24T02:56:09.819124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.927239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-09-24T02:56:09.819184Z","caller":"traceutil/trace.go:171","msg":"trace[863191683] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27438; }","duration":"352.052832ms","start":"2026-09-24T02:56:09.467116Z","end":"2026-09-24T02:56:09.819169Z","steps":["trace[863191683] 'agreement among raft nodes before linearized reading' (duration: 351.785576ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:56:09.819169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.284745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-09-24T02:56:09.819261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:56:09.467092Z","time spent":"352.156945ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-24T02:56:09.819281Z","caller":"traceutil/trace.go:171","msg":"trace[185243122] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:27438; }","duration":"460.429229ms","start":"2026-09-24T02:56:09.358829Z","end":"2026-09-24T02:56:09.819259Z","steps":["trace[185243122] 'agreement among raft nodes before linearized reading' (duration: 460.103432ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:56:09.819326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-24T02:56:09.358815Z","time spent":"460.50158ms","remote":"127.0.0.1:47802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-24T02:56:09.83213Z","caller":"traceutil/trace.go:171","msg":"trace[346519905] transaction","detail":"{read_only:false; response_revision:27439; number_of_response:1; }","duration":"104.340946ms","start":"2026-09-24T02:56:09.727767Z","end":"2026-09-24T02:56:09.832108Z","steps":["trace[346519905] 'process raft request' (duration: 104.09239ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:56:09.832163Z","caller":"traceutil/trace.go:171","msg":"trace[1994791878] transaction","detail":"{read_only:false; response_revision:27440; number_of_response:1; }","duration":"102.77984ms","start":"2026-09-24T02:56:09.729351Z","end":"2026-09-24T02:56:09.832131Z","steps":["trace[1994791878] 'process raft request' (duration: 102.703439ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:56:09.832444Z","caller":"traceutil/trace.go:171","msg":"trace[693959996] transaction","detail":"{read_only:false; response_revision:27441; number_of_response:1; }","duration":"102.353871ms","start":"2026-09-24T02:56:09.730078Z","end":"2026-09-24T02:56:09.832432Z","steps":["trace[693959996] 'process raft request' (duration: 102.014584ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:56:09.832611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.26319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-24T02:56:09.832732Z","caller":"traceutil/trace.go:171","msg":"trace[1444855823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27441; }","duration":"186.447654ms","start":"2026-09-24T02:56:09.646263Z","end":"2026-09-24T02:56:09.83271Z","steps":["trace[1444855823] 'agreement among raft nodes before linearized reading' (duration: 186.081435ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:56:10.055833Z","caller":"traceutil/trace.go:171","msg":"trace[682027605] transaction","detail":"{read_only:false; response_revision:27443; number_of_response:1; }","duration":"229.819835ms","start":"2026-09-24T02:56:09.825973Z","end":"2026-09-24T02:56:10.055793Z","steps":["trace[682027605] 'process raft request' (duration: 229.486718ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:56:10.055898Z","caller":"traceutil/trace.go:171","msg":"trace[908093728] transaction","detail":"{read_only:false; response_revision:27442; number_of_response:1; }","duration":"231.249297ms","start":"2026-09-24T02:56:09.824599Z","end":"2026-09-24T02:56:10.055848Z","steps":["trace[908093728] 'process raft request' (duration: 161.7043ms)","trace[908093728] 'compare' (duration: 68.75823ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:56:10.056198Z","caller":"traceutil/trace.go:171","msg":"trace[1622705492] transaction","detail":"{read_only:false; response_revision:27446; number_of_response:1; }","duration":"219.459703ms","start":"2026-09-24T02:56:09.836701Z","end":"2026-09-24T02:56:10.056161Z","steps":["trace[1622705492] 'process raft request' (duration: 218.993273ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:56:10.056197Z","caller":"traceutil/trace.go:171","msg":"trace[1450031982] transaction","detail":"{read_only:false; response_revision:27444; number_of_response:1; }","duration":"230.01697ms","start":"2026-09-24T02:56:09.826127Z","end":"2026-09-24T02:56:10.056144Z","steps":["trace[1450031982] 'process raft request' (duration: 229.485968ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:56:10.056505Z","caller":"traceutil/trace.go:171","msg":"trace[577763226] transaction","detail":"{read_only:false; response_revision:27445; number_of_response:1; }","duration":"228.582487ms","start":"2026-09-24T02:56:09.827345Z","end":"2026-09-24T02:56:10.055927Z","steps":["trace[577763226] 'process raft request' (duration: 228.305841ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:56:10.52995Z","caller":"traceutil/trace.go:171","msg":"trace[499973008] linearizableReadLoop","detail":"{readStateIndex:28351; appliedIndex:28350; }","duration":"157.977116ms","start":"2026-09-24T02:56:10.371941Z","end":"2026-09-24T02:56:10.529918Z","steps":["trace[499973008] 'read index received' (duration: 157.643529ms)","trace[499973008] 'applied index is now lower than readState.Index' (duration: 332.427µs)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:56:10.530102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.1436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-09-24T02:56:10.530083Z","caller":"traceutil/trace.go:171","msg":"trace[1884720665] transaction","detail":"{read_only:false; response_revision:27447; number_of_response:1; }","duration":"243.400608ms","start":"2026-09-24T02:56:10.286642Z","end":"2026-09-24T02:56:10.530043Z","steps":["trace[1884720665] 'process raft request' (duration: 243.079811ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:56:10.530148Z","caller":"traceutil/trace.go:171","msg":"trace[1976508524] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:27447; }","duration":"158.252653ms","start":"2026-09-24T02:56:10.371879Z","end":"2026-09-24T02:56:10.530132Z","steps":["trace[1976508524] 'agreement among raft nodes before linearized reading' (duration: 158.15338ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:56:10.869697Z","caller":"traceutil/trace.go:171","msg":"trace[1344603725] linearizableReadLoop","detail":"{readStateIndex:28352; appliedIndex:28351; }","duration":"109.751957ms","start":"2026-09-24T02:56:10.759914Z","end":"2026-09-24T02:56:10.869666Z","steps":["trace[1344603725] 'read index received' (duration: 109.595023ms)","trace[1344603725] 'applied index is now lower than readState.Index' (duration: 155.164µs)"],"step_count":2} {"level":"warn","ts":"2026-09-24T02:56:10.869852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.910951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-09-24T02:56:10.869986Z","caller":"traceutil/trace.go:171","msg":"trace[418380843] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:27447; }","duration":"110.097625ms","start":"2026-09-24T02:56:10.759864Z","end":"2026-09-24T02:56:10.869962Z","steps":["trace[418380843] 'agreement among raft nodes before linearized reading' (duration: 109.898901ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:56:11.71979Z","caller":"traceutil/trace.go:171","msg":"trace[852376552] transaction","detail":"{read_only:false; response_revision:27451; number_of_response:1; }","duration":"182.122808ms","start":"2026-09-24T02:56:11.537627Z","end":"2026-09-24T02:56:11.71975Z","steps":["trace[852376552] 'process raft request' (duration: 86.555358ms)","trace[852376552] 'compare' (duration: 95.315784ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:56:11.960229Z","caller":"traceutil/trace.go:171","msg":"trace[763263515] transaction","detail":"{read_only:false; response_revision:27453; number_of_response:1; }","duration":"134.842579ms","start":"2026-09-24T02:56:11.825346Z","end":"2026-09-24T02:56:11.960189Z","steps":["trace[763263515] 'process raft request' (duration: 134.521982ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:56:11.960227Z","caller":"traceutil/trace.go:171","msg":"trace[1143169814] transaction","detail":"{read_only:false; response_revision:27454; number_of_response:1; }","duration":"120.939618ms","start":"2026-09-24T02:56:11.839249Z","end":"2026-09-24T02:56:11.960188Z","steps":["trace[1143169814] 'process raft request' (duration: 120.823395ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:56:11.960508Z","caller":"traceutil/trace.go:171","msg":"trace[1459643450] transaction","detail":"{read_only:false; response_revision:27455; number_of_response:1; }","duration":"121.114531ms","start":"2026-09-24T02:56:11.83937Z","end":"2026-09-24T02:56:11.960485Z","steps":["trace[1459643450] 'process raft request' (duration: 120.762604ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:56:11.960671Z","caller":"traceutil/trace.go:171","msg":"trace[251843827] linearizableReadLoop","detail":"{readStateIndex:28358; appliedIndex:28356; }","duration":"133.622462ms","start":"2026-09-24T02:56:11.82702Z","end":"2026-09-24T02:56:11.960642Z","steps":["trace[251843827] 'read index received' (duration: 29.493961ms)","trace[251843827] 'applied index is now lower than readState.Index' (duration: 104.127241ms)"],"step_count":2} {"level":"info","ts":"2026-09-24T02:56:11.960838Z","caller":"traceutil/trace.go:171","msg":"trace[267209558] transaction","detail":"{read_only:false; response_revision:27456; number_of_response:1; }","duration":"121.358637ms","start":"2026-09-24T02:56:11.839443Z","end":"2026-09-24T02:56:11.960802Z","steps":["trace[267209558] 'process raft request' (duration: 120.968159ms)"],"step_count":1} {"level":"warn","ts":"2026-09-24T02:56:11.960875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.837276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-09-24T02:56:11.961162Z","caller":"traceutil/trace.go:171","msg":"trace[832478648] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27456; }","duration":"134.125123ms","start":"2026-09-24T02:56:11.826967Z","end":"2026-09-24T02:56:11.961092Z","steps":["trace[832478648] 'agreement among raft nodes before linearized reading' (duration: 133.774205ms)"],"step_count":1} {"level":"info","ts":"2026-09-24T02:59:01.095445Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f14c7d724df9ef94","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-24T02:59:01.102463Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-09-24T02:59:01.102708Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-09-24T03:00:37.357847Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27192} {"level":"info","ts":"2026-09-24T03:00:37.516855Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27192,"took":"154.752104ms","hash":3973079009,"current-db-size-bytes":61292544,"current-db-size":"61 MB","current-db-size-in-use-bytes":36417536,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-09-24T03:00:37.516929Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3973079009,"revision":27192,"compact-revision":23793} {"level":"info","ts":"2026-09-24T03:05:37.365629Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30124} {"level":"info","ts":"2026-09-24T03:05:37.517438Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30124,"took":"147.747223ms","hash":35940201,"current-db-size-bytes":61292544,"current-db-size":"61 MB","current-db-size-in-use-bytes":32268288,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-24T03:05:37.517499Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":35940201,"revision":30124,"compact-revision":27192} {"level":"info","ts":"2026-09-24T03:10:37.374346Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32427} {"level":"info","ts":"2026-09-24T03:10:37.533993Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32427,"took":"155.129157ms","hash":1810212901,"current-db-size-bytes":62332928,"current-db-size":"62 MB","current-db-size-in-use-bytes":30695424,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-24T03:10:37.534061Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1810212901,"revision":32427,"compact-revision":30124} {"level":"info","ts":"2026-09-24T03:15:37.383183Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34651} {"level":"info","ts":"2026-09-24T03:15:37.512641Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34651,"took":"125.493504ms","hash":587673484,"current-db-size-bytes":62332928,"current-db-size":"62 MB","current-db-size-in-use-bytes":30556160,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-09-24T03:15:37.512707Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":587673484,"revision":34651,"compact-revision":32427} {"level":"info","ts":"2026-09-24T03:19:43.847616Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"f14c7d724df9ef94","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-09-24T03:19:43.857325Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-09-24T03:19:43.857458Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-09-24T03:20:37.394836Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":36879} {"level":"info","ts":"2026-09-24T03:20:37.535594Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":36879,"took":"135.264725ms","hash":370454887,"current-db-size-bytes":62332928,"current-db-size":"62 MB","current-db-size-in-use-bytes":32776192,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-09-24T03:20:37.535653Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":370454887,"revision":36879,"compact-revision":34651} {"level":"info","ts":"2026-09-24T03:25:37.402509Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39212} {"level":"info","ts":"2026-09-24T03:25:37.541773Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39212,"took":"134.98622ms","hash":990046094,"current-db-size-bytes":63598592,"current-db-size":"64 MB","current-db-size-in-use-bytes":32051200,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-09-24T03:25:37.541821Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":990046094,"revision":39212,"compact-revision":36879}