{"level":"warn","ts":"2026-08-30T01:18:37.414798Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-30T01:18:37.414947Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.148: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.148:2380","--initial-cluster=instance=https://162.253.55.148:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.148:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.148: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-08-30T01:18:37.415092Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-30T01:18:37.415126Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.148:2380"]} {"level":"info","ts":"2026-08-30T01:18:37.415171Z","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-08-30T01:18:37.416432Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.148:2379"]} {"level":"info","ts":"2026-08-30T01:18:37.416597Z","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.148:2380"],"listen-peer-urls":["https://162.253.55.148:2380"],"advertise-client-urls":["https://162.253.55.148:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.148:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.148: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-08-30T01:18:37.419875Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.824652ms"} {"level":"info","ts":"2026-08-30T01:18:37.426113Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a6342599e225e01b","cluster-id":"8ad3da7aa894cc05"} {"level":"info","ts":"2026-08-30T01:18:37.426223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b switched to configuration voters=()"} {"level":"info","ts":"2026-08-30T01:18:37.426255Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became follower at term 0"} {"level":"info","ts":"2026-08-30T01:18:37.42627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a6342599e225e01b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-30T01:18:37.426286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became follower at term 1"} {"level":"info","ts":"2026-08-30T01:18:37.426334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b switched to configuration voters=(11976238651939348507)"} {"level":"warn","ts":"2026-08-30T01:18:37.432371Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-30T01:18:37.434879Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-30T01:18:37.436643Z","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-08-30T01:18:37.440195Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a6342599e225e01b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-30T01:18:37.440428Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a6342599e225e01b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-30T01:18:37.440741Z","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-08-30T01:18:37.440868Z","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-08-30T01:18:37.440885Z","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-08-30T01:18:37.444144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b switched to configuration voters=(11976238651939348507)"} {"level":"info","ts":"2026-08-30T01:18:37.445078Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8ad3da7aa894cc05","local-member-id":"a6342599e225e01b","added-peer-id":"a6342599e225e01b","added-peer-peer-urls":["https://162.253.55.148:2380"]} {"level":"info","ts":"2026-08-30T01:18:37.446988Z","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-08-30T01:18:37.447321Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.148:2380"} {"level":"info","ts":"2026-08-30T01:18:37.447395Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a6342599e225e01b","initial-advertise-peer-urls":["https://162.253.55.148:2380"],"listen-peer-urls":["https://162.253.55.148:2380"],"advertise-client-urls":["https://162.253.55.148:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.148:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-30T01:18:37.447452Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.148:2380"} {"level":"info","ts":"2026-08-30T01:18:37.447461Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-30T01:18:37.827126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b is starting a new election at term 1"} {"level":"info","ts":"2026-08-30T01:18:37.827176Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became pre-candidate at term 1"} {"level":"info","ts":"2026-08-30T01:18:37.827214Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b received MsgPreVoteResp from a6342599e225e01b at term 1"} {"level":"info","ts":"2026-08-30T01:18:37.827233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became candidate at term 2"} {"level":"info","ts":"2026-08-30T01:18:37.827243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b received MsgVoteResp from a6342599e225e01b at term 2"} {"level":"info","ts":"2026-08-30T01:18:37.827261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a6342599e225e01b became leader at term 2"} {"level":"info","ts":"2026-08-30T01:18:37.827275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a6342599e225e01b elected leader a6342599e225e01b at term 2"} {"level":"info","ts":"2026-08-30T01:18:37.829124Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a6342599e225e01b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.148:2379]}","request-path":"/0/members/a6342599e225e01b/attributes","cluster-id":"8ad3da7aa894cc05","publish-timeout":"7s"} {"level":"info","ts":"2026-08-30T01:18:37.829305Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-30T01:18:37.829313Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-30T01:18:37.829562Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-30T01:18:37.829526Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-30T01:18:37.829613Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-30T01:18:37.830965Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8ad3da7aa894cc05","local-member-id":"a6342599e225e01b","cluster-version":"3.5"} {"level":"info","ts":"2026-08-30T01:18:37.831014Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.148:2379"} {"level":"info","ts":"2026-08-30T01:18:37.831097Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-30T01:18:37.83123Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-30T01:18:37.832124Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-30T01:18:49.289078Z","caller":"traceutil/trace.go:171","msg":"trace[759407363] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"127.697459ms","start":"2026-08-30T01:18:49.161359Z","end":"2026-08-30T01:18:49.289056Z","steps":["trace[759407363] 'process raft request' (duration: 127.567576ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:18:49.566429Z","caller":"traceutil/trace.go:171","msg":"trace[36942482] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"265.4655ms","start":"2026-08-30T01:18:49.300936Z","end":"2026-08-30T01:18:49.566402Z","steps":["trace[36942482] 'process raft request' (duration: 265.238285ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:19:22.015964Z","caller":"traceutil/trace.go:171","msg":"trace[600272370] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"220.412599ms","start":"2026-08-30T01:19:21.795505Z","end":"2026-08-30T01:19:22.015918Z","steps":["trace[600272370] 'process raft request' (duration: 165.079009ms)","trace[600272370] 'compare' (duration: 54.725727ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T01:20:09.253081Z","caller":"traceutil/trace.go:171","msg":"trace[1610957672] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"160.923109ms","start":"2026-08-30T01:20:09.092111Z","end":"2026-08-30T01:20:09.253034Z","steps":["trace[1610957672] 'process raft request' (duration: 160.558592ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:20:59.382202Z","caller":"traceutil/trace.go:171","msg":"trace[524464330] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"193.811715ms","start":"2026-08-30T01:20:59.188359Z","end":"2026-08-30T01:20:59.38217Z","steps":["trace[524464330] 'process raft request' (duration: 186.851805ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:20:59.674062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.261682ms","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-08-30T01:20:59.674589Z","caller":"traceutil/trace.go:171","msg":"trace[1269527487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1854; }","duration":"149.886675ms","start":"2026-08-30T01:20:59.524671Z","end":"2026-08-30T01:20:59.674557Z","steps":["trace[1269527487] 'range keys from in-memory index tree' (duration: 148.981485ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:21:14.579075Z","caller":"traceutil/trace.go:171","msg":"trace[1803819684] transaction","detail":"{read_only:false; response_revision:1988; number_of_response:1; }","duration":"152.766607ms","start":"2026-08-30T01:21:14.426286Z","end":"2026-08-30T01:21:14.579053Z","steps":["trace[1803819684] 'process raft request' (duration: 152.612664ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:21:55.119729Z","caller":"traceutil/trace.go:171","msg":"trace[356621615] linearizableReadLoop","detail":"{readStateIndex:2303; appliedIndex:2302; }","duration":"263.239307ms","start":"2026-08-30T01:21:54.85646Z","end":"2026-08-30T01:21:55.119699Z","steps":["trace[356621615] 'read index received' (duration: 199.251578ms)","trace[356621615] 'applied index is now lower than readState.Index' (duration: 63.986469ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T01:21:55.119816Z","caller":"traceutil/trace.go:171","msg":"trace[264553004] transaction","detail":"{read_only:false; response_revision:2214; number_of_response:1; }","duration":"285.924293ms","start":"2026-08-30T01:21:54.833854Z","end":"2026-08-30T01:21:55.119778Z","steps":["trace[264553004] 'process raft request' (duration: 221.901233ms)","trace[264553004] 'compare' (duration: 63.760384ms)"],"step_count":2} {"level":"warn","ts":"2026-08-30T01:21:55.12074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.245509ms","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-08-30T01:21:55.12084Z","caller":"traceutil/trace.go:171","msg":"trace[470914242] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2214; }","duration":"264.442163ms","start":"2026-08-30T01:21:54.856375Z","end":"2026-08-30T01:21:55.120818Z","steps":["trace[470914242] 'agreement among raft nodes before linearized reading' (duration: 263.579294ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:26:46.572693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.439577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-08-30T01:26:46.572778Z","caller":"traceutil/trace.go:171","msg":"trace[517261426] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4152; }","duration":"108.59269ms","start":"2026-08-30T01:26:46.464169Z","end":"2026-08-30T01:26:46.572762Z","steps":["trace[517261426] 'range keys from in-memory index tree' (duration: 108.249273ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:28:37.938079Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2960} {"level":"info","ts":"2026-08-30T01:28:38.012497Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2960,"took":"72.872126ms","hash":97490878,"current-db-size-bytes":56090624,"current-db-size":"56 MB","current-db-size-in-use-bytes":30920704,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-30T01:28:38.012567Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":97490878,"revision":2960,"compact-revision":-1} {"level":"info","ts":"2026-08-30T01:28:43.64551Z","caller":"traceutil/trace.go:171","msg":"trace[152515959] transaction","detail":"{read_only:false; response_revision:5688; number_of_response:1; }","duration":"125.61609ms","start":"2026-08-30T01:28:43.519855Z","end":"2026-08-30T01:28:43.645471Z","steps":["trace[152515959] 'process raft request' (duration: 118.445046ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:28:43.645799Z","caller":"traceutil/trace.go:171","msg":"trace[797261435] transaction","detail":"{read_only:false; response_revision:5690; number_of_response:1; }","duration":"124.872774ms","start":"2026-08-30T01:28:43.520897Z","end":"2026-08-30T01:28:43.64577Z","steps":["trace[797261435] 'process raft request' (duration: 124.69009ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:28:43.645822Z","caller":"traceutil/trace.go:171","msg":"trace[441938744] transaction","detail":"{read_only:false; response_revision:5691; number_of_response:1; }","duration":"124.513366ms","start":"2026-08-30T01:28:43.521301Z","end":"2026-08-30T01:28:43.645815Z","steps":["trace[441938744] 'process raft request' (duration: 124.332862ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:28:43.645937Z","caller":"traceutil/trace.go:171","msg":"trace[629165782] transaction","detail":"{read_only:false; response_revision:5693; number_of_response:1; }","duration":"123.246509ms","start":"2026-08-30T01:28:43.522679Z","end":"2026-08-30T01:28:43.645926Z","steps":["trace[629165782] 'process raft request' (duration: 123.051485ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:28:43.645934Z","caller":"traceutil/trace.go:171","msg":"trace[1182783847] linearizableReadLoop","detail":"{readStateIndex:5909; appliedIndex:5907; }","duration":"125.483347ms","start":"2026-08-30T01:28:43.520417Z","end":"2026-08-30T01:28:43.645901Z","steps":["trace[1182783847] 'read index received' (duration: 79.649772ms)","trace[1182783847] 'applied index is now lower than readState.Index' (duration: 45.832305ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T01:28:43.64606Z","caller":"traceutil/trace.go:171","msg":"trace[1813623998] transaction","detail":"{read_only:false; response_revision:5692; number_of_response:1; }","duration":"124.746561ms","start":"2026-08-30T01:28:43.521305Z","end":"2026-08-30T01:28:43.646051Z","steps":["trace[1813623998] 'process raft request' (duration: 124.372853ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:28:43.645999Z","caller":"traceutil/trace.go:171","msg":"trace[2110148439] transaction","detail":"{read_only:false; response_revision:5689; number_of_response:1; }","duration":"125.123659ms","start":"2026-08-30T01:28:43.520862Z","end":"2026-08-30T01:28:43.645985Z","steps":["trace[2110148439] 'process raft request' (duration: 124.650939ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:28:43.646335Z","caller":"traceutil/trace.go:171","msg":"trace[1355586130] transaction","detail":"{read_only:false; response_revision:5694; number_of_response:1; }","duration":"119.339724ms","start":"2026-08-30T01:28:43.526987Z","end":"2026-08-30T01:28:43.646326Z","steps":["trace[1355586130] 'process raft request' (duration: 118.835214ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:28:43.646516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.08103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-08-30T01:28:43.646535Z","caller":"traceutil/trace.go:171","msg":"trace[683789080] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:5694; }","duration":"126.135922ms","start":"2026-08-30T01:28:43.520393Z","end":"2026-08-30T01:28:43.646529Z","steps":["trace[683789080] 'agreement among raft nodes before linearized reading' (duration: 126.012139ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:28:44.167243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.946668ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-30T01:28:44.167644Z","caller":"traceutil/trace.go:171","msg":"trace[1377638982] linearizableReadLoop","detail":"{readStateIndex:5930; appliedIndex:5928; }","duration":"296.907292ms","start":"2026-08-30T01:28:43.870709Z","end":"2026-08-30T01:28:44.167616Z","steps":["trace[1377638982] 'read index received' (duration: 8.949153ms)","trace[1377638982] 'applied index is now lower than readState.Index' (duration: 287.956439ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T01:28:44.167678Z","caller":"traceutil/trace.go:171","msg":"trace[961949815] transaction","detail":"{read_only:false; response_revision:5707; number_of_response:1; }","duration":"305.007296ms","start":"2026-08-30T01:28:43.862608Z","end":"2026-08-30T01:28:44.167616Z","steps":["trace[961949815] 'process raft request' (duration: 17.029027ms)","trace[961949815] 'compare' (duration: 286.661841ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T01:28:44.16771Z","caller":"traceutil/trace.go:171","msg":"trace[1835725657] transaction","detail":"{read_only:false; number_of_response:1; response_revision:5708; }","duration":"304.595307ms","start":"2026-08-30T01:28:43.863066Z","end":"2026-08-30T01:28:44.167662Z","steps":["trace[1835725657] 'process raft request' (duration: 304.310081ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:28:44.16787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.148117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-08-30T01:28:44.167919Z","caller":"traceutil/trace.go:171","msg":"trace[1068135465] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5708; }","duration":"297.275731ms","start":"2026-08-30T01:28:43.870632Z","end":"2026-08-30T01:28:44.167908Z","steps":["trace[1068135465] 'agreement among raft nodes before linearized reading' (duration: 297.087816ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:28:44.16786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T01:28:43.862594Z","time spent":"305.171329ms","remote":"127.0.0.1:35698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":840,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-30T01:28:44.168206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T01:28:43.863038Z","time spent":"304.75327ms","remote":"127.0.0.1:35722","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":88,"response count":0,"response size":42,"request content":"compare: success: > failure: >"} {"level":"info","ts":"2026-08-30T01:28:44.460118Z","caller":"traceutil/trace.go:171","msg":"trace[1999716730] transaction","detail":"{read_only:false; response_revision:5710; number_of_response:1; }","duration":"508.402759ms","start":"2026-08-30T01:28:43.951654Z","end":"2026-08-30T01:28:44.460057Z","steps":["trace[1999716730] 'process raft request' (duration: 507.97942ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:28:44.460165Z","caller":"traceutil/trace.go:171","msg":"trace[959105572] transaction","detail":"{read_only:false; response_revision:5709; number_of_response:1; }","duration":"564.322071ms","start":"2026-08-30T01:28:43.895813Z","end":"2026-08-30T01:28:44.460135Z","steps":["trace[959105572] 'process raft request' (duration: 554.623802ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:28:44.460376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T01:28:43.895796Z","time spent":"564.450964ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-30T01:28:44.460385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T01:28:43.951621Z","time spent":"508.609194ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-30T01:28:44.460426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.827088ms","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-08-30T01:28:44.46048Z","caller":"traceutil/trace.go:171","msg":"trace[437960266] transaction","detail":"{read_only:false; response_revision:5711; number_of_response:1; }","duration":"505.293191ms","start":"2026-08-30T01:28:43.955146Z","end":"2026-08-30T01:28:44.460439Z","steps":["trace[437960266] 'process raft request' (duration: 504.598137ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:28:44.460534Z","caller":"traceutil/trace.go:171","msg":"trace[2004712534] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5711; }","duration":"461.948861ms","start":"2026-08-30T01:28:43.998559Z","end":"2026-08-30T01:28:44.460508Z","steps":["trace[2004712534] 'agreement among raft nodes before linearized reading' (duration: 461.655785ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:28:44.460586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T01:28:43.998502Z","time spent":"462.073823ms","remote":"127.0.0.1:35884","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-08-30T01:28:44.460659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.062508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-30T01:28:44.460638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.975723ms","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-08-30T01:28:44.46067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T01:28:43.955125Z","time spent":"505.437155ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-30T01:28:44.460709Z","caller":"traceutil/trace.go:171","msg":"trace[298488314] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:5711; }","duration":"499.1413ms","start":"2026-08-30T01:28:43.961556Z","end":"2026-08-30T01:28:44.460697Z","steps":["trace[298488314] 'agreement among raft nodes before linearized reading' (duration: 499.021157ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:28:44.460731Z","caller":"traceutil/trace.go:171","msg":"trace[1231991646] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5711; }","duration":"470.134946ms","start":"2026-08-30T01:28:43.990575Z","end":"2026-08-30T01:28:44.46071Z","steps":["trace[1231991646] 'agreement among raft nodes before linearized reading' (duration: 469.87198ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:28:44.460752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T01:28:43.961544Z","time spent":"499.200661ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":14,"response size":31,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-08-30T01:28:44.460786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T01:28:43.990551Z","time spent":"470.221868ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-30T01:28:44.460826Z","caller":"traceutil/trace.go:171","msg":"trace[1658832338] linearizableReadLoop","detail":"{readStateIndex:5933; appliedIndex:5930; }","duration":"292.11963ms","start":"2026-08-30T01:28:44.167682Z","end":"2026-08-30T01:28:44.459801Z","steps":["trace[1658832338] 'read index received' (duration: 282.778068ms)","trace[1658832338] 'applied index is now lower than readState.Index' (duration: 9.336702ms)"],"step_count":2} {"level":"warn","ts":"2026-08-30T01:28:44.461027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.785033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3684"} {"level":"info","ts":"2026-08-30T01:28:44.461077Z","caller":"traceutil/trace.go:171","msg":"trace[317261461] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5711; }","duration":"565.888254ms","start":"2026-08-30T01:28:43.895174Z","end":"2026-08-30T01:28:44.461062Z","steps":["trace[317261461] 'agreement among raft nodes before linearized reading' (duration: 565.722021ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:28:44.461113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T01:28:43.895148Z","time spent":"565.957626ms","remote":"127.0.0.1:35722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":3708,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" "} {"level":"info","ts":"2026-08-30T01:28:44.465441Z","caller":"traceutil/trace.go:171","msg":"trace[2078381708] transaction","detail":"{read_only:false; response_revision:5712; number_of_response:1; }","duration":"287.312696ms","start":"2026-08-30T01:28:44.178102Z","end":"2026-08-30T01:28:44.465415Z","steps":["trace[2078381708] 'process raft request' (duration: 286.880547ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:28:44.465482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.415938ms","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-08-30T01:28:44.465529Z","caller":"traceutil/trace.go:171","msg":"trace[1838101011] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:5712; }","duration":"294.539471ms","start":"2026-08-30T01:28:44.170976Z","end":"2026-08-30T01:28:44.465516Z","steps":["trace[1838101011] 'agreement among raft nodes before linearized reading' (duration: 294.355488ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:28:44.465804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.926382ms","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-08-30T01:28:44.465846Z","caller":"traceutil/trace.go:171","msg":"trace[1149373960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5712; }","duration":"263.026574ms","start":"2026-08-30T01:28:44.202807Z","end":"2026-08-30T01:28:44.465834Z","steps":["trace[1149373960] 'agreement among raft nodes before linearized reading' (duration: 262.913992ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:28:44.466097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.513037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-08-30T01:28:44.466174Z","caller":"traceutil/trace.go:171","msg":"trace[1096223920] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:5712; }","duration":"292.600429ms","start":"2026-08-30T01:28:44.173549Z","end":"2026-08-30T01:28:44.466149Z","steps":["trace[1096223920] 'agreement among raft nodes before linearized reading' (duration: 292.357704ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:28:54.391886Z","caller":"traceutil/trace.go:171","msg":"trace[1794034170] transaction","detail":"{read_only:false; response_revision:5903; number_of_response:1; }","duration":"100.638424ms","start":"2026-08-30T01:28:54.291221Z","end":"2026-08-30T01:28:54.391859Z","steps":["trace[1794034170] 'process raft request' (duration: 100.47846ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:29:48.824978Z","caller":"traceutil/trace.go:171","msg":"trace[1652860207] transaction","detail":"{read_only:false; response_revision:6371; number_of_response:1; }","duration":"110.84527ms","start":"2026-08-30T01:29:48.714107Z","end":"2026-08-30T01:29:48.824953Z","steps":["trace[1652860207] 'process raft request' (duration: 110.752398ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:29:48.825055Z","caller":"traceutil/trace.go:171","msg":"trace[1774835784] transaction","detail":"{read_only:false; response_revision:6370; number_of_response:1; }","duration":"113.15998ms","start":"2026-08-30T01:29:48.711839Z","end":"2026-08-30T01:29:48.824999Z","steps":["trace[1774835784] 'process raft request' (duration: 96.714192ms)","trace[1774835784] 'compare' (duration: 16.155761ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T01:29:48.825446Z","caller":"traceutil/trace.go:171","msg":"trace[2127134675] transaction","detail":"{read_only:false; response_revision:6372; number_of_response:1; }","duration":"105.706538ms","start":"2026-08-30T01:29:48.719696Z","end":"2026-08-30T01:29:48.825403Z","steps":["trace[2127134675] 'process raft request' (duration: 105.216368ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:33:37.945908Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5596} {"level":"info","ts":"2026-08-30T01:33:38.041099Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5596,"took":"93.00283ms","hash":552013699,"current-db-size-bytes":56090624,"current-db-size":"56 MB","current-db-size-in-use-bytes":28348416,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-30T01:33:38.041176Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":552013699,"revision":5596,"compact-revision":2960} {"level":"info","ts":"2026-08-30T01:35:20.742161Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002389.wal"} {"level":"info","ts":"2026-08-30T01:35:26.182463Z","caller":"traceutil/trace.go:171","msg":"trace[964663412] transaction","detail":"{read_only:false; response_revision:8811; number_of_response:1; }","duration":"169.835554ms","start":"2026-08-30T01:35:26.012597Z","end":"2026-08-30T01:35:26.182433Z","steps":["trace[964663412] 'process raft request' (duration: 169.62798ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:35:36.677711Z","caller":"traceutil/trace.go:171","msg":"trace[948681100] linearizableReadLoop","detail":"{readStateIndex:9191; appliedIndex:9190; }","duration":"222.964662ms","start":"2026-08-30T01:35:36.454723Z","end":"2026-08-30T01:35:36.677688Z","steps":["trace[948681100] 'read index received' (duration: 159.230927ms)","trace[948681100] 'applied index is now lower than readState.Index' (duration: 63.730385ms)"],"step_count":2} {"level":"warn","ts":"2026-08-30T01:35:36.677906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.171646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-sf9dc\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-08-30T01:35:36.677923Z","caller":"traceutil/trace.go:171","msg":"trace[924654991] range","detail":"{range_begin:/registry/pods/openstack/keepalived-sf9dc; range_end:; response_count:1; response_revision:8870; }","duration":"223.246608ms","start":"2026-08-30T01:35:36.454671Z","end":"2026-08-30T01:35:36.677918Z","steps":["trace[924654991] 'agreement among raft nodes before linearized reading' (duration: 223.105995ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:35:36.678123Z","caller":"traceutil/trace.go:171","msg":"trace[374014558] transaction","detail":"{read_only:false; response_revision:8870; number_of_response:1; }","duration":"294.728752ms","start":"2026-08-30T01:35:36.383388Z","end":"2026-08-30T01:35:36.678116Z","steps":["trace[374014558] 'process raft request' (duration: 230.525756ms)","trace[374014558] 'compare' (duration: 63.660334ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T01:36:14.670945Z","caller":"traceutil/trace.go:171","msg":"trace[536499177] transaction","detail":"{read_only:false; response_revision:9123; number_of_response:1; }","duration":"187.048808ms","start":"2026-08-30T01:36:14.483872Z","end":"2026-08-30T01:36:14.67092Z","steps":["trace[536499177] 'process raft request' (duration: 186.867484ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:36:14.671778Z","caller":"traceutil/trace.go:171","msg":"trace[675128591] transaction","detail":"{read_only:false; response_revision:9124; number_of_response:1; }","duration":"185.31656ms","start":"2026-08-30T01:36:14.486434Z","end":"2026-08-30T01:36:14.671751Z","steps":["trace[675128591] 'process raft request' (duration: 185.164517ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:36:14.671994Z","caller":"traceutil/trace.go:171","msg":"trace[991390986] linearizableReadLoop","detail":"{readStateIndex:9457; appliedIndex:9454; }","duration":"131.158391ms","start":"2026-08-30T01:36:14.540812Z","end":"2026-08-30T01:36:14.67197Z","steps":["trace[991390986] 'read index received' (duration: 129.953775ms)","trace[991390986] 'applied index is now lower than readState.Index' (duration: 1.202886ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T01:36:14.672085Z","caller":"traceutil/trace.go:171","msg":"trace[1358067419] transaction","detail":"{read_only:false; response_revision:9125; number_of_response:1; }","duration":"157.364326ms","start":"2026-08-30T01:36:14.514667Z","end":"2026-08-30T01:36:14.672032Z","steps":["trace[1358067419] 'process raft request' (duration: 157.044319ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:36:14.6722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.374466ms","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-08-30T01:36:14.672255Z","caller":"traceutil/trace.go:171","msg":"trace[523547821] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9125; }","duration":"131.489148ms","start":"2026-08-30T01:36:14.540752Z","end":"2026-08-30T01:36:14.672241Z","steps":["trace[523547821] 'agreement among raft nodes before linearized reading' (duration: 131.291753ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:36:18.155792Z","caller":"traceutil/trace.go:171","msg":"trace[1113638706] linearizableReadLoop","detail":"{readStateIndex:9476; appliedIndex:9475; }","duration":"153.866471ms","start":"2026-08-30T01:36:18.001905Z","end":"2026-08-30T01:36:18.155771Z","steps":["trace[1113638706] 'read index received' (duration: 153.413571ms)","trace[1113638706] 'applied index is now lower than readState.Index' (duration: 451.75µs)"],"step_count":2} {"level":"info","ts":"2026-08-30T01:36:18.156502Z","caller":"traceutil/trace.go:171","msg":"trace[1466633686] transaction","detail":"{read_only:false; response_revision:9143; number_of_response:1; }","duration":"189.876958ms","start":"2026-08-30T01:36:17.966611Z","end":"2026-08-30T01:36:18.156488Z","steps":["trace[1466633686] 'process raft request' (duration: 188.803055ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:36:18.156751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.841142ms","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-08-30T01:36:18.156794Z","caller":"traceutil/trace.go:171","msg":"trace[1518819383] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9143; }","duration":"154.936844ms","start":"2026-08-30T01:36:18.001845Z","end":"2026-08-30T01:36:18.156782Z","steps":["trace[1518819383] 'agreement among raft nodes before linearized reading' (duration: 154.804052ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:36:18.157022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.695993ms","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-08-30T01:36:18.157126Z","caller":"traceutil/trace.go:171","msg":"trace[97675365] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:9143; }","duration":"125.886987ms","start":"2026-08-30T01:36:18.031217Z","end":"2026-08-30T01:36:18.157104Z","steps":["trace[97675365] 'agreement among raft nodes before linearized reading' (duration: 125.703763ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:36:27.934551Z","caller":"traceutil/trace.go:171","msg":"trace[702614152] transaction","detail":"{read_only:false; response_revision:9237; number_of_response:1; }","duration":"129.398753ms","start":"2026-08-30T01:36:27.805114Z","end":"2026-08-30T01:36:27.934513Z","steps":["trace[702614152] 'process raft request' (duration: 129.148278ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:36:28.601426Z","caller":"traceutil/trace.go:171","msg":"trace[990374055] transaction","detail":"{read_only:false; response_revision:9239; number_of_response:1; }","duration":"270.154341ms","start":"2026-08-30T01:36:28.331246Z","end":"2026-08-30T01:36:28.601401Z","steps":["trace[990374055] 'process raft request' (duration: 269.956226ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:37:14.504052Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a6342599e225e01b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-30T01:37:14.512072Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-30T01:37:14.512231Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-30T01:38:37.954102Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7967} {"level":"info","ts":"2026-08-30T01:38:38.049186Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7967,"took":"87.946866ms","hash":3397503525,"current-db-size-bytes":56090624,"current-db-size":"56 MB","current-db-size-in-use-bytes":25346048,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-08-30T01:38:38.049294Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3397503525,"revision":7967,"compact-revision":5596} {"level":"info","ts":"2026-08-30T01:43:29.341885Z","caller":"traceutil/trace.go:171","msg":"trace[1353530059] linearizableReadLoop","detail":"{readStateIndex:12895; appliedIndex:12894; }","duration":"110.807036ms","start":"2026-08-30T01:43:29.231049Z","end":"2026-08-30T01:43:29.341856Z","steps":["trace[1353530059] 'read index received' (duration: 110.486478ms)","trace[1353530059] 'applied index is now lower than readState.Index' (duration: 319.318µs)"],"step_count":2} {"level":"info","ts":"2026-08-30T01:43:29.342032Z","caller":"traceutil/trace.go:171","msg":"trace[705309425] transaction","detail":"{read_only:false; response_revision:12456; number_of_response:1; }","duration":"139.542872ms","start":"2026-08-30T01:43:29.202441Z","end":"2026-08-30T01:43:29.341984Z","steps":["trace[705309425] 'process raft request' (duration: 139.225604ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:43:29.342167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.089262ms","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-08-30T01:43:29.342213Z","caller":"traceutil/trace.go:171","msg":"trace[1205289634] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:12456; }","duration":"111.216114ms","start":"2026-08-30T01:43:29.230985Z","end":"2026-08-30T01:43:29.342201Z","steps":["trace[1205289634] 'agreement among raft nodes before linearized reading' (duration: 111.01946ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:43:29.469698Z","caller":"traceutil/trace.go:171","msg":"trace[698613742] transaction","detail":"{read_only:false; response_revision:12457; number_of_response:1; }","duration":"122.623789ms","start":"2026-08-30T01:43:29.347012Z","end":"2026-08-30T01:43:29.469636Z","steps":["trace[698613742] 'process raft request' (duration: 103.240663ms)","trace[698613742] 'compare' (duration: 18.857775ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T01:43:29.469792Z","caller":"traceutil/trace.go:171","msg":"trace[1372418425] transaction","detail":"{read_only:false; response_revision:12458; number_of_response:1; }","duration":"122.150978ms","start":"2026-08-30T01:43:29.3476Z","end":"2026-08-30T01:43:29.469751Z","steps":["trace[1372418425] 'process raft request' (duration: 121.915373ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:43:37.962344Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10365} {"level":"info","ts":"2026-08-30T01:43:38.047497Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10365,"took":"82.11947ms","hash":2306784416,"current-db-size-bytes":56090624,"current-db-size":"56 MB","current-db-size-in-use-bytes":25772032,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-08-30T01:43:38.04758Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2306784416,"revision":10365,"compact-revision":7967} {"level":"info","ts":"2026-08-30T01:48:37.972074Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12528} {"level":"info","ts":"2026-08-30T01:48:38.055142Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12528,"took":"79.997498ms","hash":2901748391,"current-db-size-bytes":56090624,"current-db-size":"56 MB","current-db-size-in-use-bytes":27824128,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-30T01:48:38.05523Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2901748391,"revision":12528,"compact-revision":10365} {"level":"info","ts":"2026-08-30T01:50:24.120635Z","caller":"traceutil/trace.go:171","msg":"trace[2060516524] transaction","detail":"{read_only:false; response_revision:15200; number_of_response:1; }","duration":"189.03385ms","start":"2026-08-30T01:50:23.931569Z","end":"2026-08-30T01:50:24.120602Z","steps":["trace[2060516524] 'process raft request' (duration: 188.842006ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:50:24.280443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.693732ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-30T01:50:24.280625Z","caller":"traceutil/trace.go:171","msg":"trace[1182768248] linearizableReadLoop","detail":"{readStateIndex:15739; appliedIndex:15738; }","duration":"138.495095ms","start":"2026-08-30T01:50:24.142102Z","end":"2026-08-30T01:50:24.280597Z","steps":["trace[1182768248] 'read index received' (duration: 31.426175ms)","trace[1182768248] 'applied index is now lower than readState.Index' (duration: 107.06686ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T01:50:24.280669Z","caller":"traceutil/trace.go:171","msg":"trace[49556694] transaction","detail":"{read_only:false; response_revision:15201; number_of_response:1; }","duration":"346.460553ms","start":"2026-08-30T01:50:23.934162Z","end":"2026-08-30T01:50:24.280622Z","steps":["trace[49556694] 'process raft request' (duration: 239.479095ms)","trace[49556694] 'compare' (duration: 106.536039ms)"],"step_count":2} {"level":"warn","ts":"2026-08-30T01:50:24.280752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.633849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-30T01:50:24.280797Z","caller":"traceutil/trace.go:171","msg":"trace[1450080106] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:15201; }","duration":"138.7157ms","start":"2026-08-30T01:50:24.142063Z","end":"2026-08-30T01:50:24.280779Z","steps":["trace[1450080106] 'agreement among raft nodes before linearized reading' (duration: 138.628598ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:50:24.28083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T01:50:23.934143Z","time spent":"346.598427ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-30T01:50:24.296286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.97245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-sf9dc\" ","response":"range_response_count:1 size:6531"} {"level":"warn","ts":"2026-08-30T01:50:24.296288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.892721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-g77gs\" ","response":"range_response_count:1 size:12364"} {"level":"info","ts":"2026-08-30T01:50:24.296364Z","caller":"traceutil/trace.go:171","msg":"trace[771410612] range","detail":"{range_begin:/registry/pods/openstack/keepalived-sf9dc; range_end:; response_count:1; response_revision:15205; }","duration":"136.120464ms","start":"2026-08-30T01:50:24.160224Z","end":"2026-08-30T01:50:24.296345Z","steps":["trace[771410612] 'agreement among raft nodes before linearized reading' (duration: 135.879029ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:50:24.296404Z","caller":"traceutil/trace.go:171","msg":"trace[3552291] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-g77gs; range_end:; response_count:1; response_revision:15205; }","duration":"137.074695ms","start":"2026-08-30T01:50:24.159304Z","end":"2026-08-30T01:50:24.296379Z","steps":["trace[3552291] 'agreement among raft nodes before linearized reading' (duration: 136.767598ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:51:42.711928Z","caller":"traceutil/trace.go:171","msg":"trace[1445333390] transaction","detail":"{read_only:false; response_revision:16161; number_of_response:1; }","duration":"112.789703ms","start":"2026-08-30T01:51:42.59911Z","end":"2026-08-30T01:51:42.7119Z","steps":["trace[1445333390] 'process raft request' (duration: 112.598999ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:51:42.712288Z","caller":"traceutil/trace.go:171","msg":"trace[1826680242] transaction","detail":"{read_only:false; response_revision:16162; number_of_response:1; }","duration":"106.99525ms","start":"2026-08-30T01:51:42.60526Z","end":"2026-08-30T01:51:42.712255Z","steps":["trace[1826680242] 'process raft request' (duration: 106.593991ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:52:15.706005Z","caller":"traceutil/trace.go:171","msg":"trace[1887796538] transaction","detail":"{read_only:false; response_revision:16336; number_of_response:1; }","duration":"112.310143ms","start":"2026-08-30T01:52:15.593666Z","end":"2026-08-30T01:52:15.705977Z","steps":["trace[1887796538] 'process raft request' (duration: 112.124049ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:53:37.980078Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14561} {"level":"info","ts":"2026-08-30T01:53:38.067027Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14561,"took":"83.499719ms","hash":633198209,"current-db-size-bytes":56090624,"current-db-size":"56 MB","current-db-size-in-use-bytes":30801920,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-30T01:53:38.06711Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":633198209,"revision":14561,"compact-revision":12528} {"level":"info","ts":"2026-08-30T01:58:37.989201Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16863} {"level":"info","ts":"2026-08-30T01:58:38.093061Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16863,"took":"100.153871ms","hash":3813350199,"current-db-size-bytes":56090624,"current-db-size":"56 MB","current-db-size-in-use-bytes":31633408,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-30T01:58:38.093139Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3813350199,"revision":16863,"compact-revision":14561} {"level":"info","ts":"2026-08-30T01:58:53.738872Z","caller":"traceutil/trace.go:171","msg":"trace[45650686] transaction","detail":"{read_only:false; response_revision:19185; number_of_response:1; }","duration":"105.7184ms","start":"2026-08-30T01:58:53.633124Z","end":"2026-08-30T01:58:53.738843Z","steps":["trace[45650686] 'process raft request' (duration: 105.102857ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:58:54.221636Z","caller":"traceutil/trace.go:171","msg":"trace[323378332] transaction","detail":"{read_only:false; response_revision:19186; number_of_response:1; }","duration":"204.360108ms","start":"2026-08-30T01:58:54.017245Z","end":"2026-08-30T01:58:54.221605Z","steps":["trace[323378332] 'process raft request' (duration: 204.207284ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:59:02.397178Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a6342599e225e01b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-30T01:59:02.468415Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-30T01:59:02.469105Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-30T01:59:02.611581Z","caller":"traceutil/trace.go:171","msg":"trace[1320325618] transaction","detail":"{read_only:false; response_revision:19335; number_of_response:1; }","duration":"128.941739ms","start":"2026-08-30T01:59:02.482613Z","end":"2026-08-30T01:59:02.611554Z","steps":["trace[1320325618] 'process raft request' (duration: 128.843297ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:59:02.611627Z","caller":"traceutil/trace.go:171","msg":"trace[1852956536] transaction","detail":"{read_only:false; response_revision:19334; number_of_response:1; }","duration":"132.836571ms","start":"2026-08-30T01:59:02.478761Z","end":"2026-08-30T01:59:02.611598Z","steps":["trace[1852956536] 'process raft request' (duration: 132.558276ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:59:02.611883Z","caller":"traceutil/trace.go:171","msg":"trace[587282985] transaction","detail":"{read_only:false; response_revision:19333; number_of_response:1; }","duration":"133.24239ms","start":"2026-08-30T01:59:02.478397Z","end":"2026-08-30T01:59:02.61164Z","steps":["trace[587282985] 'process raft request' (duration: 90.599935ms)","trace[587282985] 'compare' (duration: 42.093234ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T01:59:02.612226Z","caller":"traceutil/trace.go:171","msg":"trace[1171332356] transaction","detail":"{read_only:false; response_revision:19336; number_of_response:1; }","duration":"127.793143ms","start":"2026-08-30T01:59:02.484419Z","end":"2026-08-30T01:59:02.612212Z","steps":["trace[1171332356] 'process raft request' (duration: 127.074108ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:59:02.7663Z","caller":"traceutil/trace.go:171","msg":"trace[1719898301] linearizableReadLoop","detail":"{readStateIndex:20013; appliedIndex:20011; }","duration":"147.548067ms","start":"2026-08-30T01:59:02.618722Z","end":"2026-08-30T01:59:02.76627Z","steps":["trace[1719898301] 'read index received' (duration: 49.100734ms)","trace[1719898301] 'applied index is now lower than readState.Index' (duration: 98.445873ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T01:59:02.766603Z","caller":"traceutil/trace.go:171","msg":"trace[1638582013] transaction","detail":"{read_only:false; response_revision:19339; number_of_response:1; }","duration":"148.483389ms","start":"2026-08-30T01:59:02.618089Z","end":"2026-08-30T01:59:02.766572Z","steps":["trace[1638582013] 'process raft request' (duration: 99.888154ms)","trace[1638582013] 'compare' (duration: 47.844088ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T01:59:02.766676Z","caller":"traceutil/trace.go:171","msg":"trace[1299958369] transaction","detail":"{read_only:false; response_revision:19341; number_of_response:1; }","duration":"120.109629ms","start":"2026-08-30T01:59:02.64656Z","end":"2026-08-30T01:59:02.76667Z","steps":["trace[1299958369] 'process raft request' (duration: 119.656488ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:59:02.766702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.961437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/openstack/libvirt-libvirt-default-dwxzq-vnc\" ","response":"range_response_count:1 size:2049"} {"level":"info","ts":"2026-08-30T01:59:02.768462Z","caller":"traceutil/trace.go:171","msg":"trace[1241627389] range","detail":"{range_begin:/registry/cert-manager.io/certificates/openstack/libvirt-libvirt-default-dwxzq-vnc; range_end:; response_count:1; response_revision:19341; }","duration":"149.754555ms","start":"2026-08-30T01:59:02.618684Z","end":"2026-08-30T01:59:02.768439Z","steps":["trace[1241627389] 'agreement among raft nodes before linearized reading' (duration: 147.876336ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T01:59:02.767231Z","caller":"traceutil/trace.go:171","msg":"trace[484269717] transaction","detail":"{read_only:false; response_revision:19340; number_of_response:1; }","duration":"146.182899ms","start":"2026-08-30T01:59:02.621018Z","end":"2026-08-30T01:59:02.767201Z","steps":["trace[484269717] 'process raft request' (duration: 145.094005ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T01:59:02.767718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.694063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1125"} {"level":"info","ts":"2026-08-30T01:59:02.769272Z","caller":"traceutil/trace.go:171","msg":"trace[405385547] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:19341; }","duration":"150.289116ms","start":"2026-08-30T01:59:02.618961Z","end":"2026-08-30T01:59:02.76925Z","steps":["trace[405385547] 'agreement among raft nodes before linearized reading' (duration: 148.509179ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:03:37.998074Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19065} {"level":"info","ts":"2026-08-30T02:03:38.100149Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19065,"took":"96.368857ms","hash":3770392235,"current-db-size-bytes":56090624,"current-db-size":"56 MB","current-db-size-in-use-bytes":33828864,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-30T02:03:38.100205Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3770392235,"revision":19065,"compact-revision":16863} {"level":"info","ts":"2026-08-30T02:05:03.552797Z","caller":"traceutil/trace.go:171","msg":"trace[1744906410] transaction","detail":"{read_only:false; response_revision:22102; number_of_response:1; }","duration":"152.48679ms","start":"2026-08-30T02:05:03.400277Z","end":"2026-08-30T02:05:03.552764Z","steps":["trace[1744906410] 'process raft request' (duration: 152.262996ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:05:04.098136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.924318ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-30T02:05:04.098722Z","caller":"traceutil/trace.go:171","msg":"trace[1151673078] linearizableReadLoop","detail":"{readStateIndex:22867; appliedIndex:22865; }","duration":"349.601778ms","start":"2026-08-30T02:05:03.749092Z","end":"2026-08-30T02:05:04.098694Z","steps":["trace[1151673078] 'read index received' (duration: 93.004365ms)","trace[1151673078] 'applied index is now lower than readState.Index' (duration: 256.596383ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:05:04.098881Z","caller":"traceutil/trace.go:171","msg":"trace[1684987563] transaction","detail":"{read_only:false; response_revision:22104; number_of_response:1; }","duration":"399.778933ms","start":"2026-08-30T02:05:03.699089Z","end":"2026-08-30T02:05:04.098868Z","steps":["trace[1684987563] 'process raft request' (duration: 399.456246ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:05:04.098847Z","caller":"traceutil/trace.go:171","msg":"trace[925939491] transaction","detail":"{read_only:false; response_revision:22103; number_of_response:1; }","duration":"695.474834ms","start":"2026-08-30T02:05:03.403302Z","end":"2026-08-30T02:05:04.098777Z","steps":["trace[925939491] 'process raft request' (duration: 438.769889ms)","trace[925939491] 'compare' (duration: 255.814326ms)"],"step_count":2} {"level":"warn","ts":"2026-08-30T02:05:04.099184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.066307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:05:04.099234Z","caller":"traceutil/trace.go:171","msg":"trace[449615048] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22104; }","duration":"350.19609ms","start":"2026-08-30T02:05:03.749022Z","end":"2026-08-30T02:05:04.099218Z","steps":["trace[449615048] 'agreement among raft nodes before linearized reading' (duration: 350.023256ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:05:04.099273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:05:03.748992Z","time spent":"350.271572ms","remote":"127.0.0.1:35640","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-08-30T02:05:04.099256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.245402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-08-30T02:05:04.099152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:05:03.699057Z","time spent":"399.947907ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-30T02:05:04.099376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.901433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11789"} {"level":"warn","ts":"2026-08-30T02:05:04.099405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:05:03.403275Z","time spent":"695.905674ms","remote":"127.0.0.1:35884","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-08-30T02:05:04.099465Z","caller":"traceutil/trace.go:171","msg":"trace[942208574] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:22104; }","duration":"246.116527ms","start":"2026-08-30T02:05:03.853324Z","end":"2026-08-30T02:05:04.09944Z","steps":["trace[942208574] 'agreement among raft nodes before linearized reading' (duration: 245.737359ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:05:04.099338Z","caller":"traceutil/trace.go:171","msg":"trace[995109451] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:22104; }","duration":"344.394926ms","start":"2026-08-30T02:05:03.754922Z","end":"2026-08-30T02:05:04.099317Z","steps":["trace[995109451] 'agreement among raft nodes before linearized reading' (duration: 344.1408ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:05:04.099624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:05:03.754908Z","time spent":"344.673251ms","remote":"127.0.0.1:54478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":32,"request content":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true "} {"level":"warn","ts":"2026-08-30T02:05:04.100523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.449291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-08-30T02:05:04.100619Z","caller":"traceutil/trace.go:171","msg":"trace[1365318903] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:22104; }","duration":"257.617535ms","start":"2026-08-30T02:05:03.84298Z","end":"2026-08-30T02:05:04.100597Z","steps":["trace[1365318903] 'agreement among raft nodes before linearized reading' (duration: 256.086052ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:05:04.636759Z","caller":"traceutil/trace.go:171","msg":"trace[611300776] transaction","detail":"{read_only:false; response_revision:22105; number_of_response:1; }","duration":"427.526009ms","start":"2026-08-30T02:05:04.209199Z","end":"2026-08-30T02:05:04.636725Z","steps":["trace[611300776] 'process raft request' (duration: 427.286414ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:05:04.637057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:05:04.209167Z","time spent":"427.686911ms","remote":"127.0.0.1:35884","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-08-30T02:05:04.65012Z","caller":"traceutil/trace.go:171","msg":"trace[1696259366] linearizableReadLoop","detail":"{readStateIndex:22871; appliedIndex:22867; }","duration":"366.662882ms","start":"2026-08-30T02:05:04.283427Z","end":"2026-08-30T02:05:04.65009Z","steps":["trace[1696259366] 'read index received' (duration: 353.033941ms)","trace[1696259366] 'applied index is now lower than readState.Index' (duration: 13.627701ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:05:04.650203Z","caller":"traceutil/trace.go:171","msg":"trace[2104953414] transaction","detail":"{read_only:false; response_revision:22106; number_of_response:1; }","duration":"439.121756ms","start":"2026-08-30T02:05:04.211071Z","end":"2026-08-30T02:05:04.650193Z","steps":["trace[2104953414] 'process raft request' (duration: 438.761778ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:05:04.650253Z","caller":"traceutil/trace.go:171","msg":"trace[1830978806] transaction","detail":"{read_only:false; response_revision:22108; number_of_response:1; }","duration":"398.585598ms","start":"2026-08-30T02:05:04.251651Z","end":"2026-08-30T02:05:04.650237Z","steps":["trace[1830978806] 'process raft request' (duration: 398.394133ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:05:04.650151Z","caller":"traceutil/trace.go:171","msg":"trace[312480518] transaction","detail":"{read_only:false; response_revision:22107; number_of_response:1; }","duration":"428.539669ms","start":"2026-08-30T02:05:04.221585Z","end":"2026-08-30T02:05:04.650125Z","steps":["trace[312480518] 'process raft request' (duration: 428.416536ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:05:04.650318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:05:04.211059Z","time spent":"439.214229ms","remote":"127.0.0.1:35884","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-08-30T02:05:04.650455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:05:04.251614Z","time spent":"398.68117ms","remote":"127.0.0.1:35884","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-08-30T02:05:04.650518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:05:04.221544Z","time spent":"428.859637ms","remote":"127.0.0.1:35884","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-08-30T02:05:04.650549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.944616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-08-30T02:05:04.650629Z","caller":"traceutil/trace.go:171","msg":"trace[694632995] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22108; }","duration":"344.080009ms","start":"2026-08-30T02:05:04.306528Z","end":"2026-08-30T02:05:04.650608Z","steps":["trace[694632995] 'agreement among raft nodes before linearized reading' (duration: 343.863384ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:05:04.650593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.109002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-08-30T02:05:04.650671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:05:04.306501Z","time spent":"344.15822ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-30T02:05:04.650714Z","caller":"traceutil/trace.go:171","msg":"trace[1439754092] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:22108; }","duration":"367.379418ms","start":"2026-08-30T02:05:04.283303Z","end":"2026-08-30T02:05:04.650683Z","steps":["trace[1439754092] 'agreement among raft nodes before linearized reading' (duration: 367.122632ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:05:04.650774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:05:04.283266Z","time spent":"367.49738ms","remote":"127.0.0.1:33006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":32,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"info","ts":"2026-08-30T02:05:04.800194Z","caller":"traceutil/trace.go:171","msg":"trace[1295811694] transaction","detail":"{read_only:false; response_revision:22109; number_of_response:1; }","duration":"144.184762ms","start":"2026-08-30T02:05:04.655967Z","end":"2026-08-30T02:05:04.800151Z","steps":["trace[1295811694] 'process raft request' (duration: 77.362178ms)","trace[1295811694] 'compare' (duration: 66.448596ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:08:38.008608Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21494} {"level":"info","ts":"2026-08-30T02:08:38.136519Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21494,"took":"123.498979ms","hash":2303249780,"current-db-size-bytes":56090624,"current-db-size":"56 MB","current-db-size-in-use-bytes":30621696,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-30T02:08:38.136602Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2303249780,"revision":21494,"compact-revision":19065} {"level":"info","ts":"2026-08-30T02:10:30.718212Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006686.wal"} {"level":"info","ts":"2026-08-30T02:13:38.015835Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23706} {"level":"info","ts":"2026-08-30T02:13:38.146834Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23706,"took":"125.962313ms","hash":3427109326,"current-db-size-bytes":56090624,"current-db-size":"56 MB","current-db-size-in-use-bytes":42962944,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-08-30T02:13:38.146914Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3427109326,"revision":23706,"compact-revision":21494} {"level":"info","ts":"2026-08-30T02:18:29.38848Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a6342599e225e01b","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-30T02:18:29.394073Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-08-30T02:18:29.394163Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-08-30T02:18:38.024137Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26865} {"level":"info","ts":"2026-08-30T02:18:38.167742Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26865,"took":"138.668696ms","hash":2335843836,"current-db-size-bytes":56090624,"current-db-size":"56 MB","current-db-size-in-use-bytes":30273536,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-30T02:18:38.167802Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2335843836,"revision":26865,"compact-revision":23706} {"level":"warn","ts":"2026-08-30T02:20:10.827307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.476567ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-30T02:20:10.827555Z","caller":"traceutil/trace.go:171","msg":"trace[1565597201] transaction","detail":"{read_only:false; response_revision:29827; number_of_response:1; }","duration":"157.895798ms","start":"2026-08-30T02:20:10.669586Z","end":"2026-08-30T02:20:10.827482Z","steps":["trace[1565597201] 'process raft request' (duration: 43.135625ms)","trace[1565597201] 'compare' (duration: 114.377355ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:13.116999Z","caller":"traceutil/trace.go:171","msg":"trace[892172901] transaction","detail":"{read_only:false; response_revision:29856; number_of_response:1; }","duration":"123.619193ms","start":"2026-08-30T02:20:12.993324Z","end":"2026-08-30T02:20:13.116943Z","steps":["trace[892172901] 'process raft request' (duration: 123.358917ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:13.117006Z","caller":"traceutil/trace.go:171","msg":"trace[1349806363] transaction","detail":"{read_only:false; number_of_response:1; response_revision:29856; }","duration":"123.643423ms","start":"2026-08-30T02:20:12.993324Z","end":"2026-08-30T02:20:13.116967Z","steps":["trace[1349806363] 'process raft request' (duration: 123.526941ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:13.117121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.672229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/auth-system/keycloak-0\" ","response":"range_response_count:1 size:7965"} {"level":"info","ts":"2026-08-30T02:20:13.117205Z","caller":"traceutil/trace.go:171","msg":"trace[694593796] range","detail":"{range_begin:/registry/pods/auth-system/keycloak-0; range_end:; response_count:1; response_revision:29856; }","duration":"106.813962ms","start":"2026-08-30T02:20:13.010371Z","end":"2026-08-30T02:20:13.117185Z","steps":["trace[694593796] 'agreement among raft nodes before linearized reading' (duration: 106.576277ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:14.439367Z","caller":"traceutil/trace.go:171","msg":"trace[172346753] linearizableReadLoop","detail":"{readStateIndex:30856; appliedIndex:30855; }","duration":"171.768746ms","start":"2026-08-30T02:20:14.267572Z","end":"2026-08-30T02:20:14.439341Z","steps":["trace[172346753] 'read index received' (duration: 171.685654ms)","trace[172346753] 'applied index is now lower than readState.Index' (duration: 82.042µs)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:14.439726Z","caller":"traceutil/trace.go:171","msg":"trace[784226951] transaction","detail":"{read_only:false; response_revision:29862; number_of_response:1; }","duration":"172.247977ms","start":"2026-08-30T02:20:14.267464Z","end":"2026-08-30T02:20:14.439712Z","steps":["trace[784226951] 'process raft request' (duration: 171.707205ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:14.440086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.459712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19027"} {"level":"info","ts":"2026-08-30T02:20:14.440204Z","caller":"traceutil/trace.go:171","msg":"trace[663498646] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:29862; }","duration":"172.656216ms","start":"2026-08-30T02:20:14.267525Z","end":"2026-08-30T02:20:14.440181Z","steps":["trace[663498646] 'agreement among raft nodes before linearized reading' (duration: 172.277098ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:14.557668Z","caller":"traceutil/trace.go:171","msg":"trace[559803735] transaction","detail":"{read_only:false; response_revision:29863; number_of_response:1; }","duration":"244.109519ms","start":"2026-08-30T02:20:14.313507Z","end":"2026-08-30T02:20:14.557616Z","steps":["trace[559803735] 'process raft request' (duration: 181.523356ms)","trace[559803735] 'compare' (duration: 62.059171ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:14.571513Z","caller":"traceutil/trace.go:171","msg":"trace[1596149181] transaction","detail":"{read_only:false; response_revision:29865; number_of_response:1; }","duration":"172.164045ms","start":"2026-08-30T02:20:14.399297Z","end":"2026-08-30T02:20:14.571461Z","steps":["trace[1596149181] 'process raft request' (duration: 171.996731ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:14.57152Z","caller":"traceutil/trace.go:171","msg":"trace[249452596] transaction","detail":"{read_only:false; response_revision:29864; number_of_response:1; }","duration":"174.144918ms","start":"2026-08-30T02:20:14.397295Z","end":"2026-08-30T02:20:14.57144Z","steps":["trace[249452596] 'process raft request' (duration: 160.094996ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:14.571702Z","caller":"traceutil/trace.go:171","msg":"trace[2117677741] linearizableReadLoop","detail":"{readStateIndex:30860; appliedIndex:30856; }","duration":"132.186728ms","start":"2026-08-30T02:20:14.439447Z","end":"2026-08-30T02:20:14.571634Z","steps":["trace[2117677741] 'read index received' (duration: 55.558733ms)","trace[2117677741] 'applied index is now lower than readState.Index' (duration: 76.623965ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:14.571758Z","caller":"traceutil/trace.go:171","msg":"trace[371550809] transaction","detail":"{read_only:false; response_revision:29866; number_of_response:1; }","duration":"135.483688ms","start":"2026-08-30T02:20:14.436244Z","end":"2026-08-30T02:20:14.571728Z","steps":["trace[371550809] 'process raft request' (duration: 135.152151ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:14.571997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.373261ms","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-08-30T02:20:14.572064Z","caller":"traceutil/trace.go:171","msg":"trace[402308928] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:29866; }","duration":"283.495813ms","start":"2026-08-30T02:20:14.28854Z","end":"2026-08-30T02:20:14.572036Z","steps":["trace[402308928] 'agreement among raft nodes before linearized reading' (duration: 283.34378ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:14.572106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.835606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" limit:500 ","response":"range_response_count:16 size:111962"} {"level":"info","ts":"2026-08-30T02:20:14.572164Z","caller":"traceutil/trace.go:171","msg":"trace[946735891] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:16; response_revision:29866; }","duration":"198.889788ms","start":"2026-08-30T02:20:14.373247Z","end":"2026-08-30T02:20:14.572137Z","steps":["trace[946735891] 'agreement among raft nodes before linearized reading' (duration: 198.557491ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:14.579686Z","caller":"traceutil/trace.go:171","msg":"trace[320866764] transaction","detail":"{read_only:false; response_revision:29867; number_of_response:1; }","duration":"118.422521ms","start":"2026-08-30T02:20:14.460793Z","end":"2026-08-30T02:20:14.579216Z","steps":["trace[320866764] 'process raft request' (duration: 118.280388ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:14.605197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.641002ms","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-08-30T02:20:14.605291Z","caller":"traceutil/trace.go:171","msg":"trace[153529592] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:29868; }","duration":"149.811566ms","start":"2026-08-30T02:20:14.455453Z","end":"2026-08-30T02:20:14.605265Z","steps":["trace[153529592] 'agreement among raft nodes before linearized reading' (duration: 149.047568ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:14.759516Z","caller":"traceutil/trace.go:171","msg":"trace[2037882322] transaction","detail":"{read_only:false; response_revision:29870; number_of_response:1; }","duration":"147.802532ms","start":"2026-08-30T02:20:14.611657Z","end":"2026-08-30T02:20:14.759459Z","steps":["trace[2037882322] 'process raft request' (duration: 49.566674ms)","trace[2037882322] 'compare' (duration: 97.895341ms)"],"step_count":2} {"level":"warn","ts":"2026-08-30T02:20:15.15413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.911331ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:15.154249Z","caller":"traceutil/trace.go:171","msg":"trace[1956788345] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:29871; }","duration":"104.044874ms","start":"2026-08-30T02:20:15.050186Z","end":"2026-08-30T02:20:15.154231Z","steps":["trace[1956788345] 'range keys from in-memory index tree' (duration: 103.892571ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:15.154326Z","caller":"traceutil/trace.go:171","msg":"trace[733774708] transaction","detail":"{read_only:false; response_revision:29872; number_of_response:1; }","duration":"206.750407ms","start":"2026-08-30T02:20:14.947548Z","end":"2026-08-30T02:20:15.154298Z","steps":["trace[733774708] 'process raft request' (duration: 144.134153ms)","trace[733774708] 'compare' (duration: 62.313387ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:15.15432Z","caller":"traceutil/trace.go:171","msg":"trace[1250974652] linearizableReadLoop","detail":"{readStateIndex:30866; appliedIndex:30865; }","duration":"164.92968ms","start":"2026-08-30T02:20:14.989346Z","end":"2026-08-30T02:20:15.154275Z","steps":["trace[1250974652] 'read index received' (duration: 102.275765ms)","trace[1250974652] 'applied index is now lower than readState.Index' (duration: 62.650725ms)"],"step_count":2} {"level":"warn","ts":"2026-08-30T02:20:15.154469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.115164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:15.154516Z","caller":"traceutil/trace.go:171","msg":"trace[924719839] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:29872; }","duration":"165.205756ms","start":"2026-08-30T02:20:14.989299Z","end":"2026-08-30T02:20:15.154504Z","steps":["trace[924719839] 'agreement among raft nodes before linearized reading' (duration: 165.128144ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:16.213806Z","caller":"traceutil/trace.go:171","msg":"trace[945319567] linearizableReadLoop","detail":"{readStateIndex:30869; appliedIndex:30868; }","duration":"323.764369ms","start":"2026-08-30T02:20:15.890007Z","end":"2026-08-30T02:20:16.213771Z","steps":["trace[945319567] 'read index received' (duration: 323.511244ms)","trace[945319567] 'applied index is now lower than readState.Index' (duration: 251.545µs)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:16.214007Z","caller":"traceutil/trace.go:171","msg":"trace[1508560309] transaction","detail":"{read_only:false; response_revision:29875; number_of_response:1; }","duration":"330.791009ms","start":"2026-08-30T02:20:15.883202Z","end":"2026-08-30T02:20:16.213993Z","steps":["trace[1508560309] 'process raft request' (duration: 330.351279ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:16.214235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.590345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/cert-manager/cert-manager-79c48d47db-mm6d5\" ","response":"range_response_count:1 size:5039"} {"level":"warn","ts":"2026-08-30T02:20:16.214305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.853936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:16.21434Z","caller":"traceutil/trace.go:171","msg":"trace[225177616] range","detail":"{range_begin:/registry/pods/cert-manager/cert-manager-79c48d47db-mm6d5; range_end:; response_count:1; response_revision:29875; }","duration":"255.732708ms","start":"2026-08-30T02:20:15.958567Z","end":"2026-08-30T02:20:16.2143Z","steps":["trace[225177616] 'agreement among raft nodes before linearized reading' (duration: 255.514334ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:16.214365Z","caller":"traceutil/trace.go:171","msg":"trace[1072242675] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-user; range_end:; response_count:0; response_revision:29875; }","duration":"245.952078ms","start":"2026-08-30T02:20:15.968394Z","end":"2026-08-30T02:20:16.214346Z","steps":["trace[1072242675] 'agreement among raft nodes before linearized reading' (duration: 245.848566ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:16.214365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.057081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"warn","ts":"2026-08-30T02:20:16.214406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.394912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/secretgen-controller/\" range_end:\"/registry/pods/secretgen-controller0\" limit:500 ","response":"range_response_count:1 size:3164"} {"level":"info","ts":"2026-08-30T02:20:16.214442Z","caller":"traceutil/trace.go:171","msg":"trace[4510408] range","detail":"{range_begin:/registry/jobs/openstack/magnum-db-sync; range_end:; response_count:1; response_revision:29875; }","duration":"246.192204ms","start":"2026-08-30T02:20:15.96823Z","end":"2026-08-30T02:20:16.214423Z","steps":["trace[4510408] 'agreement among raft nodes before linearized reading' (duration: 245.940869ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:16.214463Z","caller":"traceutil/trace.go:171","msg":"trace[1015949269] range","detail":"{range_begin:/registry/pods/secretgen-controller/; range_end:/registry/pods/secretgen-controller0; response_count:1; response_revision:29875; }","duration":"324.495274ms","start":"2026-08-30T02:20:15.889949Z","end":"2026-08-30T02:20:16.214444Z","steps":["trace[1015949269] 'agreement among raft nodes before linearized reading' (duration: 324.344041ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:16.214239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.349203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-30T02:20:16.21454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:15.889926Z","time spent":"324.591326ms","remote":"127.0.0.1:35816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":1,"response size":3188,"request content":"key:\"/registry/pods/secretgen-controller/\" range_end:\"/registry/pods/secretgen-controller0\" limit:500 "} {"level":"warn","ts":"2026-08-30T02:20:16.214618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.377798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:16.214595Z","caller":"traceutil/trace.go:171","msg":"trace[2094064364] range","detail":"{range_begin:/registry/jobs/openstack/magnum-rabbit-init; range_end:; response_count:0; response_revision:29875; }","duration":"244.776003ms","start":"2026-08-30T02:20:15.969799Z","end":"2026-08-30T02:20:16.214575Z","steps":["trace[2094064364] 'agreement among raft nodes before linearized reading' (duration: 244.358284ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:16.214644Z","caller":"traceutil/trace.go:171","msg":"trace[1503378497] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-endpoints; range_end:; response_count:0; response_revision:29875; }","duration":"246.436128ms","start":"2026-08-30T02:20:15.968199Z","end":"2026-08-30T02:20:16.214635Z","steps":["trace[1503378497] 'agreement among raft nodes before linearized reading' (duration: 246.391567ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:16.214687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.227501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-domain-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:16.214727Z","caller":"traceutil/trace.go:171","msg":"trace[1293446525] range","detail":"{range_begin:/registry/jobs/openstack/magnum-domain-ks-user; range_end:; response_count:0; response_revision:29875; }","duration":"244.280182ms","start":"2026-08-30T02:20:15.970436Z","end":"2026-08-30T02:20:16.214716Z","steps":["trace[1293446525] 'agreement among raft nodes before linearized reading' (duration: 244.221841ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:16.214284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:15.883168Z","time spent":"330.979923ms","remote":"127.0.0.1:35884","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-08-30T02:20:16.691201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.730986ms","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-08-30T02:20:16.691238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.145912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/cert-manager/cert-manager-79c48d47db-mm6d5\" ","response":"range_response_count:1 size:5039"} {"level":"info","ts":"2026-08-30T02:20:16.691283Z","caller":"traceutil/trace.go:171","msg":"trace[1361349901] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:29875; }","duration":"247.865119ms","start":"2026-08-30T02:20:16.443399Z","end":"2026-08-30T02:20:16.691264Z","steps":["trace[1361349901] 'range keys from in-memory index tree' (duration: 247.527262ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:16.691313Z","caller":"traceutil/trace.go:171","msg":"trace[35592104] range","detail":"{range_begin:/registry/pods/cert-manager/cert-manager-79c48d47db-mm6d5; range_end:; response_count:1; response_revision:29875; }","duration":"204.264334ms","start":"2026-08-30T02:20:16.48703Z","end":"2026-08-30T02:20:16.691295Z","steps":["trace[35592104] 'range keys from in-memory index tree' (duration: 203.972878ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:16.816854Z","caller":"traceutil/trace.go:171","msg":"trace[2088536937] transaction","detail":"{read_only:false; response_revision:29876; number_of_response:1; }","duration":"236.929925ms","start":"2026-08-30T02:20:16.579895Z","end":"2026-08-30T02:20:16.816825Z","steps":["trace[2088536937] 'process raft request' (duration: 236.651119ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:16.817076Z","caller":"traceutil/trace.go:171","msg":"trace[143361398] transaction","detail":"{read_only:false; response_revision:29877; number_of_response:1; }","duration":"236.929445ms","start":"2026-08-30T02:20:16.580125Z","end":"2026-08-30T02:20:16.817054Z","steps":["trace[143361398] 'process raft request' (duration: 236.630358ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:16.817567Z","caller":"traceutil/trace.go:171","msg":"trace[1821767927] transaction","detail":"{read_only:false; response_revision:29878; number_of_response:1; }","duration":"236.451604ms","start":"2026-08-30T02:20:16.581072Z","end":"2026-08-30T02:20:16.817524Z","steps":["trace[1821767927] 'process raft request' (duration: 235.912703ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:16.817583Z","caller":"traceutil/trace.go:171","msg":"trace[1235425222] transaction","detail":"{read_only:false; response_revision:29879; number_of_response:1; }","duration":"235.853561ms","start":"2026-08-30T02:20:16.581698Z","end":"2026-08-30T02:20:16.817551Z","steps":["trace[1235425222] 'process raft request' (duration: 235.659317ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:16.817744Z","caller":"traceutil/trace.go:171","msg":"trace[9911125] linearizableReadLoop","detail":"{readStateIndex:30875; appliedIndex:30869; }","duration":"183.358045ms","start":"2026-08-30T02:20:16.63434Z","end":"2026-08-30T02:20:16.817698Z","steps":["trace[9911125] 'read index received' (duration: 61.169153ms)","trace[9911125] 'applied index is now lower than readState.Index' (duration: 122.184942ms)"],"step_count":2} {"level":"warn","ts":"2026-08-30T02:20:16.817953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.60409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-08-30T02:20:16.817948Z","caller":"traceutil/trace.go:171","msg":"trace[1710431214] transaction","detail":"{read_only:false; response_revision:29880; number_of_response:1; }","duration":"234.558213ms","start":"2026-08-30T02:20:16.583286Z","end":"2026-08-30T02:20:16.817845Z","steps":["trace[1710431214] 'process raft request' (duration: 234.221756ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:16.818001Z","caller":"traceutil/trace.go:171","msg":"trace[1851068631] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:29880; }","duration":"183.709302ms","start":"2026-08-30T02:20:16.634278Z","end":"2026-08-30T02:20:16.817988Z","steps":["trace[1851068631] 'agreement among raft nodes before linearized reading' (duration: 183.541549ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:16.845694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.206737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/cert-manager/cert-manager-79c48d47db-mm6d5\" ","response":"range_response_count:1 size:5039"} {"level":"info","ts":"2026-08-30T02:20:16.845683Z","caller":"traceutil/trace.go:171","msg":"trace[1706793283] transaction","detail":"{read_only:false; response_revision:29881; number_of_response:1; }","duration":"148.362404ms","start":"2026-08-30T02:20:16.697271Z","end":"2026-08-30T02:20:16.845633Z","steps":["trace[1706793283] 'process raft request' (duration: 148.166249ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:16.845759Z","caller":"traceutil/trace.go:171","msg":"trace[1998764120] range","detail":"{range_begin:/registry/pods/cert-manager/cert-manager-79c48d47db-mm6d5; range_end:; response_count:1; response_revision:29881; }","duration":"146.32091ms","start":"2026-08-30T02:20:16.699419Z","end":"2026-08-30T02:20:16.84574Z","steps":["trace[1998764120] 'agreement among raft nodes before linearized reading' (duration: 146.148676ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:16.993663Z","caller":"traceutil/trace.go:171","msg":"trace[433662011] linearizableReadLoop","detail":"{readStateIndex:30878; appliedIndex:30877; }","duration":"130.765596ms","start":"2026-08-30T02:20:16.86286Z","end":"2026-08-30T02:20:16.993625Z","steps":["trace[433662011] 'read index received' (duration: 129.449648ms)","trace[433662011] 'applied index is now lower than readState.Index' (duration: 1.313568ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:16.993979Z","caller":"traceutil/trace.go:171","msg":"trace[1429701953] transaction","detail":"{read_only:false; response_revision:29883; number_of_response:1; }","duration":"141.18235ms","start":"2026-08-30T02:20:16.852677Z","end":"2026-08-30T02:20:16.99386Z","steps":["trace[1429701953] 'process raft request' (duration: 139.284119ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:16.994311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.225729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19027"} {"level":"info","ts":"2026-08-30T02:20:16.994539Z","caller":"traceutil/trace.go:171","msg":"trace[757238767] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:29883; }","duration":"147.486895ms","start":"2026-08-30T02:20:16.847033Z","end":"2026-08-30T02:20:16.99452Z","steps":["trace[757238767] 'agreement among raft nodes before linearized reading' (duration: 146.963953ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:17.217264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.703566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/cert-manager/cert-manager-79c48d47db-mm6d5\" ","response":"range_response_count:1 size:5039"} {"level":"info","ts":"2026-08-30T02:20:17.217331Z","caller":"traceutil/trace.go:171","msg":"trace[1658541590] range","detail":"{range_begin:/registry/pods/cert-manager/cert-manager-79c48d47db-mm6d5; range_end:; response_count:1; response_revision:29885; }","duration":"117.829628ms","start":"2026-08-30T02:20:17.099485Z","end":"2026-08-30T02:20:17.217314Z","steps":["trace[1658541590] 'range keys from in-memory index tree' (duration: 117.534913ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:17.217653Z","caller":"traceutil/trace.go:171","msg":"trace[1156568156] transaction","detail":"{read_only:false; response_revision:29886; number_of_response:1; }","duration":"100.599399ms","start":"2026-08-30T02:20:17.117035Z","end":"2026-08-30T02:20:17.217635Z","steps":["trace[1156568156] 'process raft request' (duration: 49.468502ms)","trace[1156568156] 'compare' (duration: 50.549925ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:17.635861Z","caller":"traceutil/trace.go:171","msg":"trace[157494811] transaction","detail":"{read_only:false; response_revision:29889; number_of_response:1; }","duration":"113.281691ms","start":"2026-08-30T02:20:17.522541Z","end":"2026-08-30T02:20:17.635822Z","steps":["trace[157494811] 'process raft request' (duration: 113.019935ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:18.585143Z","caller":"traceutil/trace.go:171","msg":"trace[655309889] linearizableReadLoop","detail":"{readStateIndex:30886; appliedIndex:30885; }","duration":"133.515114ms","start":"2026-08-30T02:20:18.451608Z","end":"2026-08-30T02:20:18.585123Z","steps":["trace[655309889] 'read index received' (duration: 133.31166ms)","trace[655309889] 'applied index is now lower than readState.Index' (duration: 202.634µs)"],"step_count":2} {"level":"warn","ts":"2026-08-30T02:20:18.58528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.643358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs/\" range_end:\"/registry/runtime.cluster.x-k8s.io/extensionconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:18.585305Z","caller":"traceutil/trace.go:171","msg":"trace[464981286] range","detail":"{range_begin:/registry/runtime.cluster.x-k8s.io/extensionconfigs/; range_end:/registry/runtime.cluster.x-k8s.io/extensionconfigs0; response_count:0; response_revision:29891; }","duration":"133.728819ms","start":"2026-08-30T02:20:18.451569Z","end":"2026-08-30T02:20:18.585298Z","steps":["trace[464981286] 'agreement among raft nodes before linearized reading' (duration: 133.655277ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:18.585362Z","caller":"traceutil/trace.go:171","msg":"trace[1911845131] transaction","detail":"{read_only:false; response_revision:29891; number_of_response:1; }","duration":"142.938598ms","start":"2026-08-30T02:20:18.442345Z","end":"2026-08-30T02:20:18.585284Z","steps":["trace[1911845131] 'process raft request' (duration: 142.642551ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:18.58558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.002335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/cert-manager/cert-manager-webhook-7d6b59cfdc-9ms8z\" ","response":"range_response_count:1 size:4876"} {"level":"info","ts":"2026-08-30T02:20:18.585665Z","caller":"traceutil/trace.go:171","msg":"trace[381459367] range","detail":"{range_begin:/registry/pods/cert-manager/cert-manager-webhook-7d6b59cfdc-9ms8z; range_end:; response_count:1; response_revision:29891; }","duration":"127.115177ms","start":"2026-08-30T02:20:18.458524Z","end":"2026-08-30T02:20:18.585639Z","steps":["trace[381459367] 'agreement among raft nodes before linearized reading' (duration: 126.868722ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:19.157822Z","caller":"traceutil/trace.go:171","msg":"trace[1528726161] transaction","detail":"{read_only:false; response_revision:29894; number_of_response:1; }","duration":"331.291221ms","start":"2026-08-30T02:20:18.826504Z","end":"2026-08-30T02:20:19.157795Z","steps":["trace[1528726161] 'process raft request' (duration: 331.160488ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:19.157938Z","caller":"traceutil/trace.go:171","msg":"trace[1651424458] transaction","detail":"{read_only:false; response_revision:29893; number_of_response:1; }","duration":"331.514046ms","start":"2026-08-30T02:20:18.826373Z","end":"2026-08-30T02:20:19.157887Z","steps":["trace[1651424458] 'process raft request' (duration: 331.132128ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:19.158079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:18.826493Z","time spent":"331.467134ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-30T02:20:19.158131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:18.82635Z","time spent":"331.664528ms","remote":"127.0.0.1:35884","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-08-30T02:20:19.158256Z","caller":"traceutil/trace.go:171","msg":"trace[252775819] transaction","detail":"{read_only:false; response_revision:29895; number_of_response:1; }","duration":"331.719199ms","start":"2026-08-30T02:20:18.82652Z","end":"2026-08-30T02:20:19.158239Z","steps":["trace[252775819] 'process raft request' (duration: 331.189258ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:19.158319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:18.826498Z","time spent":"331.787401ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-30T02:20:19.158328Z","caller":"traceutil/trace.go:171","msg":"trace[1245963461] linearizableReadLoop","detail":"{readStateIndex:30891; appliedIndex:30887; }","duration":"307.307405ms","start":"2026-08-30T02:20:18.850988Z","end":"2026-08-30T02:20:19.158296Z","steps":["trace[1245963461] 'read index received' (duration: 29.33451ms)","trace[1245963461] 'applied index is now lower than readState.Index' (duration: 277.971265ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:19.158361Z","caller":"traceutil/trace.go:171","msg":"trace[1897251156] transaction","detail":"{read_only:false; response_revision:29896; number_of_response:1; }","duration":"331.655597ms","start":"2026-08-30T02:20:18.826665Z","end":"2026-08-30T02:20:19.158321Z","steps":["trace[1897251156] 'process raft request' (duration: 331.488033ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:19.158545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:18.826656Z","time spent":"331.78229ms","remote":"127.0.0.1:35884","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-08-30T02:20:19.15865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.666464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-08-30T02:20:19.158722Z","caller":"traceutil/trace.go:171","msg":"trace[1181739349] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:29896; }","duration":"307.782776ms","start":"2026-08-30T02:20:18.850925Z","end":"2026-08-30T02:20:19.158708Z","steps":["trace[1181739349] 'agreement among raft nodes before linearized reading' (duration: 307.51543ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:19.158785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:18.850894Z","time spent":"307.881497ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-30T02:20:19.189048Z","caller":"traceutil/trace.go:171","msg":"trace[1848757967] transaction","detail":"{read_only:false; response_revision:29897; number_of_response:1; }","duration":"172.675526ms","start":"2026-08-30T02:20:19.01634Z","end":"2026-08-30T02:20:19.189015Z","steps":["trace[1848757967] 'process raft request' (duration: 172.441622ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:19.189177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.842475ms","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-08-30T02:20:19.189258Z","caller":"traceutil/trace.go:171","msg":"trace[808995041] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:29897; }","duration":"190.986689ms","start":"2026-08-30T02:20:18.998251Z","end":"2026-08-30T02:20:19.189238Z","steps":["trace[808995041] 'agreement among raft nodes before linearized reading' (duration: 190.730354ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:19.189196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.633274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-08-30T02:20:19.189436Z","caller":"traceutil/trace.go:171","msg":"trace[1265966117] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:29897; }","duration":"322.93363ms","start":"2026-08-30T02:20:18.866426Z","end":"2026-08-30T02:20:19.189359Z","steps":["trace[1265966117] 'agreement among raft nodes before linearized reading' (duration: 322.669824ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:19.189445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.732555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-vnncf\" ","response":"range_response_count:1 size:5485"} {"level":"warn","ts":"2026-08-30T02:20:19.189568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:18.866401Z","time spent":"323.128434ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-30T02:20:19.189694Z","caller":"traceutil/trace.go:171","msg":"trace[2092503208] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-vnncf; range_end:; response_count:1; response_revision:29897; }","duration":"239.97437ms","start":"2026-08-30T02:20:18.949638Z","end":"2026-08-30T02:20:19.189612Z","steps":["trace[2092503208] 'agreement among raft nodes before linearized reading' (duration: 239.418698ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:19.302682Z","caller":"traceutil/trace.go:171","msg":"trace[1183469305] linearizableReadLoop","detail":"{readStateIndex:30893; appliedIndex:30892; }","duration":"113.752151ms","start":"2026-08-30T02:20:19.188908Z","end":"2026-08-30T02:20:19.30266Z","steps":["trace[1183469305] 'read index received' (duration: 71.141356ms)","trace[1183469305] 'applied index is now lower than readState.Index' (duration: 42.609765ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:19.302758Z","caller":"traceutil/trace.go:171","msg":"trace[1618039449] transaction","detail":"{read_only:false; response_revision:29898; number_of_response:1; }","duration":"139.710987ms","start":"2026-08-30T02:20:19.163013Z","end":"2026-08-30T02:20:19.302724Z","steps":["trace[1618039449] 'process raft request' (duration: 97.019521ms)","trace[1618039449] 'compare' (duration: 42.524533ms)"],"step_count":2} {"level":"warn","ts":"2026-08-30T02:20:19.302907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.484047ms","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-08-30T02:20:19.302977Z","caller":"traceutil/trace.go:171","msg":"trace[2142822940] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:29898; }","duration":"114.598999ms","start":"2026-08-30T02:20:19.188361Z","end":"2026-08-30T02:20:19.30296Z","steps":["trace[2142822940] 'agreement among raft nodes before linearized reading' (duration: 114.393804ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:19.313168Z","caller":"traceutil/trace.go:171","msg":"trace[1087647482] transaction","detail":"{read_only:false; response_revision:29899; number_of_response:1; }","duration":"119.72585ms","start":"2026-08-30T02:20:19.193413Z","end":"2026-08-30T02:20:19.313139Z","steps":["trace[1087647482] 'process raft request' (duration: 119.522656ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:19.313355Z","caller":"traceutil/trace.go:171","msg":"trace[1373936262] transaction","detail":"{read_only:false; response_revision:29900; number_of_response:1; }","duration":"118.85156ms","start":"2026-08-30T02:20:19.194489Z","end":"2026-08-30T02:20:19.31334Z","steps":["trace[1373936262] 'process raft request' (duration: 118.605005ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:19.89791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.480193ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-30T02:20:19.898127Z","caller":"traceutil/trace.go:171","msg":"trace[1036185488] linearizableReadLoop","detail":"{readStateIndex:30900; appliedIndex:30898; }","duration":"167.000825ms","start":"2026-08-30T02:20:19.731108Z","end":"2026-08-30T02:20:19.898109Z","steps":["trace[1036185488] 'read index received' (duration: 20.103683ms)","trace[1036185488] 'applied index is now lower than readState.Index' (duration: 146.895322ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:19.898131Z","caller":"traceutil/trace.go:171","msg":"trace[1249635626] transaction","detail":"{read_only:false; response_revision:29904; number_of_response:1; }","duration":"251.177981ms","start":"2026-08-30T02:20:19.646919Z","end":"2026-08-30T02:20:19.898097Z","steps":["trace[1249635626] 'process raft request' (duration: 104.387501ms)","trace[1249635626] 'compare' (duration: 146.195247ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:19.898231Z","caller":"traceutil/trace.go:171","msg":"trace[1840005779] transaction","detail":"{read_only:false; response_revision:29905; number_of_response:1; }","duration":"216.930265ms","start":"2026-08-30T02:20:19.681292Z","end":"2026-08-30T02:20:19.898222Z","steps":["trace[1840005779] 'process raft request' (duration: 216.722971ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:19.898443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.70994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-30T02:20:19.898478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.361854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:19.89854Z","caller":"traceutil/trace.go:171","msg":"trace[607510088] range","detail":"{range_begin:/registry/jobs/openstack/magnum-rabbit-init; range_end:; response_count:0; response_revision:29905; }","duration":"147.836073ms","start":"2026-08-30T02:20:19.750686Z","end":"2026-08-30T02:20:19.898522Z","steps":["trace[607510088] 'agreement among raft nodes before linearized reading' (duration: 147.69141ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:19.898541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.433164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-controller-vjlqb\" ","response":"range_response_count:1 size:7125"} {"level":"warn","ts":"2026-08-30T02:20:19.89854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.389374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:19.898562Z","caller":"traceutil/trace.go:171","msg":"trace[1024425761] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-user; range_end:; response_count:0; response_revision:29905; }","duration":"148.514757ms","start":"2026-08-30T02:20:19.750027Z","end":"2026-08-30T02:20:19.898541Z","steps":["trace[1024425761] 'agreement among raft nodes before linearized reading' (duration: 148.352904ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:19.898443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.17053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-domain-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:19.898594Z","caller":"traceutil/trace.go:171","msg":"trace[1807230437] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-controller-vjlqb; range_end:; response_count:1; response_revision:29905; }","duration":"167.530976ms","start":"2026-08-30T02:20:19.731049Z","end":"2026-08-30T02:20:19.89858Z","steps":["trace[1807230437] 'agreement among raft nodes before linearized reading' (duration: 167.332152ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:19.898609Z","caller":"traceutil/trace.go:171","msg":"trace[842829564] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-endpoints; range_end:; response_count:0; response_revision:29905; }","duration":"148.484606ms","start":"2026-08-30T02:20:19.750108Z","end":"2026-08-30T02:20:19.898593Z","steps":["trace[842829564] 'agreement among raft nodes before linearized reading' (duration: 148.341913ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:19.898611Z","caller":"traceutil/trace.go:171","msg":"trace[1813173125] range","detail":"{range_begin:/registry/jobs/openstack/magnum-domain-ks-user; range_end:; response_count:0; response_revision:29905; }","duration":"148.364364ms","start":"2026-08-30T02:20:19.750233Z","end":"2026-08-30T02:20:19.898597Z","steps":["trace[1813173125] 'agreement among raft nodes before linearized reading' (duration: 148.15716ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:19.898688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.815113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"info","ts":"2026-08-30T02:20:19.898761Z","caller":"traceutil/trace.go:171","msg":"trace[799990091] range","detail":"{range_begin:/registry/jobs/openstack/magnum-db-sync; range_end:; response_count:1; response_revision:29905; }","duration":"147.939475ms","start":"2026-08-30T02:20:19.7508Z","end":"2026-08-30T02:20:19.89874Z","steps":["trace[799990091] 'agreement among raft nodes before linearized reading' (duration: 147.69762ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:20.113761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.042699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-controller-vjlqb\" ","response":"range_response_count:1 size:7125"} {"level":"info","ts":"2026-08-30T02:20:20.11384Z","caller":"traceutil/trace.go:171","msg":"trace[629309466] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-controller-vjlqb; range_end:; response_count:1; response_revision:29905; }","duration":"102.177452ms","start":"2026-08-30T02:20:20.011643Z","end":"2026-08-30T02:20:20.113821Z","steps":["trace[629309466] 'range keys from in-memory index tree' (duration: 101.797984ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:20.373393Z","caller":"traceutil/trace.go:171","msg":"trace[1648796482] linearizableReadLoop","detail":"{readStateIndex:30901; appliedIndex:30900; }","duration":"105.602117ms","start":"2026-08-30T02:20:20.26774Z","end":"2026-08-30T02:20:20.373342Z","steps":["trace[1648796482] 'read index received' (duration: 105.356482ms)","trace[1648796482] 'applied index is now lower than readState.Index' (duration: 244.505µs)"],"step_count":2} {"level":"warn","ts":"2026-08-30T02:20:20.373739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.969375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:20.374332Z","caller":"traceutil/trace.go:171","msg":"trace[1830577865] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-user; range_end:; response_count:0; response_revision:29906; }","duration":"106.596487ms","start":"2026-08-30T02:20:20.26771Z","end":"2026-08-30T02:20:20.374307Z","steps":["trace[1830577865] 'agreement among raft nodes before linearized reading' (duration: 105.953024ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:20.373755Z","caller":"traceutil/trace.go:171","msg":"trace[1037745310] transaction","detail":"{read_only:false; response_revision:29906; number_of_response:1; }","duration":"106.082387ms","start":"2026-08-30T02:20:20.267624Z","end":"2026-08-30T02:20:20.373707Z","steps":["trace[1037745310] 'process raft request' (duration: 105.468494ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:21.418334Z","caller":"traceutil/trace.go:171","msg":"trace[527686716] transaction","detail":"{read_only:false; response_revision:29909; number_of_response:1; }","duration":"254.676155ms","start":"2026-08-30T02:20:21.16363Z","end":"2026-08-30T02:20:21.418307Z","steps":["trace[527686716] 'process raft request' (duration: 254.475141ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:21.418588Z","caller":"traceutil/trace.go:171","msg":"trace[96025453] transaction","detail":"{read_only:false; response_revision:29910; number_of_response:1; }","duration":"254.538813ms","start":"2026-08-30T02:20:21.164033Z","end":"2026-08-30T02:20:21.418572Z","steps":["trace[96025453] 'process raft request' (duration: 254.238767ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:21.418678Z","caller":"traceutil/trace.go:171","msg":"trace[1628091838] transaction","detail":"{read_only:false; response_revision:29911; number_of_response:1; }","duration":"254.41201ms","start":"2026-08-30T02:20:21.164253Z","end":"2026-08-30T02:20:21.418665Z","steps":["trace[1628091838] 'process raft request' (duration: 254.257917ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:21.418805Z","caller":"traceutil/trace.go:171","msg":"trace[1804421854] linearizableReadLoop","detail":"{readStateIndex:30907; appliedIndex:30902; }","duration":"194.112786ms","start":"2026-08-30T02:20:21.224683Z","end":"2026-08-30T02:20:21.418795Z","steps":["trace[1804421854] 'read index received' (duration: 4.20633ms)","trace[1804421854] 'applied index is now lower than readState.Index' (duration: 189.905446ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:21.418867Z","caller":"traceutil/trace.go:171","msg":"trace[1886917195] transaction","detail":"{read_only:false; response_revision:29912; number_of_response:1; }","duration":"224.263162ms","start":"2026-08-30T02:20:21.194596Z","end":"2026-08-30T02:20:21.418859Z","steps":["trace[1886917195] 'process raft request' (duration: 224.027747ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:21.41904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.34018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jhs9r\" ","response":"range_response_count:1 size:18526"} {"level":"info","ts":"2026-08-30T02:20:21.419139Z","caller":"traceutil/trace.go:171","msg":"trace[1752211298] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jhs9r; range_end:; response_count:1; response_revision:29912; }","duration":"194.487414ms","start":"2026-08-30T02:20:21.224632Z","end":"2026-08-30T02:20:21.41912Z","steps":["trace[1752211298] 'agreement among raft nodes before linearized reading' (duration: 194.246228ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:21.452891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.177943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-30T02:20:21.452988Z","caller":"traceutil/trace.go:171","msg":"trace[1906109129] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:29913; }","duration":"170.326786ms","start":"2026-08-30T02:20:21.282642Z","end":"2026-08-30T02:20:21.452969Z","steps":["trace[1906109129] 'agreement among raft nodes before linearized reading' (duration: 170.144772ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:21.453158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.071854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-08-30T02:20:21.453145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.565569ms","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-08-30T02:20:21.45325Z","caller":"traceutil/trace.go:171","msg":"trace[772111909] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:29913; }","duration":"146.209917ms","start":"2026-08-30T02:20:21.307017Z","end":"2026-08-30T02:20:21.453227Z","steps":["trace[772111909] 'agreement among raft nodes before linearized reading' (duration: 146.014873ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:21.453273Z","caller":"traceutil/trace.go:171","msg":"trace[1893753286] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:29913; }","duration":"135.777733ms","start":"2026-08-30T02:20:21.317476Z","end":"2026-08-30T02:20:21.453254Z","steps":["trace[1893753286] 'agreement among raft nodes before linearized reading' (duration: 135.442276ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:21.453356Z","caller":"traceutil/trace.go:171","msg":"trace[647736121] transaction","detail":"{read_only:false; response_revision:29913; number_of_response:1; }","duration":"133.477234ms","start":"2026-08-30T02:20:21.319851Z","end":"2026-08-30T02:20:21.453328Z","steps":["trace[647736121] 'process raft request' (duration: 132.802599ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:21.453415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.479597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-08-30T02:20:21.453588Z","caller":"traceutil/trace.go:171","msg":"trace[1506908099] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:29913; }","duration":"135.701992ms","start":"2026-08-30T02:20:21.317865Z","end":"2026-08-30T02:20:21.453567Z","steps":["trace[1506908099] 'agreement among raft nodes before linearized reading' (duration: 135.239982ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:21.931599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.415865ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:42"} {"level":"warn","ts":"2026-08-30T02:20:21.931716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:21.455031Z","time spent":"476.678909ms","remote":"127.0.0.1:35652","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-08-30T02:20:22.003515Z","caller":"traceutil/trace.go:171","msg":"trace[1167115375] transaction","detail":"{read_only:false; response_revision:29914; number_of_response:1; }","duration":"544.992096ms","start":"2026-08-30T02:20:21.458493Z","end":"2026-08-30T02:20:22.003485Z","steps":["trace[1167115375] 'process raft request' (duration: 544.75798ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:22.003663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:21.458472Z","time spent":"545.113909ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-30T02:20:22.003722Z","caller":"traceutil/trace.go:171","msg":"trace[1237507543] transaction","detail":"{read_only:false; response_revision:29915; number_of_response:1; }","duration":"545.19636ms","start":"2026-08-30T02:20:21.458508Z","end":"2026-08-30T02:20:22.003704Z","steps":["trace[1237507543] 'process raft request' (duration: 544.910384ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:22.003812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:21.458489Z","time spent":"545.278402ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-30T02:20:22.004036Z","caller":"traceutil/trace.go:171","msg":"trace[613660862] transaction","detail":"{read_only:false; response_revision:29916; number_of_response:1; }","duration":"545.519887ms","start":"2026-08-30T02:20:21.458506Z","end":"2026-08-30T02:20:22.004026Z","steps":["trace[613660862] 'process raft request' (duration: 545.143329ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:22.0041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:21.45848Z","time spent":"545.588669ms","remote":"127.0.0.1:35884","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-08-30T02:20:22.004236Z","caller":"traceutil/trace.go:171","msg":"trace[1745192454] transaction","detail":"{read_only:false; response_revision:29917; number_of_response:1; }","duration":"545.247231ms","start":"2026-08-30T02:20:21.458976Z","end":"2026-08-30T02:20:22.004224Z","steps":["trace[1745192454] 'process raft request' (duration: 545.010586ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:22.004278Z","caller":"traceutil/trace.go:171","msg":"trace[2075130971] linearizableReadLoop","detail":"{readStateIndex:30913; appliedIndex:30908; }","duration":"465.238324ms","start":"2026-08-30T02:20:21.539029Z","end":"2026-08-30T02:20:22.004268Z","steps":["trace[2075130971] 'read index received' (duration: 224.198761ms)","trace[2075130971] 'applied index is now lower than readState.Index' (duration: 241.038383ms)"],"step_count":2} {"level":"warn","ts":"2026-08-30T02:20:22.004309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:21.458942Z","time spent":"545.333753ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-30T02:20:22.004337Z","caller":"traceutil/trace.go:171","msg":"trace[1407109664] transaction","detail":"{read_only:false; response_revision:29918; number_of_response:1; }","duration":"463.827884ms","start":"2026-08-30T02:20:21.540501Z","end":"2026-08-30T02:20:22.004329Z","steps":["trace[1407109664] 'process raft request' (duration: 463.688101ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:22.004382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:21.540468Z","time spent":"463.886475ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-30T02:20:22.00472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.651973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jhs9r\" ","response":"range_response_count:1 size:18526"} {"level":"info","ts":"2026-08-30T02:20:22.004854Z","caller":"traceutil/trace.go:171","msg":"trace[1055841018] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jhs9r; range_end:; response_count:1; response_revision:29918; }","duration":"465.829137ms","start":"2026-08-30T02:20:21.538997Z","end":"2026-08-30T02:20:22.004826Z","steps":["trace[1055841018] 'agreement among raft nodes before linearized reading' (duration: 465.367747ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:22.004921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:21.538983Z","time spent":"465.923319ms","remote":"127.0.0.1:35816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18550,"request content":"key:\"/registry/pods/kube-system/cilium-jhs9r\" "} {"level":"info","ts":"2026-08-30T02:20:22.148437Z","caller":"traceutil/trace.go:171","msg":"trace[1181615179] linearizableReadLoop","detail":"{readStateIndex:30915; appliedIndex:30914; }","duration":"144.107112ms","start":"2026-08-30T02:20:22.004299Z","end":"2026-08-30T02:20:22.148406Z","steps":["trace[1181615179] 'read index received' (duration: 76.90719ms)","trace[1181615179] 'applied index is now lower than readState.Index' (duration: 67.198502ms)"],"step_count":2} {"level":"warn","ts":"2026-08-30T02:20:22.148606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.293383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-domain-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-30T02:20:22.148625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.547557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:22.148667Z","caller":"traceutil/trace.go:171","msg":"trace[1000273682] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-user; range_end:; response_count:0; response_revision:29919; }","duration":"244.62224ms","start":"2026-08-30T02:20:21.904035Z","end":"2026-08-30T02:20:22.148657Z","steps":["trace[1000273682] 'agreement among raft nodes before linearized reading' (duration: 244.486417ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:22.148666Z","caller":"traceutil/trace.go:171","msg":"trace[1813890034] range","detail":"{range_begin:/registry/jobs/openstack/magnum-domain-ks-user; range_end:; response_count:0; response_revision:29919; }","duration":"244.399584ms","start":"2026-08-30T02:20:21.904246Z","end":"2026-08-30T02:20:22.148646Z","steps":["trace[1813890034] 'agreement among raft nodes before linearized reading' (duration: 244.164709ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:22.148833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.386174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-30T02:20:22.14886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.652051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-08-30T02:20:22.14887Z","caller":"traceutil/trace.go:171","msg":"trace[1436810998] range","detail":"{range_begin:/registry/jobs/openstack/magnum-rabbit-init; range_end:; response_count:0; response_revision:29919; }","duration":"244.425045ms","start":"2026-08-30T02:20:21.904435Z","end":"2026-08-30T02:20:22.148861Z","steps":["trace[1436810998] 'agreement among raft nodes before linearized reading' (duration: 244.373174ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:22.148938Z","caller":"traceutil/trace.go:171","msg":"trace[905991034] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:29919; }","duration":"245.729843ms","start":"2026-08-30T02:20:21.903159Z","end":"2026-08-30T02:20:22.148888Z","steps":["trace[905991034] 'agreement among raft nodes before linearized reading' (duration: 245.492158ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:22.148626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.692861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-30T02:20:22.149017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.808453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"info","ts":"2026-08-30T02:20:22.148461Z","caller":"traceutil/trace.go:171","msg":"trace[843599485] transaction","detail":"{read_only:false; response_revision:29919; number_of_response:1; }","duration":"215.521155ms","start":"2026-08-30T02:20:21.932885Z","end":"2026-08-30T02:20:22.148406Z","steps":["trace[843599485] 'process raft request' (duration: 148.322103ms)","trace[843599485] 'compare' (duration: 67.057209ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:22.149054Z","caller":"traceutil/trace.go:171","msg":"trace[921884717] range","detail":"{range_begin:/registry/jobs/openstack/magnum-db-sync; range_end:; response_count:1; response_revision:29919; }","duration":"244.893466ms","start":"2026-08-30T02:20:21.904148Z","end":"2026-08-30T02:20:22.149041Z","steps":["trace[921884717] 'agreement among raft nodes before linearized reading' (duration: 244.767932ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:22.149051Z","caller":"traceutil/trace.go:171","msg":"trace[695551819] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-endpoints; range_end:; response_count:0; response_revision:29919; }","duration":"245.12427ms","start":"2026-08-30T02:20:21.903895Z","end":"2026-08-30T02:20:22.149019Z","steps":["trace[695551819] 'agreement among raft nodes before linearized reading' (duration: 244.682611ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:22.149209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.800068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jhs9r\" ","response":"range_response_count:1 size:18526"} {"level":"info","ts":"2026-08-30T02:20:22.149286Z","caller":"traceutil/trace.go:171","msg":"trace[2129080203] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jhs9r; range_end:; response_count:1; response_revision:29919; }","duration":"130.891659ms","start":"2026-08-30T02:20:22.018373Z","end":"2026-08-30T02:20:22.149264Z","steps":["trace[2129080203] 'agreement among raft nodes before linearized reading' (duration: 130.580452ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:22.544748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.666624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jhs9r\" ","response":"range_response_count:1 size:18526"} {"level":"info","ts":"2026-08-30T02:20:22.544855Z","caller":"traceutil/trace.go:171","msg":"trace[616051207] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jhs9r; range_end:; response_count:1; response_revision:29921; }","duration":"102.791187ms","start":"2026-08-30T02:20:22.442018Z","end":"2026-08-30T02:20:22.544809Z","steps":["trace[616051207] 'range keys from in-memory index tree' (duration: 102.423759ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:23.468243Z","caller":"traceutil/trace.go:171","msg":"trace[589581738] linearizableReadLoop","detail":"{readStateIndex:30919; appliedIndex:30918; }","duration":"231.980688ms","start":"2026-08-30T02:20:23.236234Z","end":"2026-08-30T02:20:23.468215Z","steps":["trace[589581738] 'read index received' (duration: 231.780974ms)","trace[589581738] 'applied index is now lower than readState.Index' (duration: 198.174µs)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:23.46831Z","caller":"traceutil/trace.go:171","msg":"trace[1180990869] transaction","detail":"{read_only:false; response_revision:29923; number_of_response:1; }","duration":"234.471651ms","start":"2026-08-30T02:20:23.233805Z","end":"2026-08-30T02:20:23.468277Z","steps":["trace[1180990869] 'process raft request' (duration: 234.225616ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:23.468527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.275975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jhs9r\" ","response":"range_response_count:1 size:18526"} {"level":"info","ts":"2026-08-30T02:20:23.468587Z","caller":"traceutil/trace.go:171","msg":"trace[1545745667] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jhs9r; range_end:; response_count:1; response_revision:29923; }","duration":"232.345566ms","start":"2026-08-30T02:20:23.236216Z","end":"2026-08-30T02:20:23.468561Z","steps":["trace[1545745667] 'agreement among raft nodes before linearized reading' (duration: 232.127821ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:23.684012Z","caller":"traceutil/trace.go:171","msg":"trace[462888616] transaction","detail":"{read_only:false; response_revision:29924; number_of_response:1; }","duration":"258.454006ms","start":"2026-08-30T02:20:23.425533Z","end":"2026-08-30T02:20:23.683987Z","steps":["trace[462888616] 'process raft request' (duration: 258.233762ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:23.684302Z","caller":"traceutil/trace.go:171","msg":"trace[1480717032] transaction","detail":"{read_only:false; response_revision:29925; number_of_response:1; }","duration":"258.704262ms","start":"2026-08-30T02:20:23.425567Z","end":"2026-08-30T02:20:23.684272Z","steps":["trace[1480717032] 'process raft request' (duration: 258.370004ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:23.684374Z","caller":"traceutil/trace.go:171","msg":"trace[763847588] transaction","detail":"{read_only:false; response_revision:29926; number_of_response:1; }","duration":"258.520939ms","start":"2026-08-30T02:20:23.425828Z","end":"2026-08-30T02:20:23.684349Z","steps":["trace[763847588] 'process raft request' (duration: 258.352965ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:23.684657Z","caller":"traceutil/trace.go:171","msg":"trace[1698279478] transaction","detail":"{read_only:false; response_revision:29927; number_of_response:1; }","duration":"258.615671ms","start":"2026-08-30T02:20:23.426016Z","end":"2026-08-30T02:20:23.684631Z","steps":["trace[1698279478] 'process raft request' (duration: 258.282444ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:23.684785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.162625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:23.684814Z","caller":"traceutil/trace.go:171","msg":"trace[183190091] transaction","detail":"{read_only:false; response_revision:29928; number_of_response:1; }","duration":"226.852288ms","start":"2026-08-30T02:20:23.457949Z","end":"2026-08-30T02:20:23.684801Z","steps":["trace[183190091] 'process raft request' (duration: 226.585783ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:23.684856Z","caller":"traceutil/trace.go:171","msg":"trace[1140049984] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:29928; }","duration":"255.280908ms","start":"2026-08-30T02:20:23.429562Z","end":"2026-08-30T02:20:23.684843Z","steps":["trace[1140049984] 'agreement among raft nodes before linearized reading' (duration: 255.145385ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:23.684658Z","caller":"traceutil/trace.go:171","msg":"trace[1676042518] linearizableReadLoop","detail":"{readStateIndex:30924; appliedIndex:30919; }","duration":"216.320373ms","start":"2026-08-30T02:20:23.468311Z","end":"2026-08-30T02:20:23.684631Z","steps":["trace[1676042518] 'read index received' (duration: 215.389782ms)","trace[1676042518] 'applied index is now lower than readState.Index' (duration: 929.431µs)"],"step_count":2} {"level":"warn","ts":"2026-08-30T02:20:23.685105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.784328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-30T02:20:23.685122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.702819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:23.685166Z","caller":"traceutil/trace.go:171","msg":"trace[683667196] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:29928; }","duration":"140.789821ms","start":"2026-08-30T02:20:23.544361Z","end":"2026-08-30T02:20:23.685151Z","steps":["trace[683667196] 'agreement among raft nodes before linearized reading' (duration: 140.697459ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:23.685333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.39715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jhs9r\" ","response":"range_response_count:1 size:18526"} {"level":"info","ts":"2026-08-30T02:20:23.685154Z","caller":"traceutil/trace.go:171","msg":"trace[1193516542] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:29928; }","duration":"207.881711ms","start":"2026-08-30T02:20:23.477259Z","end":"2026-08-30T02:20:23.685141Z","steps":["trace[1193516542] 'agreement among raft nodes before linearized reading' (duration: 207.782608ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:23.685482Z","caller":"traceutil/trace.go:171","msg":"trace[186583806] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jhs9r; range_end:; response_count:1; response_revision:29928; }","duration":"207.603344ms","start":"2026-08-30T02:20:23.477862Z","end":"2026-08-30T02:20:23.685466Z","steps":["trace[186583806] 'agreement among raft nodes before linearized reading' (duration: 207.236587ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:24.122153Z","caller":"traceutil/trace.go:171","msg":"trace[1755600255] transaction","detail":"{read_only:false; response_revision:29930; number_of_response:1; }","duration":"106.613598ms","start":"2026-08-30T02:20:24.015515Z","end":"2026-08-30T02:20:24.122129Z","steps":["trace[1755600255] 'process raft request' (duration: 106.421724ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:24.122494Z","caller":"traceutil/trace.go:171","msg":"trace[1666121416] transaction","detail":"{read_only:false; response_revision:29931; number_of_response:1; }","duration":"106.828323ms","start":"2026-08-30T02:20:24.015641Z","end":"2026-08-30T02:20:24.12247Z","steps":["trace[1666121416] 'process raft request' (duration: 106.444215ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:24.122663Z","caller":"traceutil/trace.go:171","msg":"trace[1294652084] transaction","detail":"{read_only:false; response_revision:29932; number_of_response:1; }","duration":"106.882684ms","start":"2026-08-30T02:20:24.015766Z","end":"2026-08-30T02:20:24.122648Z","steps":["trace[1294652084] 'process raft request' (duration: 106.537886ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:24.51154Z","caller":"traceutil/trace.go:171","msg":"trace[651129154] linearizableReadLoop","detail":"{readStateIndex:30930; appliedIndex:30929; }","duration":"252.058719ms","start":"2026-08-30T02:20:24.259458Z","end":"2026-08-30T02:20:24.511516Z","steps":["trace[651129154] 'read index received' (duration: 251.850545ms)","trace[651129154] 'applied index is now lower than readState.Index' (duration: 206.744µs)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:24.511598Z","caller":"traceutil/trace.go:171","msg":"trace[893600756] transaction","detail":"{read_only:false; response_revision:29934; number_of_response:1; }","duration":"252.924907ms","start":"2026-08-30T02:20:24.25864Z","end":"2026-08-30T02:20:24.511565Z","steps":["trace[893600756] 'process raft request' (duration: 252.671282ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:24.511888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.429147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jhs9r\" ","response":"range_response_count:1 size:18526"} {"level":"info","ts":"2026-08-30T02:20:24.511977Z","caller":"traceutil/trace.go:171","msg":"trace[910178210] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jhs9r; range_end:; response_count:1; response_revision:29934; }","duration":"252.57808ms","start":"2026-08-30T02:20:24.259379Z","end":"2026-08-30T02:20:24.511957Z","steps":["trace[910178210] 'agreement among raft nodes before linearized reading' (duration: 252.254044ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:24.542138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.237981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-domain-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:24.542168Z","caller":"traceutil/trace.go:171","msg":"trace[2107322104] transaction","detail":"{read_only:false; response_revision:29935; number_of_response:1; }","duration":"132.590676ms","start":"2026-08-30T02:20:24.409551Z","end":"2026-08-30T02:20:24.542142Z","steps":["trace[2107322104] 'process raft request' (duration: 132.34113ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:24.542246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.905173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"info","ts":"2026-08-30T02:20:24.542687Z","caller":"traceutil/trace.go:171","msg":"trace[289708795] range","detail":"{range_begin:/registry/jobs/openstack/magnum-db-sync; range_end:; response_count:1; response_revision:29935; }","duration":"209.352013ms","start":"2026-08-30T02:20:24.333293Z","end":"2026-08-30T02:20:24.542645Z","steps":["trace[289708795] 'agreement among raft nodes before linearized reading' (duration: 208.796072ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:24.542274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.427895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:24.542807Z","caller":"traceutil/trace.go:171","msg":"trace[569078355] range","detail":"{range_begin:/registry/jobs/openstack/magnum-rabbit-init; range_end:; response_count:0; response_revision:29935; }","duration":"209.986306ms","start":"2026-08-30T02:20:24.332793Z","end":"2026-08-30T02:20:24.542779Z","steps":["trace[569078355] 'agreement among raft nodes before linearized reading' (duration: 209.436655ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:24.542315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.229448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:24.542959Z","caller":"traceutil/trace.go:171","msg":"trace[809366537] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-user; range_end:; response_count:0; response_revision:29935; }","duration":"159.883481ms","start":"2026-08-30T02:20:24.383046Z","end":"2026-08-30T02:20:24.54293Z","steps":["trace[809366537] 'agreement among raft nodes before linearized reading' (duration: 159.157376ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:24.543084Z","caller":"traceutil/trace.go:171","msg":"trace[503232490] range","detail":"{range_begin:/registry/jobs/openstack/magnum-domain-ks-user; range_end:; response_count:0; response_revision:29935; }","duration":"209.577168ms","start":"2026-08-30T02:20:24.332834Z","end":"2026-08-30T02:20:24.542411Z","steps":["trace[503232490] 'agreement among raft nodes before linearized reading' (duration: 209.246581ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:24.663717Z","caller":"traceutil/trace.go:171","msg":"trace[2048333396] linearizableReadLoop","detail":"{readStateIndex:30932; appliedIndex:30931; }","duration":"121.63771ms","start":"2026-08-30T02:20:24.542048Z","end":"2026-08-30T02:20:24.663686Z","steps":["trace[2048333396] 'read index received' (duration: 66.098807ms)","trace[2048333396] 'applied index is now lower than readState.Index' (duration: 55.537773ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:24.663804Z","caller":"traceutil/trace.go:171","msg":"trace[30059095] transaction","detail":"{read_only:false; response_revision:29936; number_of_response:1; }","duration":"147.436763ms","start":"2026-08-30T02:20:24.516323Z","end":"2026-08-30T02:20:24.66376Z","steps":["trace[30059095] 'process raft request' (duration: 91.823379ms)","trace[30059095] 'compare' (duration: 55.38783ms)"],"step_count":2} {"level":"warn","ts":"2026-08-30T02:20:24.663962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.867417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jhs9r\" ","response":"range_response_count:1 size:18526"} {"level":"info","ts":"2026-08-30T02:20:24.664006Z","caller":"traceutil/trace.go:171","msg":"trace[1725397523] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jhs9r; range_end:; response_count:1; response_revision:29936; }","duration":"142.968458ms","start":"2026-08-30T02:20:24.521026Z","end":"2026-08-30T02:20:24.663994Z","steps":["trace[1725397523] 'agreement among raft nodes before linearized reading' (duration: 142.776374ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:25.632939Z","caller":"traceutil/trace.go:171","msg":"trace[238188516] linearizableReadLoop","detail":"{readStateIndex:30935; appliedIndex:30934; }","duration":"148.032137ms","start":"2026-08-30T02:20:25.484883Z","end":"2026-08-30T02:20:25.632915Z","steps":["trace[238188516] 'read index received' (duration: 147.839473ms)","trace[238188516] 'applied index is now lower than readState.Index' (duration: 191.174µs)"],"step_count":2} {"level":"warn","ts":"2026-08-30T02:20:25.633139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.221611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:25.633212Z","caller":"traceutil/trace.go:171","msg":"trace[1533781485] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:29939; }","duration":"148.335484ms","start":"2026-08-30T02:20:25.484855Z","end":"2026-08-30T02:20:25.63319Z","steps":["trace[1533781485] 'agreement among raft nodes before linearized reading' (duration: 148.17522ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:25.63313Z","caller":"traceutil/trace.go:171","msg":"trace[1878959185] transaction","detail":"{read_only:false; response_revision:29939; number_of_response:1; }","duration":"158.86458ms","start":"2026-08-30T02:20:25.474107Z","end":"2026-08-30T02:20:25.632972Z","steps":["trace[1878959185] 'process raft request' (duration: 158.582404ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:26.04057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.62759ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-30T02:20:26.040713Z","caller":"traceutil/trace.go:171","msg":"trace[354609039] transaction","detail":"{read_only:false; response_revision:29940; number_of_response:1; }","duration":"350.295647ms","start":"2026-08-30T02:20:25.690389Z","end":"2026-08-30T02:20:26.040684Z","steps":["trace[354609039] 'process raft request' (duration: 78.412993ms)","trace[354609039] 'compare' (duration: 271.329242ms)"],"step_count":2} {"level":"warn","ts":"2026-08-30T02:20:26.040983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:25.690371Z","time spent":"350.555823ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-30T02:20:26.131278Z","caller":"traceutil/trace.go:171","msg":"trace[629887868] transaction","detail":"{read_only:false; response_revision:29941; number_of_response:1; }","duration":"440.667827ms","start":"2026-08-30T02:20:25.690557Z","end":"2026-08-30T02:20:26.131224Z","steps":["trace[629887868] 'process raft request' (duration: 440.438642ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:26.131496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:25.690533Z","time spent":"440.84395ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-30T02:20:26.131599Z","caller":"traceutil/trace.go:171","msg":"trace[1522824139] transaction","detail":"{read_only:false; response_revision:29942; number_of_response:1; }","duration":"440.85982ms","start":"2026-08-30T02:20:25.69072Z","end":"2026-08-30T02:20:26.13158Z","steps":["trace[1522824139] 'process raft request' (duration: 440.438772ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:26.131708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:25.690693Z","time spent":"440.957443ms","remote":"127.0.0.1:35884","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-08-30T02:20:26.13206Z","caller":"traceutil/trace.go:171","msg":"trace[2030899226] linearizableReadLoop","detail":"{readStateIndex:30940; appliedIndex:30935; }","duration":"382.098999ms","start":"2026-08-30T02:20:25.749938Z","end":"2026-08-30T02:20:26.132037Z","steps":["trace[2030899226] 'read index received' (duration: 18.855074ms)","trace[2030899226] 'applied index is now lower than readState.Index' (duration: 363.242625ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:26.132152Z","caller":"traceutil/trace.go:171","msg":"trace[782151930] transaction","detail":"{read_only:false; response_revision:29943; number_of_response:1; }","duration":"441.076896ms","start":"2026-08-30T02:20:25.691047Z","end":"2026-08-30T02:20:26.132124Z","steps":["trace[782151930] 'process raft request' (duration: 440.459473ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:26.132197Z","caller":"traceutil/trace.go:171","msg":"trace[29418194] transaction","detail":"{read_only:false; response_revision:29944; number_of_response:1; }","duration":"440.459862ms","start":"2026-08-30T02:20:25.691724Z","end":"2026-08-30T02:20:26.132184Z","steps":["trace[29418194] 'process raft request' (duration: 440.197717ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:26.132258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:25.691031Z","time spent":"441.175288ms","remote":"127.0.0.1:35884","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-08-30T02:20:26.132307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:25.691714Z","time spent":"440.506853ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-30T02:20:26.132352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.981654ms","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-08-30T02:20:26.132457Z","caller":"traceutil/trace.go:171","msg":"trace[2079597495] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:29944; }","duration":"373.091776ms","start":"2026-08-30T02:20:25.759322Z","end":"2026-08-30T02:20:26.132414Z","steps":["trace[2079597495] 'agreement among raft nodes before linearized reading' (duration: 372.920992ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:26.132507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:25.75931Z","time spent":"373.188759ms","remote":"127.0.0.1:36068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":30,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-08-30T02:20:26.132495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.902628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/floatingips/\" range_end:\"/registry/openstack.k-orc.cloud/floatingips0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:26.132575Z","caller":"traceutil/trace.go:171","msg":"trace[1348238618] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/floatingips/; range_end:/registry/openstack.k-orc.cloud/floatingips0; response_count:0; response_revision:29944; }","duration":"158.021571ms","start":"2026-08-30T02:20:25.97453Z","end":"2026-08-30T02:20:26.132552Z","steps":["trace[1348238618] 'agreement among raft nodes before linearized reading' (duration: 157.863438ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:26.132587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.642412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:26.132644Z","caller":"traceutil/trace.go:171","msg":"trace[372806294] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:29944; }","duration":"382.739035ms","start":"2026-08-30T02:20:25.749888Z","end":"2026-08-30T02:20:26.132627Z","steps":["trace[372806294] 'agreement among raft nodes before linearized reading' (duration: 382.656992ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:26.132694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:25.749866Z","time spent":"382.817896ms","remote":"127.0.0.1:35636","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-08-30T02:20:26.132853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.577464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-hxk8z\" ","response":"range_response_count:1 size:4695"} {"level":"info","ts":"2026-08-30T02:20:26.132896Z","caller":"traceutil/trace.go:171","msg":"trace[2120610540] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-hxk8z; range_end:; response_count:1; response_revision:29944; }","duration":"350.665246ms","start":"2026-08-30T02:20:25.782215Z","end":"2026-08-30T02:20:26.13288Z","steps":["trace[2120610540] 'agreement among raft nodes before linearized reading' (duration: 350.497872ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:26.132921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:25.782192Z","time spent":"350.722968ms","remote":"127.0.0.1:35816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4719,"request content":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-hxk8z\" "} {"level":"warn","ts":"2026-08-30T02:20:26.362642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.501965ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-30T02:20:26.362963Z","caller":"traceutil/trace.go:171","msg":"trace[1085149242] transaction","detail":"{read_only:false; response_revision:29945; number_of_response:1; }","duration":"225.852617ms","start":"2026-08-30T02:20:26.137047Z","end":"2026-08-30T02:20:26.3629Z","steps":["trace[1085149242] 'process raft request' (duration: 44.965575ms)","trace[1085149242] 'compare' (duration: 180.28882ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:26.363013Z","caller":"traceutil/trace.go:171","msg":"trace[1401111206] transaction","detail":"{read_only:false; response_revision:29946; number_of_response:1; }","duration":"224.887577ms","start":"2026-08-30T02:20:26.13809Z","end":"2026-08-30T02:20:26.362977Z","steps":["trace[1401111206] 'process raft request' (duration: 224.714833ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:26.363034Z","caller":"traceutil/trace.go:171","msg":"trace[1556789572] transaction","detail":"{read_only:false; response_revision:29947; number_of_response:1; }","duration":"224.818534ms","start":"2026-08-30T02:20:26.138181Z","end":"2026-08-30T02:20:26.363Z","steps":["trace[1556789572] 'process raft request' (duration: 224.697002ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:26.363001Z","caller":"traceutil/trace.go:171","msg":"trace[645451040] linearizableReadLoop","detail":"{readStateIndex:30944; appliedIndex:30940; }","duration":"223.18792ms","start":"2026-08-30T02:20:26.139786Z","end":"2026-08-30T02:20:26.362974Z","steps":["trace[645451040] 'read index received' (duration: 42.335808ms)","trace[645451040] 'applied index is now lower than readState.Index' (duration: 180.850642ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:26.363101Z","caller":"traceutil/trace.go:171","msg":"trace[483065919] transaction","detail":"{read_only:false; response_revision:29948; number_of_response:1; }","duration":"224.780644ms","start":"2026-08-30T02:20:26.13828Z","end":"2026-08-30T02:20:26.363061Z","steps":["trace[483065919] 'process raft request' (duration: 224.642081ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:26.363209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.417955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-hxk8z\" ","response":"range_response_count:1 size:4695"} {"level":"info","ts":"2026-08-30T02:20:26.363265Z","caller":"traceutil/trace.go:171","msg":"trace[237981626] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-hxk8z; range_end:; response_count:1; response_revision:29948; }","duration":"223.497677ms","start":"2026-08-30T02:20:26.139753Z","end":"2026-08-30T02:20:26.36325Z","steps":["trace[237981626] 'agreement among raft nodes before linearized reading' (duration: 223.279022ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:26.363297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.400848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-30T02:20:26.36331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.332143ms","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-08-30T02:20:26.363368Z","caller":"traceutil/trace.go:171","msg":"trace[2099464812] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-endpoints; range_end:; response_count:0; response_revision:29948; }","duration":"123.518251ms","start":"2026-08-30T02:20:26.239834Z","end":"2026-08-30T02:20:26.363352Z","steps":["trace[2099464812] 'agreement among raft nodes before linearized reading' (duration: 123.377588ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:26.363388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.50037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-30T02:20:26.363296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.925275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-30T02:20:26.363421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.134064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:26.363465Z","caller":"traceutil/trace.go:171","msg":"trace[668212054] range","detail":"{range_begin:/registry/jobs/openstack/magnum-rabbit-init; range_end:; response_count:0; response_revision:29948; }","duration":"123.593642ms","start":"2026-08-30T02:20:26.239822Z","end":"2026-08-30T02:20:26.363416Z","steps":["trace[668212054] 'agreement among raft nodes before linearized reading' (duration: 123.50527ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:26.363375Z","caller":"traceutil/trace.go:171","msg":"trace[1715116450] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:29948; }","duration":"223.425955ms","start":"2026-08-30T02:20:26.139932Z","end":"2026-08-30T02:20:26.363357Z","steps":["trace[1715116450] 'agreement among raft nodes before linearized reading' (duration: 223.270082ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:26.363488Z","caller":"traceutil/trace.go:171","msg":"trace[734893484] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-user; range_end:; response_count:0; response_revision:29948; }","duration":"124.227945ms","start":"2026-08-30T02:20:26.239247Z","end":"2026-08-30T02:20:26.363475Z","steps":["trace[734893484] 'agreement among raft nodes before linearized reading' (duration: 124.150444ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:26.363489Z","caller":"traceutil/trace.go:171","msg":"trace[606795360] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-endpoints; range_end:; response_count:0; response_revision:29948; }","duration":"107.148719ms","start":"2026-08-30T02:20:26.256313Z","end":"2026-08-30T02:20:26.363462Z","steps":["trace[606795360] 'agreement among raft nodes before linearized reading' (duration: 106.900654ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:26.363576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.96719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"info","ts":"2026-08-30T02:20:26.363646Z","caller":"traceutil/trace.go:171","msg":"trace[436683408] range","detail":"{range_begin:/registry/jobs/openstack/magnum-db-sync; range_end:; response_count:1; response_revision:29948; }","duration":"124.039212ms","start":"2026-08-30T02:20:26.23959Z","end":"2026-08-30T02:20:26.363629Z","steps":["trace[436683408] 'agreement among raft nodes before linearized reading' (duration: 123.766776ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:26.363656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.886049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-domain-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:26.363701Z","caller":"traceutil/trace.go:171","msg":"trace[2008015596] range","detail":"{range_begin:/registry/jobs/openstack/magnum-domain-ks-user; range_end:; response_count:0; response_revision:29948; }","duration":"123.95026ms","start":"2026-08-30T02:20:26.239738Z","end":"2026-08-30T02:20:26.363688Z","steps":["trace[2008015596] 'agreement among raft nodes before linearized reading' (duration: 123.878218ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:27.88654Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.31076789s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-30T02:20:28.16301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.587394815s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-08-30T02:20:28.163237Z","caller":"traceutil/trace.go:171","msg":"trace[1085949231] linearizableReadLoop","detail":"{readStateIndex:30945; appliedIndex:30944; }","duration":"1.64720424s","start":"2026-08-30T02:20:26.516012Z","end":"2026-08-30T02:20:28.163216Z","steps":["trace[1085949231] 'read index received' (duration: 59.821995ms)","trace[1085949231] 'applied index is now lower than readState.Index' (duration: 1.587381325s)"],"step_count":2} {"level":"warn","ts":"2026-08-30T02:20:28.163472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.647460815s","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-08-30T02:20:28.163502Z","caller":"traceutil/trace.go:171","msg":"trace[312682814] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:29948; }","duration":"1.647539037s","start":"2026-08-30T02:20:26.515951Z","end":"2026-08-30T02:20:28.16349Z","steps":["trace[312682814] 'agreement among raft nodes before linearized reading' (duration: 1.647368553s)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:28.163549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:26.515926Z","time spent":"1.647599639s","remote":"127.0.0.1:35884","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-08-30T02:20:28.164585Z","caller":"traceutil/trace.go:171","msg":"trace[19978971] transaction","detail":"{read_only:false; response_revision:29949; number_of_response:1; }","duration":"1.616215555s","start":"2026-08-30T02:20:26.548332Z","end":"2026-08-30T02:20:28.164547Z","steps":["trace[19978971] 'process raft request' (duration: 1.614785294s)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:28.164776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:26.548312Z","time spent":"1.616358398s","remote":"127.0.0.1:35884","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-08-30T02:20:28.350825Z","caller":"traceutil/trace.go:171","msg":"trace[925159923] transaction","detail":"{read_only:false; response_revision:29950; number_of_response:1; }","duration":"1.317610437s","start":"2026-08-30T02:20:27.033185Z","end":"2026-08-30T02:20:28.350796Z","steps":["trace[925159923] 'process raft request' (duration: 1.225048321s)","trace[925159923] 'compare' (duration: 92.240319ms)"],"step_count":2} {"level":"warn","ts":"2026-08-30T02:20:28.350965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:27.033158Z","time spent":"1.317727679s","remote":"127.0.0.1:35884","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-08-30T02:20:28.351029Z","caller":"traceutil/trace.go:171","msg":"trace[1991600475] transaction","detail":"{read_only:false; response_revision:29951; number_of_response:1; }","duration":"712.50711ms","start":"2026-08-30T02:20:27.638476Z","end":"2026-08-30T02:20:28.350983Z","steps":["trace[1991600475] 'process raft request' (duration: 712.221384ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:28.35125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:27.63845Z","time spent":"712.670154ms","remote":"127.0.0.1:35884","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-08-30T02:20:28.419706Z","caller":"traceutil/trace.go:171","msg":"trace[69934876] transaction","detail":"{read_only:false; response_revision:29952; number_of_response:1; }","duration":"372.937583ms","start":"2026-08-30T02:20:28.046711Z","end":"2026-08-30T02:20:28.419649Z","steps":["trace[69934876] 'process raft request' (duration: 372.598906ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:28.419737Z","caller":"traceutil/trace.go:171","msg":"trace[893497912] transaction","detail":"{read_only:false; response_revision:29953; number_of_response:1; }","duration":"282.948632ms","start":"2026-08-30T02:20:28.136753Z","end":"2026-08-30T02:20:28.419702Z","steps":["trace[893497912] 'process raft request' (duration: 282.810709ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:28.419892Z","caller":"traceutil/trace.go:171","msg":"trace[361543521] transaction","detail":"{read_only:false; response_revision:29954; number_of_response:1; }","duration":"281.874729ms","start":"2026-08-30T02:20:28.137995Z","end":"2026-08-30T02:20:28.41987Z","steps":["trace[361543521] 'process raft request' (duration: 281.637614ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:28.419946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:28.046686Z","time spent":"373.122127ms","remote":"127.0.0.1:35884","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-30T02:20:28.420128Z","caller":"traceutil/trace.go:171","msg":"trace[1866352245] transaction","detail":"{read_only:false; response_revision:29955; number_of_response:1; }","duration":"281.48229ms","start":"2026-08-30T02:20:28.138608Z","end":"2026-08-30T02:20:28.42009Z","steps":["trace[1866352245] 'process raft request' (duration: 281.158723ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:28.420187Z","caller":"traceutil/trace.go:171","msg":"trace[319234113] transaction","detail":"{read_only:false; response_revision:29956; number_of_response:1; }","duration":"281.501541ms","start":"2026-08-30T02:20:28.138672Z","end":"2026-08-30T02:20:28.420173Z","steps":["trace[319234113] 'process raft request' (duration: 281.346098ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:28.420199Z","caller":"traceutil/trace.go:171","msg":"trace[1265872407] transaction","detail":"{read_only:false; response_revision:29957; number_of_response:1; }","duration":"251.371225ms","start":"2026-08-30T02:20:28.168806Z","end":"2026-08-30T02:20:28.420178Z","steps":["trace[1265872407] 'process raft request' (duration: 251.299683ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:28.420205Z","caller":"traceutil/trace.go:171","msg":"trace[81781446] linearizableReadLoop","detail":"{readStateIndex:30953; appliedIndex:30946; }","duration":"256.916004ms","start":"2026-08-30T02:20:28.163264Z","end":"2026-08-30T02:20:28.42018Z","steps":["trace[81781446] 'read index received' (duration: 94.992719ms)","trace[81781446] 'applied index is now lower than readState.Index' (duration: 161.920855ms)"],"step_count":2} {"level":"warn","ts":"2026-08-30T02:20:28.420352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.872560536s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:28.420397Z","caller":"traceutil/trace.go:171","msg":"trace[1845660543] range","detail":"{range_begin:/registry/jobs/openstack/magnum-rabbit-init; range_end:; response_count:0; response_revision:29957; }","duration":"1.872678628s","start":"2026-08-30T02:20:26.547708Z","end":"2026-08-30T02:20:28.420387Z","steps":["trace[1845660543] 'agreement among raft nodes before linearized reading' (duration: 1.872577106s)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:28.420444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.856452ms","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":"warn","ts":"2026-08-30T02:20:28.420451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:26.547683Z","time spent":"1.872760261s","remote":"127.0.0.1:35866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":30,"request content":"key:\"/registry/jobs/openstack/magnum-rabbit-init\" "} {"level":"warn","ts":"2026-08-30T02:20:28.420458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.873057627s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-db-sync\" ","response":"range_response_count:1 size:5080"} {"level":"info","ts":"2026-08-30T02:20:28.420511Z","caller":"traceutil/trace.go:171","msg":"trace[1905026350] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:29957; }","duration":"194.966133ms","start":"2026-08-30T02:20:28.225507Z","end":"2026-08-30T02:20:28.420473Z","steps":["trace[1905026350] 'agreement among raft nodes before linearized reading' (duration: 194.862801ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:28.42053Z","caller":"traceutil/trace.go:171","msg":"trace[66711667] range","detail":"{range_begin:/registry/jobs/openstack/magnum-db-sync; range_end:; response_count:1; response_revision:29957; }","duration":"1.873189429s","start":"2026-08-30T02:20:26.54732Z","end":"2026-08-30T02:20:28.42051Z","steps":["trace[66711667] 'agreement among raft nodes before linearized reading' (duration: 1.872921223s)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:28.420576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:26.547304Z","time spent":"1.873259991s","remote":"127.0.0.1:35866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":5104,"request content":"key:\"/registry/jobs/openstack/magnum-db-sync\" "} {"level":"warn","ts":"2026-08-30T02:20:28.420587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.230350563s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1634"} {"level":"info","ts":"2026-08-30T02:20:28.420682Z","caller":"traceutil/trace.go:171","msg":"trace[394711654] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:29957; }","duration":"1.230473416s","start":"2026-08-30T02:20:27.190183Z","end":"2026-08-30T02:20:28.420656Z","steps":["trace[394711654] 'agreement among raft nodes before linearized reading' (duration: 1.230290662s)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:28.420723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.670379267s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-30T02:20:28.420739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:27.190163Z","time spent":"1.230561989s","remote":"127.0.0.1:35794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1658,"request content":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" "} {"level":"info","ts":"2026-08-30T02:20:28.420772Z","caller":"traceutil/trace.go:171","msg":"trace[947100853] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:29957; }","duration":"1.670463318s","start":"2026-08-30T02:20:26.750296Z","end":"2026-08-30T02:20:28.420759Z","steps":["trace[947100853] 'agreement among raft nodes before linearized reading' (duration: 1.670386027s)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:28.420808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:26.750275Z","time spent":"1.67052635s","remote":"127.0.0.1:35636","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-08-30T02:20:28.420689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.872662008s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:28.420915Z","caller":"traceutil/trace.go:171","msg":"trace[638061768] range","detail":"{range_begin:/registry/jobs/openstack/magnum-ks-user; range_end:; response_count:0; response_revision:29957; }","duration":"1.872898753s","start":"2026-08-30T02:20:26.548Z","end":"2026-08-30T02:20:28.420899Z","steps":["trace[638061768] 'agreement among raft nodes before linearized reading' (duration: 1.872639238s)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:28.420964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:26.547991Z","time spent":"1.872960724s","remote":"127.0.0.1:35866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":30,"request content":"key:\"/registry/jobs/openstack/magnum-ks-user\" "} {"level":"warn","ts":"2026-08-30T02:20:28.420395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.780092131s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-6tn9m\" ","response":"range_response_count:1 size:4906"} {"level":"info","ts":"2026-08-30T02:20:28.421195Z","caller":"traceutil/trace.go:171","msg":"trace[2049974671] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-6tn9m; range_end:; response_count:1; response_revision:29957; }","duration":"1.780945759s","start":"2026-08-30T02:20:26.640232Z","end":"2026-08-30T02:20:28.421178Z","steps":["trace[2049974671] 'agreement among raft nodes before linearized reading' (duration: 1.779960298s)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:28.421256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:26.640208Z","time spent":"1.781031561s","remote":"127.0.0.1:35816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":4930,"request content":"key:\"/registry/pods/kube-system/coredns-67659f764b-6tn9m\" "} {"level":"warn","ts":"2026-08-30T02:20:28.420755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.873111358s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/magnum-domain-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-30T02:20:28.421748Z","caller":"traceutil/trace.go:171","msg":"trace[1984136280] range","detail":"{range_begin:/registry/jobs/openstack/magnum-domain-ks-user; range_end:; response_count:0; response_revision:29957; }","duration":"1.87412914s","start":"2026-08-30T02:20:26.547605Z","end":"2026-08-30T02:20:28.421734Z","steps":["trace[1984136280] 'agreement among raft nodes before linearized reading' (duration: 1.873117557s)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:28.421829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-30T02:20:26.547595Z","time spent":"1.874221552s","remote":"127.0.0.1:35866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":30,"request content":"key:\"/registry/jobs/openstack/magnum-domain-ks-user\" "} {"level":"warn","ts":"2026-08-30T02:20:28.564307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.033747ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-30T02:20:28.564466Z","caller":"traceutil/trace.go:171","msg":"trace[287252628] linearizableReadLoop","detail":"{readStateIndex:30955; appliedIndex:30954; }","duration":"134.077397ms","start":"2026-08-30T02:20:28.430367Z","end":"2026-08-30T02:20:28.564445Z","steps":["trace[287252628] 'read index received' (duration: 33.794305ms)","trace[287252628] 'applied index is now lower than readState.Index' (duration: 100.281422ms)"],"step_count":2} {"level":"info","ts":"2026-08-30T02:20:28.564519Z","caller":"traceutil/trace.go:171","msg":"trace[902264726] transaction","detail":"{read_only:false; response_revision:29958; number_of_response:1; }","duration":"135.503128ms","start":"2026-08-30T02:20:28.428979Z","end":"2026-08-30T02:20:28.564483Z","steps":["trace[902264726] 'process raft request' (duration: 35.166435ms)","trace[902264726] 'compare' (duration: 99.850252ms)"],"step_count":2} {"level":"warn","ts":"2026-08-30T02:20:28.564706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.309862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-cf528109-c1cd-4e2a-b48a-2db874924d32\" ","response":"range_response_count:1 size:1294"} {"level":"info","ts":"2026-08-30T02:20:28.564771Z","caller":"traceutil/trace.go:171","msg":"trace[2043555267] range","detail":"{range_begin:/registry/persistentvolumes/pvc-cf528109-c1cd-4e2a-b48a-2db874924d32; range_end:; response_count:1; response_revision:29958; }","duration":"134.431105ms","start":"2026-08-30T02:20:28.430323Z","end":"2026-08-30T02:20:28.564754Z","steps":["trace[2043555267] 'agreement among raft nodes before linearized reading' (duration: 134.18091ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:28.641564Z","caller":"traceutil/trace.go:171","msg":"trace[1333655746] transaction","detail":"{read_only:false; response_revision:29959; number_of_response:1; }","duration":"209.726852ms","start":"2026-08-30T02:20:28.431811Z","end":"2026-08-30T02:20:28.641538Z","steps":["trace[1333655746] 'process raft request' (duration: 209.464916ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:28.641892Z","caller":"traceutil/trace.go:171","msg":"trace[1043573661] transaction","detail":"{read_only:false; response_revision:29960; number_of_response:1; }","duration":"209.936016ms","start":"2026-08-30T02:20:28.431905Z","end":"2026-08-30T02:20:28.641841Z","steps":["trace[1043573661] 'process raft request' (duration: 209.585899ms)"],"step_count":1} {"level":"warn","ts":"2026-08-30T02:20:28.642031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.17829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-30T02:20:28.64209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.433247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-6tn9m\" ","response":"range_response_count:1 size:4906"} {"level":"info","ts":"2026-08-30T02:20:28.642112Z","caller":"traceutil/trace.go:171","msg":"trace[2035593119] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:29961; }","duration":"210.294513ms","start":"2026-08-30T02:20:28.431796Z","end":"2026-08-30T02:20:28.642091Z","steps":["trace[2035593119] 'agreement among raft nodes before linearized reading' (duration: 210.12852ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:28.642145Z","caller":"traceutil/trace.go:171","msg":"trace[717878144] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-6tn9m; range_end:; response_count:1; response_revision:29961; }","duration":"122.550129ms","start":"2026-08-30T02:20:28.519581Z","end":"2026-08-30T02:20:28.642131Z","steps":["trace[717878144] 'agreement among raft nodes before linearized reading' (duration: 122.343525ms)"],"step_count":1} {"level":"info","ts":"2026-08-30T02:20:28.642398Z","caller":"traceutil/trace.go:171","msg":"trace[1674102606] transaction","detail":"{read_only:false; response_revision:29961; number_of_response:1; }","duration":"209.442514ms","start":"2026-08-30T02:20:28.432939Z","end":"2026-08-30T02:20:28.642381Z","steps":["trace[1674102606] 'process raft request' (duration: 208.797401ms)"],"step_count":1}