{"level":"warn","ts":"2026-10-02T04:43:33.649054Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-02T04:43:33.649145Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.223: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.223:2380","--initial-cluster=instance=https://162.253.55.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.223: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-10-02T04:43:33.649199Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-02T04:43:33.649206Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.223:2380"]} {"level":"info","ts":"2026-10-02T04:43:33.649222Z","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-10-02T04:43:33.649789Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.223:2379"]} {"level":"info","ts":"2026-10-02T04:43:33.649868Z","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":8,"max-cpu-available":8,"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.223:2380"],"listen-peer-urls":["https://162.253.55.223:2380"],"advertise-client-urls":["https://162.253.55.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.223: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-10-02T04:43:33.655443Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.38256ms"} {"level":"info","ts":"2026-10-02T04:43:33.669227Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a0f50f8a6c5f7d06","cluster-id":"62f129f77cf8e487"} {"level":"info","ts":"2026-10-02T04:43:33.669298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 switched to configuration voters=()"} {"level":"info","ts":"2026-10-02T04:43:33.669317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became follower at term 0"} {"level":"info","ts":"2026-10-02T04:43:33.669327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a0f50f8a6c5f7d06 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-02T04:43:33.669336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became follower at term 1"} {"level":"info","ts":"2026-10-02T04:43:33.66937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 switched to configuration voters=(11598193502560681222)"} {"level":"warn","ts":"2026-10-02T04:43:33.679699Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-02T04:43:33.683894Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-02T04:43:33.685387Z","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-10-02T04:43:33.68884Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a0f50f8a6c5f7d06","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-02T04:43:33.689265Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a0f50f8a6c5f7d06","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-02T04:43:33.689389Z","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-10-02T04:43:33.689439Z","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-10-02T04:43:33.689446Z","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-10-02T04:43:33.691094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 switched to configuration voters=(11598193502560681222)"} {"level":"info","ts":"2026-10-02T04:43:33.69161Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62f129f77cf8e487","local-member-id":"a0f50f8a6c5f7d06","added-peer-id":"a0f50f8a6c5f7d06","added-peer-peer-urls":["https://162.253.55.223:2380"]} {"level":"info","ts":"2026-10-02T04:43:33.696106Z","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-10-02T04:43:33.696343Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a0f50f8a6c5f7d06","initial-advertise-peer-urls":["https://162.253.55.223:2380"],"listen-peer-urls":["https://162.253.55.223:2380"],"advertise-client-urls":["https://162.253.55.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-02T04:43:33.696367Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-02T04:43:33.696537Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.223:2380"} {"level":"info","ts":"2026-10-02T04:43:33.696549Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.223:2380"} {"level":"info","ts":"2026-10-02T04:43:33.770312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 is starting a new election at term 1"} {"level":"info","ts":"2026-10-02T04:43:33.770401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-02T04:43:33.770435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 received MsgPreVoteResp from a0f50f8a6c5f7d06 at term 1"} {"level":"info","ts":"2026-10-02T04:43:33.770457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became candidate at term 2"} {"level":"info","ts":"2026-10-02T04:43:33.770468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 received MsgVoteResp from a0f50f8a6c5f7d06 at term 2"} {"level":"info","ts":"2026-10-02T04:43:33.770485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a0f50f8a6c5f7d06 became leader at term 2"} {"level":"info","ts":"2026-10-02T04:43:33.770496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a0f50f8a6c5f7d06 elected leader a0f50f8a6c5f7d06 at term 2"} {"level":"info","ts":"2026-10-02T04:43:33.771596Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a0f50f8a6c5f7d06","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.223:2379]}","request-path":"/0/members/a0f50f8a6c5f7d06/attributes","cluster-id":"62f129f77cf8e487","publish-timeout":"7s"} {"level":"info","ts":"2026-10-02T04:43:33.771779Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T04:43:33.771912Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-02T04:43:33.772036Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-02T04:43:33.772314Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-02T04:43:33.772377Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-02T04:43:33.772812Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62f129f77cf8e487","local-member-id":"a0f50f8a6c5f7d06","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T04:43:33.772921Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T04:43:33.772972Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-02T04:43:33.774695Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-02T04:43:33.775017Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.223:2379"} {"level":"info","ts":"2026-10-02T04:44:02.109444Z","caller":"traceutil/trace.go:171","msg":"trace[808263832] linearizableReadLoop","detail":"{readStateIndex:486; appliedIndex:485; }","duration":"108.432674ms","start":"2026-10-02T04:44:02.000984Z","end":"2026-10-02T04:44:02.109417Z","steps":["trace[808263832] 'read index received' (duration: 108.185212ms)","trace[808263832] 'applied index is now lower than readState.Index' (duration: 246.542µs)"],"step_count":2} {"level":"info","ts":"2026-10-02T04:44:02.109504Z","caller":"traceutil/trace.go:171","msg":"trace[817544353] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"114.916788ms","start":"2026-10-02T04:44:01.99456Z","end":"2026-10-02T04:44:02.109477Z","steps":["trace[817544353] 'process raft request' (duration: 114.694257ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:44:02.109652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.583932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-02T04:44:02.109715Z","caller":"traceutil/trace.go:171","msg":"trace[1657324837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:469; }","duration":"108.722648ms","start":"2026-10-02T04:44:02.00098Z","end":"2026-10-02T04:44:02.109702Z","steps":["trace[1657324837] 'agreement among raft nodes before linearized reading' (duration: 108.55493ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:44:11.892953Z","caller":"traceutil/trace.go:171","msg":"trace[1224209360] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"173.506062ms","start":"2026-10-02T04:44:11.719419Z","end":"2026-10-02T04:44:11.892925Z","steps":["trace[1224209360] 'process raft request' (duration: 173.377595ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:44:11.892979Z","caller":"traceutil/trace.go:171","msg":"trace[478124377] linearizableReadLoop","detail":"{readStateIndex:544; appliedIndex:544; }","duration":"156.780053ms","start":"2026-10-02T04:44:11.73617Z","end":"2026-10-02T04:44:11.89295Z","steps":["trace[478124377] 'read index received' (duration: 156.770322ms)","trace[478124377] 'applied index is now lower than readState.Index' (duration: 7.851µs)"],"step_count":2} {"level":"warn","ts":"2026-10-02T04:44:11.893147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.958922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T04:44:11.893192Z","caller":"traceutil/trace.go:171","msg":"trace[289830779] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:525; }","duration":"157.051857ms","start":"2026-10-02T04:44:11.736119Z","end":"2026-10-02T04:44:11.893171Z","steps":["trace[289830779] 'agreement among raft nodes before linearized reading' (duration: 156.935001ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:44:11.909895Z","caller":"traceutil/trace.go:171","msg":"trace[601003562] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"103.348283ms","start":"2026-10-02T04:44:11.806511Z","end":"2026-10-02T04:44:11.909859Z","steps":["trace[601003562] 'process raft request' (duration: 100.726268ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:44:12.54147Z","caller":"traceutil/trace.go:171","msg":"trace[1274385311] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"144.595396ms","start":"2026-10-02T04:44:12.39683Z","end":"2026-10-02T04:44:12.541426Z","steps":["trace[1274385311] 'process raft request' (duration: 122.72007ms)","trace[1274385311] 'compare' (duration: 21.674076ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T04:44:12.543872Z","caller":"traceutil/trace.go:171","msg":"trace[2078519676] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"131.773932ms","start":"2026-10-02T04:44:12.41208Z","end":"2026-10-02T04:44:12.543853Z","steps":["trace[2078519676] 'process raft request' (duration: 131.667166ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:44:12.544153Z","caller":"traceutil/trace.go:171","msg":"trace[628547727] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"134.642439ms","start":"2026-10-02T04:44:12.409496Z","end":"2026-10-02T04:44:12.544139Z","steps":["trace[628547727] 'process raft request' (duration: 134.0365ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:44:13.889409Z","caller":"traceutil/trace.go:171","msg":"trace[1628365128] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"124.882554ms","start":"2026-10-02T04:44:13.764505Z","end":"2026-10-02T04:44:13.889387Z","steps":["trace[1628365128] 'process raft request' (duration: 114.812812ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:44:14.139939Z","caller":"traceutil/trace.go:171","msg":"trace[532363936] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"237.479592ms","start":"2026-10-02T04:44:13.902429Z","end":"2026-10-02T04:44:14.139908Z","steps":["trace[532363936] 'process raft request' (duration: 235.910796ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:44:18.396398Z","caller":"traceutil/trace.go:171","msg":"trace[1741434900] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"189.299716ms","start":"2026-10-02T04:44:18.20707Z","end":"2026-10-02T04:44:18.396369Z","steps":["trace[1741434900] 'read index received' (duration: 189.248803ms)","trace[1741434900] 'applied index is now lower than readState.Index' (duration: 49.533µs)"],"step_count":2} {"level":"info","ts":"2026-10-02T04:44:18.396516Z","caller":"traceutil/trace.go:171","msg":"trace[853903598] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"215.685103ms","start":"2026-10-02T04:44:18.18082Z","end":"2026-10-02T04:44:18.396506Z","steps":["trace[853903598] 'process raft request' (duration: 215.325715ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:44:18.396728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.640472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-02T04:44:18.39682Z","caller":"traceutil/trace.go:171","msg":"trace[1835817468] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:621; }","duration":"189.768788ms","start":"2026-10-02T04:44:18.207022Z","end":"2026-10-02T04:44:18.396791Z","steps":["trace[1835817468] 'agreement among raft nodes before linearized reading' (duration: 189.572679ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:44:18.444096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.538723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-02T04:44:18.444174Z","caller":"traceutil/trace.go:171","msg":"trace[699947565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:622; }","duration":"228.649318ms","start":"2026-10-02T04:44:18.215507Z","end":"2026-10-02T04:44:18.444156Z","steps":["trace[699947565] 'agreement among raft nodes before linearized reading' (duration: 228.455699ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:44:18.444287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.869589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-10-02T04:44:18.44438Z","caller":"traceutil/trace.go:171","msg":"trace[314297232] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:622; }","duration":"205.006726ms","start":"2026-10-02T04:44:18.23935Z","end":"2026-10-02T04:44:18.444357Z","steps":["trace[314297232] 'agreement among raft nodes before linearized reading' (duration: 204.730353ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:44:19.039071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.071971ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-02T04:44:19.039337Z","caller":"traceutil/trace.go:171","msg":"trace[22144556] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"591.135325ms","start":"2026-10-02T04:44:18.448161Z","end":"2026-10-02T04:44:19.039297Z","steps":["trace[22144556] 'process raft request' (duration: 176.239494ms)","trace[22144556] 'compare' (duration: 413.912323ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T04:44:19.039405Z","caller":"traceutil/trace.go:171","msg":"trace[1547377229] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:647; }","duration":"508.52712ms","start":"2026-10-02T04:44:18.530859Z","end":"2026-10-02T04:44:19.039386Z","steps":["trace[1547377229] 'read index received' (duration: 93.569146ms)","trace[1547377229] 'applied index is now lower than readState.Index' (duration: 414.956224ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T04:44:19.039527Z","caller":"traceutil/trace.go:171","msg":"trace[773374698] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"589.38228ms","start":"2026-10-02T04:44:18.4501Z","end":"2026-10-02T04:44:19.039482Z","steps":["trace[773374698] 'process raft request' (duration: 589.080616ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:44:19.039598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T04:44:18.448137Z","time spent":"591.279622ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-02T04:44:19.039676Z","caller":"traceutil/trace.go:171","msg":"trace[1451252658] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"516.436382ms","start":"2026-10-02T04:44:18.523198Z","end":"2026-10-02T04:44:19.039635Z","steps":["trace[1451252658] 'process raft request' (duration: 516.042753ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:44:19.03969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.778112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-26dmc\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-02T04:44:19.039733Z","caller":"traceutil/trace.go:171","msg":"trace[655760353] range","detail":"{range_begin:/registry/pods/kube-system/cilium-26dmc; range_end:; response_count:1; response_revision:626; }","duration":"508.882097ms","start":"2026-10-02T04:44:18.530841Z","end":"2026-10-02T04:44:19.039723Z","steps":["trace[655760353] 'agreement among raft nodes before linearized reading' (duration: 508.598233ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:44:19.039753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T04:44:18.450075Z","time spent":"589.558729ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-02T04:44:19.039809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T04:44:18.530831Z","time spent":"508.967142ms","remote":"127.0.0.1:57734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-26dmc\" "} {"level":"warn","ts":"2026-10-02T04:44:19.039829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T04:44:18.52318Z","time spent":"516.542807ms","remote":"127.0.0.1:57758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-02T04:44:21.020721Z","caller":"traceutil/trace.go:171","msg":"trace[682716395] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"233.029502ms","start":"2026-10-02T04:44:20.787641Z","end":"2026-10-02T04:44:21.02067Z","steps":["trace[682716395] 'process raft request' (duration: 225.154739ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:44:21.669273Z","caller":"traceutil/trace.go:171","msg":"trace[1965412264] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"104.305561ms","start":"2026-10-02T04:44:21.564935Z","end":"2026-10-02T04:44:21.66924Z","steps":["trace[1965412264] 'process raft request' (duration: 103.915042ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:44:22.161053Z","caller":"traceutil/trace.go:171","msg":"trace[8386007] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"176.021221ms","start":"2026-10-02T04:44:21.98501Z","end":"2026-10-02T04:44:22.161031Z","steps":["trace[8386007] 'process raft request' (duration: 175.854943ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:44:33.7737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.298538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2z8cz\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-10-02T04:44:33.773794Z","caller":"traceutil/trace.go:171","msg":"trace[191130425] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2z8cz; range_end:; response_count:1; response_revision:793; }","duration":"139.453866ms","start":"2026-10-02T04:44:33.634317Z","end":"2026-10-02T04:44:33.773771Z","steps":["trace[191130425] 'range keys from in-memory index tree' (duration: 139.089428ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:45:06.053066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.962089ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-02T04:45:06.053293Z","caller":"traceutil/trace.go:171","msg":"trace[56777604] linearizableReadLoop","detail":"{readStateIndex:1233; appliedIndex:1232; }","duration":"425.279918ms","start":"2026-10-02T04:45:05.627989Z","end":"2026-10-02T04:45:06.053269Z","steps":["trace[56777604] 'read index received' (duration: 197.909758ms)","trace[56777604] 'applied index is now lower than readState.Index' (duration: 227.36856ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T04:45:06.053373Z","caller":"traceutil/trace.go:171","msg":"trace[424255207] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"628.566342ms","start":"2026-10-02T04:45:05.424744Z","end":"2026-10-02T04:45:06.05331Z","steps":["trace[424255207] 'process raft request' (duration: 401.241635ms)","trace[424255207] 'compare' (duration: 225.795428ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T04:45:06.053474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.442666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-02T04:45:06.053464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.065625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T04:45:06.05366Z","caller":"traceutil/trace.go:171","msg":"trace[414958755] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1198; }","duration":"425.593864ms","start":"2026-10-02T04:45:05.627953Z","end":"2026-10-02T04:45:06.053547Z","steps":["trace[414958755] 'agreement among raft nodes before linearized reading' (duration: 425.429735ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:45:06.053683Z","caller":"traceutil/trace.go:171","msg":"trace[1148155400] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1198; }","duration":"317.265735ms","start":"2026-10-02T04:45:05.736362Z","end":"2026-10-02T04:45:06.053628Z","steps":["trace[1148155400] 'agreement among raft nodes before linearized reading' (duration: 317.060054ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:45:06.053756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T04:45:05.627937Z","time spent":"425.797704ms","remote":"127.0.0.1:57794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-10-02T04:45:06.053853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T04:45:05.73635Z","time spent":"317.463125ms","remote":"127.0.0.1:57580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-02T04:45:06.053673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T04:45:05.424726Z","time spent":"628.793634ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-02T04:45:27.635532Z","caller":"traceutil/trace.go:171","msg":"trace[1394087375] transaction","detail":"{read_only:false; response_revision:1450; number_of_response:1; }","duration":"102.340531ms","start":"2026-10-02T04:45:27.533161Z","end":"2026-10-02T04:45:27.635502Z","steps":["trace[1394087375] 'process raft request' (duration: 102.177033ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:45:30.352734Z","caller":"traceutil/trace.go:171","msg":"trace[1899769917] transaction","detail":"{read_only:false; response_revision:1468; number_of_response:1; }","duration":"144.345756ms","start":"2026-10-02T04:45:30.208354Z","end":"2026-10-02T04:45:30.3527Z","steps":["trace[1899769917] 'process raft request' (duration: 114.779447ms)","trace[1899769917] 'compare' (duration: 29.440612ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T04:45:42.35804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.53659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-02T04:45:42.358127Z","caller":"traceutil/trace.go:171","msg":"trace[1517514920] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1699; }","duration":"106.637655ms","start":"2026-10-02T04:45:42.251472Z","end":"2026-10-02T04:45:42.35811Z","steps":["trace[1517514920] 'range keys from in-memory index tree' (duration: 106.354711ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:45:56.062152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.747899ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-02T04:45:56.062319Z","caller":"traceutil/trace.go:171","msg":"trace[1228468516] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"288.684471ms","start":"2026-10-02T04:45:55.77361Z","end":"2026-10-02T04:45:56.062295Z","steps":["trace[1228468516] 'process raft request' (duration: 123.709194ms)","trace[1228468516] 'compare' (duration: 164.56327ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T04:45:56.203382Z","caller":"traceutil/trace.go:171","msg":"trace[1472088964] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"133.621253ms","start":"2026-10-02T04:45:56.069725Z","end":"2026-10-02T04:45:56.203346Z","steps":["trace[1472088964] 'process raft request' (duration: 93.882249ms)","trace[1472088964] 'compare' (duration: 39.622435ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T04:45:56.543047Z","caller":"traceutil/trace.go:171","msg":"trace[1495574906] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"252.879279ms","start":"2026-10-02T04:45:56.290138Z","end":"2026-10-02T04:45:56.543017Z","steps":["trace[1495574906] 'process raft request' (duration: 178.968793ms)","trace[1495574906] 'compare' (duration: 73.402809ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T04:45:56.543186Z","caller":"traceutil/trace.go:171","msg":"trace[643360077] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"122.679983ms","start":"2026-10-02T04:45:56.420485Z","end":"2026-10-02T04:45:56.543165Z","steps":["trace[643360077] 'process raft request' (duration: 122.514304ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:46:09.14771Z","caller":"traceutil/trace.go:171","msg":"trace[1595610926] transaction","detail":"{read_only:false; response_revision:1989; number_of_response:1; }","duration":"107.798454ms","start":"2026-10-02T04:46:09.039875Z","end":"2026-10-02T04:46:09.147674Z","steps":["trace[1595610926] 'process raft request' (duration: 107.513564ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:46:09.147681Z","caller":"traceutil/trace.go:171","msg":"trace[2071195064] linearizableReadLoop","detail":"{readStateIndex:2065; appliedIndex:2064; }","duration":"104.799267ms","start":"2026-10-02T04:46:09.042827Z","end":"2026-10-02T04:46:09.147627Z","steps":["trace[2071195064] 'read index received' (duration: 104.625787ms)","trace[2071195064] 'applied index is now lower than readState.Index' (duration: 171.86µs)"],"step_count":2} {"level":"warn","ts":"2026-10-02T04:46:09.147946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.092055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-02T04:46:09.148003Z","caller":"traceutil/trace.go:171","msg":"trace[1810107978] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1989; }","duration":"105.177725ms","start":"2026-10-02T04:46:09.042813Z","end":"2026-10-02T04:46:09.147991Z","steps":["trace[1810107978] 'agreement among raft nodes before linearized reading' (duration: 104.960027ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:46:09.373062Z","caller":"traceutil/trace.go:171","msg":"trace[47956111] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"317.195557ms","start":"2026-10-02T04:46:09.055828Z","end":"2026-10-02T04:46:09.373024Z","steps":["trace[47956111] 'process raft request' (duration: 234.252952ms)","trace[47956111] 'compare' (duration: 82.576715ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T04:46:09.373136Z","caller":"traceutil/trace.go:171","msg":"trace[260230442] linearizableReadLoop","detail":"{readStateIndex:2067; appliedIndex:2065; }","duration":"217.898623ms","start":"2026-10-02T04:46:09.155213Z","end":"2026-10-02T04:46:09.373112Z","steps":["trace[260230442] 'read index received' (duration: 134.834238ms)","trace[260230442] 'applied index is now lower than readState.Index' (duration: 83.063185ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T04:46:09.373272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T04:46:09.05581Z","time spent":"317.367387ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-02T04:46:09.373307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.093742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-10-02T04:46:09.37336Z","caller":"traceutil/trace.go:171","msg":"trace[554028877] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1992; }","duration":"218.176882ms","start":"2026-10-02T04:46:09.155167Z","end":"2026-10-02T04:46:09.373344Z","steps":["trace[554028877] 'agreement among raft nodes before linearized reading' (duration: 218.014493ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:46:09.373565Z","caller":"traceutil/trace.go:171","msg":"trace[1310316868] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"144.179387ms","start":"2026-10-02T04:46:09.229305Z","end":"2026-10-02T04:46:09.373484Z","steps":["trace[1310316868] 'process raft request' (duration: 143.743428ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:46:09.374131Z","caller":"traceutil/trace.go:171","msg":"trace[461149945] transaction","detail":"{read_only:false; response_revision:1991; number_of_response:1; }","duration":"221.777898ms","start":"2026-10-02T04:46:09.152304Z","end":"2026-10-02T04:46:09.374082Z","steps":["trace[461149945] 'process raft request' (duration: 220.634859ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:46:09.703645Z","caller":"traceutil/trace.go:171","msg":"trace[390450942] transaction","detail":"{read_only:false; response_revision:1994; number_of_response:1; }","duration":"111.801987ms","start":"2026-10-02T04:46:09.591818Z","end":"2026-10-02T04:46:09.70362Z","steps":["trace[390450942] 'process raft request' (duration: 111.597907ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:46:09.703926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.358961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T04:46:09.703988Z","caller":"traceutil/trace.go:171","msg":"trace[947642068] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:1994; }","duration":"101.578381ms","start":"2026-10-02T04:46:09.602393Z","end":"2026-10-02T04:46:09.703971Z","steps":["trace[947642068] 'agreement among raft nodes before linearized reading' (duration: 101.317151ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:46:09.703603Z","caller":"traceutil/trace.go:171","msg":"trace[1802004081] linearizableReadLoop","detail":"{readStateIndex:2070; appliedIndex:2069; }","duration":"101.140131ms","start":"2026-10-02T04:46:09.602434Z","end":"2026-10-02T04:46:09.703574Z","steps":["trace[1802004081] 'read index received' (duration: 100.956471ms)","trace[1802004081] 'applied index is now lower than readState.Index' (duration: 182.86µs)"],"step_count":2} {"level":"warn","ts":"2026-10-02T04:46:12.899067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.946163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T04:46:12.899179Z","caller":"traceutil/trace.go:171","msg":"trace[1029229106] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:2016; }","duration":"107.126532ms","start":"2026-10-02T04:46:12.792026Z","end":"2026-10-02T04:46:12.899152Z","steps":["trace[1029229106] 'count revisions from in-memory index tree' (duration: 106.613343ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:46:46.490758Z","caller":"traceutil/trace.go:171","msg":"trace[2093108164] transaction","detail":"{read_only:false; response_revision:2200; number_of_response:1; }","duration":"173.000746ms","start":"2026-10-02T04:46:46.317717Z","end":"2026-10-02T04:46:46.490718Z","steps":["trace[2093108164] 'process raft request' (duration: 172.822514ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:46:46.926997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.779117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-10-02T04:46:46.927066Z","caller":"traceutil/trace.go:171","msg":"trace[833945149] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2200; }","duration":"276.889578ms","start":"2026-10-02T04:46:46.650157Z","end":"2026-10-02T04:46:46.927047Z","steps":["trace[833945149] 'range keys from in-memory index tree' (duration: 276.584285ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:46:46.927168Z","caller":"traceutil/trace.go:171","msg":"trace[978806358] linearizableReadLoop","detail":"{readStateIndex:2285; appliedIndex:2284; }","duration":"106.226206ms","start":"2026-10-02T04:46:46.820911Z","end":"2026-10-02T04:46:46.927137Z","steps":["trace[978806358] 'read index received' (duration: 29.690411ms)","trace[978806358] 'applied index is now lower than readState.Index' (duration: 76.534535ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T04:46:46.92736Z","caller":"traceutil/trace.go:171","msg":"trace[191891720] transaction","detail":"{read_only:false; response_revision:2201; number_of_response:1; }","duration":"177.878379ms","start":"2026-10-02T04:46:46.749413Z","end":"2026-10-02T04:46:46.927292Z","steps":["trace[191891720] 'process raft request' (duration: 101.269403ms)","trace[191891720] 'compare' (duration: 76.340423ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T04:46:46.927515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.57384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-10-02T04:46:46.927577Z","caller":"traceutil/trace.go:171","msg":"trace[1657287573] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2201; }","duration":"106.703462ms","start":"2026-10-02T04:46:46.820857Z","end":"2026-10-02T04:46:46.92756Z","steps":["trace[1657287573] 'agreement among raft nodes before linearized reading' (duration: 106.440199ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:46:46.927063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.669408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-02T04:46:46.928121Z","caller":"traceutil/trace.go:171","msg":"trace[362029447] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2200; }","duration":"192.80851ms","start":"2026-10-02T04:46:46.735293Z","end":"2026-10-02T04:46:46.928102Z","steps":["trace[362029447] 'range keys from in-memory index tree' (duration: 191.578927ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:46:47.355707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.475226ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-02T04:46:47.356082Z","caller":"traceutil/trace.go:171","msg":"trace[1048417924] linearizableReadLoop","detail":"{readStateIndex:2288; appliedIndex:2285; }","duration":"337.94306ms","start":"2026-10-02T04:46:47.018113Z","end":"2026-10-02T04:46:47.356056Z","steps":["trace[1048417924] 'read index received' (duration: 233.008839ms)","trace[1048417924] 'applied index is now lower than readState.Index' (duration: 104.932621ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T04:46:47.356145Z","caller":"traceutil/trace.go:171","msg":"trace[308268066] transaction","detail":"{read_only:false; response_revision:2202; number_of_response:1; }","duration":"422.925951ms","start":"2026-10-02T04:46:46.933192Z","end":"2026-10-02T04:46:47.356118Z","steps":["trace[308268066] 'process raft request' (duration: 317.903319ms)","trace[308268066] 'compare' (duration: 104.252773ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T04:46:47.356149Z","caller":"traceutil/trace.go:171","msg":"trace[800716334] transaction","detail":"{read_only:false; response_revision:2203; number_of_response:1; }","duration":"422.484186ms","start":"2026-10-02T04:46:46.933613Z","end":"2026-10-02T04:46:47.356097Z","steps":["trace[800716334] 'process raft request' (duration: 422.242773ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:46:47.356238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.113932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-02T04:46:47.356251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T04:46:46.933166Z","time spent":"423.024282ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-02T04:46:47.356307Z","caller":"traceutil/trace.go:171","msg":"trace[2037121179] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:2204; }","duration":"338.227804ms","start":"2026-10-02T04:46:47.018059Z","end":"2026-10-02T04:46:47.356287Z","steps":["trace[2037121179] 'agreement among raft nodes before linearized reading' (duration: 338.099313ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:46:47.356305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.552923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-02T04:46:47.356372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T04:46:47.018036Z","time spent":"338.324415ms","remote":"127.0.0.1:53740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"info","ts":"2026-10-02T04:46:47.356389Z","caller":"traceutil/trace.go:171","msg":"trace[1742289598] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:2204; }","duration":"110.661275ms","start":"2026-10-02T04:46:47.245701Z","end":"2026-10-02T04:46:47.356362Z","steps":["trace[1742289598] 'agreement among raft nodes before linearized reading' (duration: 110.501593ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:46:47.356435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T04:46:46.933589Z","time spent":"422.658308ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-02T04:46:47.356279Z","caller":"traceutil/trace.go:171","msg":"trace[2095755472] transaction","detail":"{read_only:false; response_revision:2204; number_of_response:1; }","duration":"422.244903ms","start":"2026-10-02T04:46:46.933863Z","end":"2026-10-02T04:46:47.356108Z","steps":["trace[2095755472] 'process raft request' (duration: 422.125592ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:46:47.356656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T04:46:46.933842Z","time spent":"422.714478ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-02T04:47:35.970154Z","caller":"traceutil/trace.go:171","msg":"trace[867757555] linearizableReadLoop","detail":"{readStateIndex:2667; appliedIndex:2666; }","duration":"255.825534ms","start":"2026-10-02T04:47:35.714293Z","end":"2026-10-02T04:47:35.970118Z","steps":["trace[867757555] 'read index received' (duration: 251.272353ms)","trace[867757555] 'applied index is now lower than readState.Index' (duration: 4.55185ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T04:47:35.970193Z","caller":"traceutil/trace.go:171","msg":"trace[381736772] transaction","detail":"{read_only:false; response_revision:2572; number_of_response:1; }","duration":"265.180502ms","start":"2026-10-02T04:47:35.704986Z","end":"2026-10-02T04:47:35.970166Z","steps":["trace[381736772] 'process raft request' (duration: 260.60285ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:47:35.970338Z","caller":"traceutil/trace.go:171","msg":"trace[2061530298] transaction","detail":"{read_only:false; response_revision:2573; number_of_response:1; }","duration":"190.110924ms","start":"2026-10-02T04:47:35.78022Z","end":"2026-10-02T04:47:35.970331Z","steps":["trace[2061530298] 'process raft request' (duration: 189.856429ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:47:35.970472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.001534ms","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-10-02T04:47:35.970513Z","caller":"traceutil/trace.go:171","msg":"trace[1915639987] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2573; }","duration":"128.091076ms","start":"2026-10-02T04:47:35.842408Z","end":"2026-10-02T04:47:35.970499Z","steps":["trace[1915639987] 'agreement among raft nodes before linearized reading' (duration: 127.892672ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:47:35.97056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.784651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-10-02T04:47:35.970544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.226203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-10-02T04:47:35.970646Z","caller":"traceutil/trace.go:171","msg":"trace[1769382914] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2573; }","duration":"256.387547ms","start":"2026-10-02T04:47:35.71423Z","end":"2026-10-02T04:47:35.970618Z","steps":["trace[1769382914] 'agreement among raft nodes before linearized reading' (duration: 256.020349ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:47:35.97059Z","caller":"traceutil/trace.go:171","msg":"trace[1288035507] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2573; }","duration":"119.883994ms","start":"2026-10-02T04:47:35.850697Z","end":"2026-10-02T04:47:35.970581Z","steps":["trace[1288035507] 'agreement among raft nodes before linearized reading' (duration: 119.739991ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:52:33.538754Z","caller":"traceutil/trace.go:171","msg":"trace[832683940] transaction","detail":"{read_only:false; response_revision:4420; number_of_response:1; }","duration":"123.703365ms","start":"2026-10-02T04:52:33.41502Z","end":"2026-10-02T04:52:33.538724Z","steps":["trace[832683940] 'process raft request' (duration: 123.483305ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:52:33.53924Z","caller":"traceutil/trace.go:171","msg":"trace[704712700] transaction","detail":"{read_only:false; response_revision:4421; number_of_response:1; }","duration":"123.854602ms","start":"2026-10-02T04:52:33.415122Z","end":"2026-10-02T04:52:33.538976Z","steps":["trace[704712700] 'process raft request' (duration: 123.552919ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:52:33.539524Z","caller":"traceutil/trace.go:171","msg":"trace[666519993] transaction","detail":"{read_only:false; response_revision:4422; number_of_response:1; }","duration":"124.208417ms","start":"2026-10-02T04:52:33.415223Z","end":"2026-10-02T04:52:33.539431Z","steps":["trace[666519993] 'process raft request' (duration: 123.644422ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:52:33.539666Z","caller":"traceutil/trace.go:171","msg":"trace[1882982695] transaction","detail":"{read_only:false; response_revision:4423; number_of_response:1; }","duration":"124.423197ms","start":"2026-10-02T04:52:33.415223Z","end":"2026-10-02T04:52:33.539646Z","steps":["trace[1882982695] 'process raft request' (duration: 124.213237ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:52:33.539671Z","caller":"traceutil/trace.go:171","msg":"trace[1443793937] transaction","detail":"{read_only:false; response_revision:4424; number_of_response:1; }","duration":"122.319464ms","start":"2026-10-02T04:52:33.417326Z","end":"2026-10-02T04:52:33.539646Z","steps":["trace[1443793937] 'process raft request' (duration: 122.269572ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:52:33.633524Z","caller":"traceutil/trace.go:171","msg":"trace[2011507647] transaction","detail":"{read_only:false; response_revision:4425; number_of_response:1; }","duration":"152.78106ms","start":"2026-10-02T04:52:33.480712Z","end":"2026-10-02T04:52:33.633493Z","steps":["trace[2011507647] 'process raft request' (duration: 107.13665ms)","trace[2011507647] 'compare' (duration: 45.436111ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T04:52:33.633683Z","caller":"traceutil/trace.go:171","msg":"trace[1565755655] transaction","detail":"{read_only:false; response_revision:4426; number_of_response:1; }","duration":"152.920737ms","start":"2026-10-02T04:52:33.48074Z","end":"2026-10-02T04:52:33.633661Z","steps":["trace[1565755655] 'process raft request' (duration: 152.668586ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:52:38.19622Z","caller":"traceutil/trace.go:171","msg":"trace[1483830003] transaction","detail":"{read_only:false; response_revision:4798; number_of_response:1; }","duration":"113.286083ms","start":"2026-10-02T04:52:38.082896Z","end":"2026-10-02T04:52:38.196182Z","steps":["trace[1483830003] 'process raft request' (duration: 113.135056ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:52:44.438807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.92056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-10-02T04:52:44.438889Z","caller":"traceutil/trace.go:171","msg":"trace[1057186510] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4926; }","duration":"230.039545ms","start":"2026-10-02T04:52:44.208828Z","end":"2026-10-02T04:52:44.438868Z","steps":["trace[1057186510] 'range keys from in-memory index tree' (duration: 229.734731ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:52:44.489134Z","caller":"traceutil/trace.go:171","msg":"trace[693745985] transaction","detail":"{read_only:false; response_revision:4927; number_of_response:1; }","duration":"110.115505ms","start":"2026-10-02T04:52:44.378992Z","end":"2026-10-02T04:52:44.489107Z","steps":["trace[693745985] 'process raft request' (duration: 109.968739ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:52:44.770308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.712451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-10-02T04:52:44.770415Z","caller":"traceutil/trace.go:171","msg":"trace[820443538] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4928; }","duration":"227.896209ms","start":"2026-10-02T04:52:44.542488Z","end":"2026-10-02T04:52:44.770384Z","steps":["trace[820443538] 'range keys from in-memory index tree' (duration: 227.472751ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:52:44.922914Z","caller":"traceutil/trace.go:171","msg":"trace[1927629641] transaction","detail":"{read_only:false; response_revision:4930; number_of_response:1; }","duration":"108.64592ms","start":"2026-10-02T04:52:44.81423Z","end":"2026-10-02T04:52:44.922876Z","steps":["trace[1927629641] 'process raft request' (duration: 108.42073ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:52:50.956096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.240617ms","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-10-02T04:52:50.956192Z","caller":"traceutil/trace.go:171","msg":"trace[1551782001] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:5028; }","duration":"265.389364ms","start":"2026-10-02T04:52:50.690776Z","end":"2026-10-02T04:52:50.956165Z","steps":["trace[1551782001] 'count revisions from in-memory index tree' (duration: 265.169553ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:52:50.956433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.918874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-02T04:52:50.956933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.678905ms","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-10-02T04:52:50.957045Z","caller":"traceutil/trace.go:171","msg":"trace[199779828] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:5028; }","duration":"100.851542ms","start":"2026-10-02T04:52:50.85616Z","end":"2026-10-02T04:52:50.957012Z","steps":["trace[199779828] 'count revisions from in-memory index tree' (duration: 100.538228ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:52:50.956503Z","caller":"traceutil/trace.go:171","msg":"trace[1517500872] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5028; }","duration":"217.004798ms","start":"2026-10-02T04:52:50.739484Z","end":"2026-10-02T04:52:50.956489Z","steps":["trace[1517500872] 'range keys from in-memory index tree' (duration: 216.866332ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:52:51.401124Z","caller":"traceutil/trace.go:171","msg":"trace[32629748] transaction","detail":"{read_only:false; response_revision:5031; number_of_response:1; }","duration":"133.119783ms","start":"2026-10-02T04:52:51.267971Z","end":"2026-10-02T04:52:51.401091Z","steps":["trace[32629748] 'process raft request' (duration: 132.940314ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:52:51.427022Z","caller":"traceutil/trace.go:171","msg":"trace[1636563074] transaction","detail":"{read_only:false; response_revision:5032; number_of_response:1; }","duration":"130.046325ms","start":"2026-10-02T04:52:51.296949Z","end":"2026-10-02T04:52:51.426995Z","steps":["trace[1636563074] 'process raft request' (duration: 129.790985ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:52:51.427343Z","caller":"traceutil/trace.go:171","msg":"trace[1275752007] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"129.670808ms","start":"2026-10-02T04:52:51.297653Z","end":"2026-10-02T04:52:51.427324Z","steps":["trace[1275752007] 'process raft request' (duration: 129.296821ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:53:04.587749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.938351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"info","ts":"2026-10-02T04:53:04.587953Z","caller":"traceutil/trace.go:171","msg":"trace[1725403016] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5201; }","duration":"137.196492ms","start":"2026-10-02T04:53:04.450726Z","end":"2026-10-02T04:53:04.587923Z","steps":["trace[1725403016] 'range keys from in-memory index tree' (duration: 136.685559ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:53:04.960527Z","caller":"traceutil/trace.go:171","msg":"trace[1567151090] linearizableReadLoop","detail":"{readStateIndex:5399; appliedIndex:5398; }","duration":"353.079515ms","start":"2026-10-02T04:53:04.607418Z","end":"2026-10-02T04:53:04.960498Z","steps":["trace[1567151090] 'read index received' (duration: 352.810593ms)","trace[1567151090] 'applied index is now lower than readState.Index' (duration: 267.812µs)"],"step_count":2} {"level":"warn","ts":"2026-10-02T04:53:04.96081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.377179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-02T04:53:04.960885Z","caller":"traceutil/trace.go:171","msg":"trace[143830758] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5202; }","duration":"353.503413ms","start":"2026-10-02T04:53:04.607369Z","end":"2026-10-02T04:53:04.960872Z","steps":["trace[143830758] 'agreement among raft nodes before linearized reading' (duration: 353.324095ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:53:04.960945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T04:53:04.607351Z","time spent":"353.582627ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-02T04:53:04.961058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.708774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"info","ts":"2026-10-02T04:53:04.961179Z","caller":"traceutil/trace.go:171","msg":"trace[306588239] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5202; }","duration":"135.82532ms","start":"2026-10-02T04:53:04.82533Z","end":"2026-10-02T04:53:04.961156Z","steps":["trace[306588239] 'agreement among raft nodes before linearized reading' (duration: 135.534786ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:53:04.960759Z","caller":"traceutil/trace.go:171","msg":"trace[1002420856] transaction","detail":"{read_only:false; response_revision:5202; number_of_response:1; }","duration":"376.177438ms","start":"2026-10-02T04:53:04.584558Z","end":"2026-10-02T04:53:04.960736Z","steps":["trace[1002420856] 'process raft request' (duration: 375.767339ms)"],"step_count":1} {"level":"warn","ts":"2026-10-02T04:53:04.961602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-02T04:53:04.584528Z","time spent":"376.993895ms","remote":"127.0.0.1:57830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-02T04:53:05.104048Z","caller":"traceutil/trace.go:171","msg":"trace[961291436] linearizableReadLoop","detail":"{readStateIndex:5401; appliedIndex:5400; }","duration":"116.225313ms","start":"2026-10-02T04:53:04.987797Z","end":"2026-10-02T04:53:05.104022Z","steps":["trace[961291436] 'read index received' (duration: 44.847528ms)","trace[961291436] 'applied index is now lower than readState.Index' (duration: 71.376605ms)"],"step_count":2} {"level":"info","ts":"2026-10-02T04:53:05.104145Z","caller":"traceutil/trace.go:171","msg":"trace[819995527] transaction","detail":"{read_only:false; response_revision:5204; number_of_response:1; }","duration":"119.675008ms","start":"2026-10-02T04:53:04.98444Z","end":"2026-10-02T04:53:05.104115Z","steps":["trace[819995527] 'process raft request' (duration: 48.257781ms)","trace[819995527] 'compare' (duration: 71.181217ms)"],"step_count":2} {"level":"warn","ts":"2026-10-02T04:53:05.104403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.58269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9637"} {"level":"info","ts":"2026-10-02T04:53:05.104929Z","caller":"traceutil/trace.go:171","msg":"trace[1184664894] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:5204; }","duration":"117.141305ms","start":"2026-10-02T04:53:04.987771Z","end":"2026-10-02T04:53:05.104913Z","steps":["trace[1184664894] 'agreement among raft nodes before linearized reading' (duration: 116.429753ms)"],"step_count":1} {"level":"info","ts":"2026-10-02T04:53:34.194189Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2888} {"level":"info","ts":"2026-10-02T04:53:34.281441Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2888,"took":"86.063076ms","hash":1083777239,"current-db-size-bytes":53051392,"current-db-size":"53 MB","current-db-size-in-use-bytes":28471296,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-02T04:53:34.281503Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1083777239,"revision":2888,"compact-revision":-1} {"level":"info","ts":"2026-10-02T04:58:34.206109Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5509} {"level":"info","ts":"2026-10-02T04:58:34.287336Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5509,"took":"79.441ms","hash":554349863,"current-db-size-bytes":53051392,"current-db-size":"53 MB","current-db-size-in-use-bytes":18833408,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-02T04:58:34.287403Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":554349863,"revision":5509,"compact-revision":2888}