{"level":"warn","ts":"2026-09-18T02:22:37.760871Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-18T02:22:37.760974Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.107: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.107:2380","--initial-cluster=instance=https://162.253.55.107:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.107:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.107:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-18T02:22:37.761068Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-18T02:22:37.761083Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.107:2380"]} {"level":"info","ts":"2026-09-18T02:22:37.761107Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-18T02:22:37.761975Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.107:2379"]} {"level":"info","ts":"2026-09-18T02:22:37.762604Z","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.107:2380"],"listen-peer-urls":["https://162.253.55.107:2380"],"advertise-client-urls":["https://162.253.55.107:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.107:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.107:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-18T02:22:37.766781Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.884904ms"} {"level":"info","ts":"2026-09-18T02:22:37.774284Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9139094afdb348df","cluster-id":"a56c8121e8858232"} {"level":"info","ts":"2026-09-18T02:22:37.774394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T02:22:37.774422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df became follower at term 0"} {"level":"info","ts":"2026-09-18T02:22:37.774436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9139094afdb348df [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T02:22:37.774469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df became follower at term 1"} {"level":"info","ts":"2026-09-18T02:22:37.774525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df switched to configuration voters=(10464405426860673247)"} {"level":"warn","ts":"2026-09-18T02:22:37.785446Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T02:22:37.787205Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T02:22:37.788912Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-18T02:22:37.791348Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9139094afdb348df","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T02:22:37.791605Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-18T02:22:37.791671Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-18T02:22:37.791702Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-18T02:22:37.792657Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9139094afdb348df","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T02:22:37.793638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df switched to configuration voters=(10464405426860673247)"} {"level":"info","ts":"2026-09-18T02:22:37.793867Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a56c8121e8858232","local-member-id":"9139094afdb348df","added-peer-id":"9139094afdb348df","added-peer-peer-urls":["https://162.253.55.107:2380"]} {"level":"info","ts":"2026-09-18T02:22:37.796249Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-18T02:22:37.796495Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9139094afdb348df","initial-advertise-peer-urls":["https://162.253.55.107:2380"],"listen-peer-urls":["https://162.253.55.107:2380"],"advertise-client-urls":["https://162.253.55.107:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.107:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T02:22:37.796529Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T02:22:37.796644Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.107:2380"} {"level":"info","ts":"2026-09-18T02:22:37.796657Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.107:2380"} {"level":"info","ts":"2026-09-18T02:22:38.175132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T02:22:38.175195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T02:22:38.175244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df received MsgPreVoteResp from 9139094afdb348df at term 1"} {"level":"info","ts":"2026-09-18T02:22:38.175264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df became candidate at term 2"} {"level":"info","ts":"2026-09-18T02:22:38.175275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df received MsgVoteResp from 9139094afdb348df at term 2"} {"level":"info","ts":"2026-09-18T02:22:38.17529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9139094afdb348df became leader at term 2"} {"level":"info","ts":"2026-09-18T02:22:38.175304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9139094afdb348df elected leader 9139094afdb348df at term 2"} {"level":"info","ts":"2026-09-18T02:22:38.177539Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:22:38.17806Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9139094afdb348df","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.107:2379]}","request-path":"/0/members/9139094afdb348df/attributes","cluster-id":"a56c8121e8858232","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T02:22:38.178305Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T02:22:38.178426Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T02:22:38.178678Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T02:22:38.17876Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T02:22:38.179147Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a56c8121e8858232","local-member-id":"9139094afdb348df","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:22:38.179261Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:22:38.17929Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:22:38.181726Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.107:2379"} {"level":"info","ts":"2026-09-18T02:22:38.183455Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-18T02:22:41.359246Z","caller":"traceutil/trace.go:171","msg":"trace[1941240949] transaction","detail":"{read_only:false; response_revision:183; number_of_response:1; }","duration":"104.56182ms","start":"2026-09-18T02:22:41.254645Z","end":"2026-09-18T02:22:41.359207Z","steps":["trace[1941240949] 'process raft request' (duration: 93.092623ms)","trace[1941240949] 'compare' (duration: 11.282323ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:22:43.718115Z","caller":"traceutil/trace.go:171","msg":"trace[1998360844] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"124.58611ms","start":"2026-09-18T02:22:43.593499Z","end":"2026-09-18T02:22:43.718085Z","steps":["trace[1998360844] 'process raft request' (duration: 82.599395ms)","trace[1998360844] 'compare' (duration: 41.725778ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:22:43.718408Z","caller":"traceutil/trace.go:171","msg":"trace[1567831911] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"112.796271ms","start":"2026-09-18T02:22:43.605594Z","end":"2026-09-18T02:22:43.71839Z","steps":["trace[1567831911] 'process raft request' (duration: 112.608687ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:43.718431Z","caller":"traceutil/trace.go:171","msg":"trace[2137969038] transaction","detail":"{read_only:false; number_of_response:0; response_revision:298; }","duration":"113.934439ms","start":"2026-09-18T02:22:43.604469Z","end":"2026-09-18T02:22:43.718403Z","steps":["trace[2137969038] 'process raft request' (duration: 113.621791ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:43.718585Z","caller":"traceutil/trace.go:171","msg":"trace[1752922434] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"114.116054ms","start":"2026-09-18T02:22:43.604454Z","end":"2026-09-18T02:22:43.71857Z","steps":["trace[1752922434] 'process raft request' (duration: 113.56547ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:43.71857Z","caller":"traceutil/trace.go:171","msg":"trace[1974845037] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"113.586601ms","start":"2026-09-18T02:22:43.604969Z","end":"2026-09-18T02:22:43.718556Z","steps":["trace[1974845037] 'process raft request' (duration: 113.17165ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:43.718704Z","caller":"traceutil/trace.go:171","msg":"trace[1312419487] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"112.786941ms","start":"2026-09-18T02:22:43.605904Z","end":"2026-09-18T02:22:43.718691Z","steps":["trace[1312419487] 'process raft request' (duration: 112.346051ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:51.639492Z","caller":"traceutil/trace.go:171","msg":"trace[745700395] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"208.213241ms","start":"2026-09-18T02:22:51.43126Z","end":"2026-09-18T02:22:51.639473Z","steps":["trace[745700395] 'process raft request' (duration: 208.112079ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:51.955869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.637041ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T02:22:51.956034Z","caller":"traceutil/trace.go:171","msg":"trace[438471138] linearizableReadLoop","detail":"{readStateIndex:420; appliedIndex:419; }","duration":"255.282716ms","start":"2026-09-18T02:22:51.700732Z","end":"2026-09-18T02:22:51.956015Z","steps":["trace[438471138] 'read index received' (duration: 42.568648ms)","trace[438471138] 'applied index is now lower than readState.Index' (duration: 212.712538ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:22:51.956074Z","caller":"traceutil/trace.go:171","msg":"trace[1252348983] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"303.674891ms","start":"2026-09-18T02:22:51.652363Z","end":"2026-09-18T02:22:51.956038Z","steps":["trace[1252348983] 'process raft request' (duration: 91.063107ms)","trace[1252348983] 'compare' (duration: 211.416306ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:22:51.956192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.464299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.107\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-18T02:22:51.956232Z","caller":"traceutil/trace.go:171","msg":"trace[949424551] range","detail":"{range_begin:/registry/masterleases/162.253.55.107; range_end:; response_count:1; response_revision:405; }","duration":"255.612154ms","start":"2026-09-18T02:22:51.700607Z","end":"2026-09-18T02:22:51.956219Z","steps":["trace[949424551] 'agreement among raft nodes before linearized reading' (duration: 255.515891ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:51.956272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:22:51.652339Z","time spent":"303.812715ms","remote":"127.0.0.1:51700","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4119,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:23:28.880648Z","caller":"traceutil/trace.go:171","msg":"trace[1423201282] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"187.399233ms","start":"2026-09-18T02:23:28.693159Z","end":"2026-09-18T02:23:28.880558Z","steps":["trace[1423201282] 'process raft request' (duration: 187.256199ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:23:29.268562Z","caller":"traceutil/trace.go:171","msg":"trace[2038115926] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:678; }","duration":"387.285192ms","start":"2026-09-18T02:23:28.881245Z","end":"2026-09-18T02:23:29.26853Z","steps":["trace[2038115926] 'read index received' (duration: 386.516048ms)","trace[2038115926] 'applied index is now lower than readState.Index' (duration: 768.104µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:23:29.268638Z","caller":"traceutil/trace.go:171","msg":"trace[1213465665] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"438.623824ms","start":"2026-09-18T02:23:28.829988Z","end":"2026-09-18T02:23:29.268612Z","steps":["trace[1213465665] 'process raft request' (duration: 437.917762ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:29.268779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:28.829925Z","time spent":"438.777396ms","remote":"127.0.0.1:51630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:23:29.268729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.845426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:23:29.269076Z","caller":"traceutil/trace.go:171","msg":"trace[1588631595] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:654; }","duration":"402.231734ms","start":"2026-09-18T02:23:28.866772Z","end":"2026-09-18T02:23:29.269003Z","steps":["trace[1588631595] 'agreement among raft nodes before linearized reading' (duration: 401.890067ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:29.269166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:28.866746Z","time spent":"402.403356ms","remote":"127.0.0.1:51506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-18T02:23:29.31109Z","caller":"traceutil/trace.go:171","msg":"trace[191866132] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"425.41047ms","start":"2026-09-18T02:23:28.885652Z","end":"2026-09-18T02:23:29.311063Z","steps":["trace[191866132] 'process raft request' (duration: 425.299698ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:29.311243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:28.885631Z","time spent":"425.547143ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:23:29.797931Z","caller":"traceutil/trace.go:171","msg":"trace[1366955219] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"454.828557ms","start":"2026-09-18T02:23:29.343083Z","end":"2026-09-18T02:23:29.797912Z","steps":["trace[1366955219] 'process raft request' (duration: 454.703685ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:29.798052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:29.343058Z","time spent":"454.929309ms","remote":"127.0.0.1:52020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T02:23:30.670493Z","caller":"traceutil/trace.go:171","msg":"trace[116238185] linearizableReadLoop","detail":"{readStateIndex:682; appliedIndex:681; }","duration":"461.200783ms","start":"2026-09-18T02:23:30.209257Z","end":"2026-09-18T02:23:30.670458Z","steps":["trace[116238185] 'read index received' (duration: 458.025796ms)","trace[116238185] 'applied index is now lower than readState.Index' (duration: 3.173767ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:23:30.670658Z","caller":"traceutil/trace.go:171","msg":"trace[1822831600] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"464.886388ms","start":"2026-09-18T02:23:30.205758Z","end":"2026-09-18T02:23:30.670645Z","steps":["trace[1822831600] 'process raft request' (duration: 461.806093ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:30.670778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:30.205727Z","time spent":"464.96603ms","remote":"127.0.0.1:51630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:23:30.670989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.704572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-18T02:23:30.671088Z","caller":"traceutil/trace.go:171","msg":"trace[96922252] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:657; }","duration":"461.841314ms","start":"2026-09-18T02:23:30.209219Z","end":"2026-09-18T02:23:30.67106Z","steps":["trace[96922252] 'agreement among raft nodes before linearized reading' (duration: 461.526778ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:30.671168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:30.209198Z","time spent":"461.958607ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-18T02:23:30.671191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.676204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-18T02:23:30.671316Z","caller":"traceutil/trace.go:171","msg":"trace[537298229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:657; }","duration":"363.910598ms","start":"2026-09-18T02:23:30.307376Z","end":"2026-09-18T02:23:30.671287Z","steps":["trace[537298229] 'agreement among raft nodes before linearized reading' (duration: 363.332208ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:30.671378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:30.307357Z","time spent":"364.00768ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-18T02:23:30.671386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.017765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-18T02:23:30.671443Z","caller":"traceutil/trace.go:171","msg":"trace[1859105750] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:657; }","duration":"231.110936ms","start":"2026-09-18T02:23:30.440316Z","end":"2026-09-18T02:23:30.671427Z","steps":["trace[1859105750] 'agreement among raft nodes before linearized reading' (duration: 230.436423ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:48.086088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.896634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:23:48.086136Z","caller":"traceutil/trace.go:171","msg":"trace[466808489] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:826; }","duration":"150.012946ms","start":"2026-09-18T02:23:47.936115Z","end":"2026-09-18T02:23:48.086128Z","steps":["trace[466808489] 'range keys from in-memory index tree' (duration: 149.791061ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:48.086137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.405636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:23:48.086182Z","caller":"traceutil/trace.go:171","msg":"trace[932613880] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:826; }","duration":"149.490278ms","start":"2026-09-18T02:23:47.936672Z","end":"2026-09-18T02:23:48.086162Z","steps":["trace[932613880] 'range keys from in-memory index tree' (duration: 149.333184ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:48.086113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.338254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T02:23:48.086399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.958065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:23:48.086435Z","caller":"traceutil/trace.go:171","msg":"trace[575669829] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:826; }","duration":"232.007416ms","start":"2026-09-18T02:23:47.854421Z","end":"2026-09-18T02:23:48.086429Z","steps":["trace[575669829] 'range keys from in-memory index tree' (duration: 231.891545ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:48.086406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.647481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:23:48.086484Z","caller":"traceutil/trace.go:171","msg":"trace[481573305] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:826; }","duration":"299.759224ms","start":"2026-09-18T02:23:47.786713Z","end":"2026-09-18T02:23:48.086472Z","steps":["trace[481573305] 'range keys from in-memory index tree' (duration: 299.53851ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:48.086064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.315354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:23:48.086564Z","caller":"traceutil/trace.go:171","msg":"trace[1836543445] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:826; }","duration":"272.863213ms","start":"2026-09-18T02:23:47.813689Z","end":"2026-09-18T02:23:48.086552Z","steps":["trace[1836543445] 'count revisions from in-memory index tree' (duration: 272.240933ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:48.086667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.864895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T02:23:48.08676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.649346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:23:48.086807Z","caller":"traceutil/trace.go:171","msg":"trace[1146728294] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:826; }","duration":"150.735587ms","start":"2026-09-18T02:23:47.936061Z","end":"2026-09-18T02:23:48.086797Z","steps":["trace[1146728294] 'count revisions from in-memory index tree' (duration: 150.557255ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:23:48.086766Z","caller":"traceutil/trace.go:171","msg":"trace[1561687296] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:826; }","duration":"300.007537ms","start":"2026-09-18T02:23:47.786739Z","end":"2026-09-18T02:23:48.086747Z","steps":["trace[1561687296] 'count revisions from in-memory index tree' (duration: 299.712993ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:48.086858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.851774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T02:23:48.08695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.371174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:23:48.087039Z","caller":"traceutil/trace.go:171","msg":"trace[36380632] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:826; }","duration":"300.060318ms","start":"2026-09-18T02:23:47.786956Z","end":"2026-09-18T02:23:48.087016Z","steps":["trace[36380632] 'range keys from in-memory index tree' (duration: 299.800654ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:23:48.087047Z","caller":"traceutil/trace.go:171","msg":"trace[1475454601] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:826; }","duration":"319.483365ms","start":"2026-09-18T02:23:47.767551Z","end":"2026-09-18T02:23:48.087035Z","steps":["trace[1475454601] 'range keys from in-memory index tree' (duration: 319.336483ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:48.086942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:47.786716Z","time spent":"300.20751ms","remote":"127.0.0.1:39866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-09-18T02:23:48.087113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.190221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:23:48.087171Z","caller":"traceutil/trace.go:171","msg":"trace[1846430521] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:826; }","duration":"319.288332ms","start":"2026-09-18T02:23:47.76787Z","end":"2026-09-18T02:23:48.087158Z","steps":["trace[1846430521] 'count revisions from in-memory index tree' (duration: 319.083719ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:48.087194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:47.786948Z","time spent":"300.11639ms","remote":"127.0.0.1:39866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-09-18T02:23:48.087213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:47.767849Z","time spent":"319.351883ms","remote":"127.0.0.1:39856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-09-18T02:23:48.087112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:47.767545Z","time spent":"319.525277ms","remote":"127.0.0.1:39856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-09-18T02:23:48.087286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.056285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7n4rr\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-09-18T02:23:48.087321Z","caller":"traceutil/trace.go:171","msg":"trace[1941494975] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7n4rr; range_end:; response_count:1; response_revision:826; }","duration":"320.161866ms","start":"2026-09-18T02:23:47.767149Z","end":"2026-09-18T02:23:48.08731Z","steps":["trace[1941494975] 'range keys from in-memory index tree' (duration: 319.909343ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:48.087378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:47.767133Z","time spent":"320.207638ms","remote":"127.0.0.1:51700","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3989,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-7n4rr\" "} {"level":"warn","ts":"2026-09-18T02:23:48.086346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.480934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:23:48.087498Z","caller":"traceutil/trace.go:171","msg":"trace[766192311] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:826; }","duration":"233.623612ms","start":"2026-09-18T02:23:47.85386Z","end":"2026-09-18T02:23:48.087484Z","steps":["trace[766192311] 'count revisions from in-memory index tree' (duration: 232.451243ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:48.086324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.649016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:23:48.087846Z","caller":"traceutil/trace.go:171","msg":"trace[2049069310] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:826; }","duration":"234.18184ms","start":"2026-09-18T02:23:47.853647Z","end":"2026-09-18T02:23:48.087829Z","steps":["trace[2049069310] 'range keys from in-memory index tree' (duration: 232.570735ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:23:48.087948Z","caller":"traceutil/trace.go:171","msg":"trace[1606757090] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:826; }","duration":"272.64933ms","start":"2026-09-18T02:23:47.81372Z","end":"2026-09-18T02:23:48.086369Z","steps":["trace[1606757090] 'range keys from in-memory index tree' (duration: 272.271823ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:48.089033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.039103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T02:23:48.089078Z","caller":"traceutil/trace.go:171","msg":"trace[53224439] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:826; }","duration":"315.126224ms","start":"2026-09-18T02:23:47.773938Z","end":"2026-09-18T02:23:48.089064Z","steps":["trace[53224439] 'count revisions from in-memory index tree' (duration: 313.775092ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:48.089841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:47.773928Z","time spent":"315.898267ms","remote":"127.0.0.1:51610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":94,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-09-18T02:24:19.295245Z","caller":"traceutil/trace.go:171","msg":"trace[1834701203] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"239.97023ms","start":"2026-09-18T02:24:19.055245Z","end":"2026-09-18T02:24:19.295215Z","steps":["trace[1834701203] 'process raft request' (duration: 166.603811ms)","trace[1834701203] 'compare' (duration: 73.227427ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:24:19.297203Z","caller":"traceutil/trace.go:171","msg":"trace[726855293] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"241.860887ms","start":"2026-09-18T02:24:19.055319Z","end":"2026-09-18T02:24:19.29718Z","steps":["trace[726855293] 'process raft request' (duration: 241.722985ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:19.297393Z","caller":"traceutil/trace.go:171","msg":"trace[421545063] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"241.747256ms","start":"2026-09-18T02:24:19.055625Z","end":"2026-09-18T02:24:19.297372Z","steps":["trace[421545063] 'process raft request' (duration: 241.519563ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:39.238866Z","caller":"traceutil/trace.go:171","msg":"trace[373723539] transaction","detail":"{read_only:false; response_revision:1380; number_of_response:1; }","duration":"102.969124ms","start":"2026-09-18T02:24:39.135852Z","end":"2026-09-18T02:24:39.238821Z","steps":["trace[373723539] 'process raft request' (duration: 102.236955ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:40.734414Z","caller":"traceutil/trace.go:171","msg":"trace[945885400] transaction","detail":"{read_only:false; response_revision:1418; number_of_response:1; }","duration":"117.391994ms","start":"2026-09-18T02:24:40.616959Z","end":"2026-09-18T02:24:40.734351Z","steps":["trace[945885400] 'process raft request' (duration: 117.223092ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:40.734432Z","caller":"traceutil/trace.go:171","msg":"trace[1216214528] transaction","detail":"{read_only:false; response_revision:1417; number_of_response:1; }","duration":"132.274404ms","start":"2026-09-18T02:24:40.602063Z","end":"2026-09-18T02:24:40.734337Z","steps":["trace[1216214528] 'process raft request' (duration: 72.995279ms)","trace[1216214528] 'compare' (duration: 58.864689ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:24:40.734984Z","caller":"traceutil/trace.go:171","msg":"trace[1230747370] transaction","detail":"{read_only:false; response_revision:1419; number_of_response:1; }","duration":"117.242363ms","start":"2026-09-18T02:24:40.617604Z","end":"2026-09-18T02:24:40.734847Z","steps":["trace[1230747370] 'process raft request' (duration: 116.675105ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:40.922284Z","caller":"traceutil/trace.go:171","msg":"trace[1379282833] transaction","detail":"{read_only:false; response_revision:1426; number_of_response:1; }","duration":"116.600264ms","start":"2026-09-18T02:24:40.805648Z","end":"2026-09-18T02:24:40.922248Z","steps":["trace[1379282833] 'process raft request' (duration: 116.444322ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:40.922362Z","caller":"traceutil/trace.go:171","msg":"trace[137785075] transaction","detail":"{read_only:false; response_revision:1425; number_of_response:1; }","duration":"118.368748ms","start":"2026-09-18T02:24:40.803823Z","end":"2026-09-18T02:24:40.922192Z","steps":["trace[137785075] 'process raft request' (duration: 35.396725ms)","trace[137785075] 'compare' (duration: 82.633058ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:24:41.112845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.550056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/ingress-nginx/ingress-nginx-defaultbackend\" ","response":"range_response_count:1 size:4121"} {"level":"info","ts":"2026-09-18T02:24:41.113051Z","caller":"traceutil/trace.go:171","msg":"trace[1928709259] range","detail":"{range_begin:/registry/deployments/ingress-nginx/ingress-nginx-defaultbackend; range_end:; response_count:1; response_revision:1441; }","duration":"100.812239ms","start":"2026-09-18T02:24:41.01221Z","end":"2026-09-18T02:24:41.113022Z","steps":["trace[1928709259] 'agreement among raft nodes before linearized reading' (duration: 100.400894ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:41.248446Z","caller":"traceutil/trace.go:171","msg":"trace[1798885162] transaction","detail":"{read_only:false; response_revision:1446; number_of_response:1; }","duration":"105.718224ms","start":"2026-09-18T02:24:41.142705Z","end":"2026-09-18T02:24:41.248423Z","steps":["trace[1798885162] 'process raft request' (duration: 105.591352ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:41.248631Z","caller":"traceutil/trace.go:171","msg":"trace[1874138216] transaction","detail":"{read_only:false; response_revision:1445; number_of_response:1; }","duration":"114.855097ms","start":"2026-09-18T02:24:41.133556Z","end":"2026-09-18T02:24:41.248411Z","steps":["trace[1874138216] 'process raft request' (duration: 87.45201ms)","trace[1874138216] 'compare' (duration: 27.169284ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:24:41.579588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.805222ms","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-09-18T02:24:41.57967Z","caller":"traceutil/trace.go:171","msg":"trace[735530470] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1457; }","duration":"116.995745ms","start":"2026-09-18T02:24:41.462655Z","end":"2026-09-18T02:24:41.579651Z","steps":["trace[735530470] 'range keys from in-memory index tree' (duration: 116.57938ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:41.580449Z","caller":"traceutil/trace.go:171","msg":"trace[756981059] transaction","detail":"{read_only:false; response_revision:1458; number_of_response:1; }","duration":"109.447624ms","start":"2026-09-18T02:24:41.470977Z","end":"2026-09-18T02:24:41.580425Z","steps":["trace[756981059] 'process raft request' (duration: 109.19163ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:24:41.6158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.207834ms","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-09-18T02:24:41.615879Z","caller":"traceutil/trace.go:171","msg":"trace[144184197] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1459; }","duration":"113.362336ms","start":"2026-09-18T02:24:41.502495Z","end":"2026-09-18T02:24:41.615858Z","steps":["trace[144184197] 'agreement among raft nodes before linearized reading' (duration: 113.073502ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:43.788872Z","caller":"traceutil/trace.go:171","msg":"trace[245139176] transaction","detail":"{read_only:false; response_revision:1488; number_of_response:1; }","duration":"142.7392ms","start":"2026-09-18T02:24:43.646079Z","end":"2026-09-18T02:24:43.788819Z","steps":["trace[245139176] 'process raft request' (duration: 60.81894ms)","trace[245139176] 'compare' (duration: 81.578376ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:24:59.322045Z","caller":"traceutil/trace.go:171","msg":"trace[1116699224] transaction","detail":"{read_only:false; response_revision:1724; number_of_response:1; }","duration":"108.672834ms","start":"2026-09-18T02:24:59.213312Z","end":"2026-09-18T02:24:59.321984Z","steps":["trace[1116699224] 'process raft request' (duration: 108.387931ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:59.449836Z","caller":"traceutil/trace.go:171","msg":"trace[1288619461] transaction","detail":"{read_only:false; response_revision:1726; number_of_response:1; }","duration":"105.024947ms","start":"2026-09-18T02:24:59.344789Z","end":"2026-09-18T02:24:59.449814Z","steps":["trace[1288619461] 'process raft request' (duration: 104.896546ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:59.651819Z","caller":"traceutil/trace.go:171","msg":"trace[1776669171] transaction","detail":"{read_only:false; response_revision:1729; number_of_response:1; }","duration":"119.96155ms","start":"2026-09-18T02:24:59.531796Z","end":"2026-09-18T02:24:59.651757Z","steps":["trace[1776669171] 'process raft request' (duration: 91.100259ms)","trace[1776669171] 'compare' (duration: 28.660109ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:24:59.920004Z","caller":"traceutil/trace.go:171","msg":"trace[1621084030] linearizableReadLoop","detail":"{readStateIndex:1801; appliedIndex:1800; }","duration":"116.401864ms","start":"2026-09-18T02:24:59.803578Z","end":"2026-09-18T02:24:59.91998Z","steps":["trace[1621084030] 'read index received' (duration: 37.770645ms)","trace[1621084030] 'applied index is now lower than readState.Index' (duration: 78.629459ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:24:59.920342Z","caller":"traceutil/trace.go:171","msg":"trace[1752394400] transaction","detail":"{read_only:false; response_revision:1730; number_of_response:1; }","duration":"248.524668ms","start":"2026-09-18T02:24:59.671538Z","end":"2026-09-18T02:24:59.920063Z","steps":["trace[1752394400] 'process raft request' (duration: 170.002651ms)","trace[1752394400] 'compare' (duration: 78.196403ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:24:59.920546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.968751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-18T02:24:59.920646Z","caller":"traceutil/trace.go:171","msg":"trace[2116962367] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1730; }","duration":"117.119374ms","start":"2026-09-18T02:24:59.803509Z","end":"2026-09-18T02:24:59.920628Z","steps":["trace[2116962367] 'agreement among raft nodes before linearized reading' (duration: 116.615547ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:02.141962Z","caller":"traceutil/trace.go:171","msg":"trace[76357778] transaction","detail":"{read_only:false; response_revision:1755; number_of_response:1; }","duration":"142.084793ms","start":"2026-09-18T02:25:01.999855Z","end":"2026-09-18T02:25:02.14194Z","steps":["trace[76357778] 'process raft request' (duration: 142.044092ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:02.142199Z","caller":"traceutil/trace.go:171","msg":"trace[1005875766] transaction","detail":"{read_only:false; response_revision:1753; number_of_response:1; }","duration":"146.981305ms","start":"2026-09-18T02:25:01.995206Z","end":"2026-09-18T02:25:02.142187Z","steps":["trace[1005875766] 'process raft request' (duration: 146.498799ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:02.142284Z","caller":"traceutil/trace.go:171","msg":"trace[11842997] transaction","detail":"{read_only:false; response_revision:1754; number_of_response:1; }","duration":"143.766104ms","start":"2026-09-18T02:25:01.99851Z","end":"2026-09-18T02:25:02.142276Z","steps":["trace[11842997] 'process raft request' (duration: 143.351159ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:02.161306Z","caller":"traceutil/trace.go:171","msg":"trace[1031396928] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1755; }","duration":"134.979882ms","start":"2026-09-18T02:25:02.026288Z","end":"2026-09-18T02:25:02.161267Z","steps":["trace[1031396928] 'process raft request' (duration: 134.451534ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:07.166523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.633681ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-09-18T02:25:07.166642Z","caller":"traceutil/trace.go:171","msg":"trace[564554789] linearizableReadLoop","detail":"{readStateIndex:1885; appliedIndex:1884; }","duration":"164.326535ms","start":"2026-09-18T02:25:07.002294Z","end":"2026-09-18T02:25:07.16662Z","steps":["trace[564554789] 'read index received' (duration: 33.515763ms)","trace[564554789] 'applied index is now lower than readState.Index' (duration: 130.809102ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:25:07.166825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.522308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-18T02:25:07.166883Z","caller":"traceutil/trace.go:171","msg":"trace[546318165] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1808; }","duration":"164.640759ms","start":"2026-09-18T02:25:07.002211Z","end":"2026-09-18T02:25:07.166852Z","steps":["trace[546318165] 'agreement among raft nodes before linearized reading' (duration: 164.466237ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:16.797155Z","caller":"traceutil/trace.go:171","msg":"trace[2032608271] linearizableReadLoop","detail":"{readStateIndex:2010; appliedIndex:2009; }","duration":"131.673477ms","start":"2026-09-18T02:25:16.665452Z","end":"2026-09-18T02:25:16.797125Z","steps":["trace[2032608271] 'read index received' (duration: 131.631807ms)","trace[2032608271] 'applied index is now lower than readState.Index' (duration: 40.55µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:16.797301Z","caller":"traceutil/trace.go:171","msg":"trace[780653501] transaction","detail":"{read_only:false; response_revision:1932; number_of_response:1; }","duration":"163.627916ms","start":"2026-09-18T02:25:16.633604Z","end":"2026-09-18T02:25:16.797232Z","steps":["trace[780653501] 'process raft request' (duration: 163.339912ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:16.797526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.050143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-18T02:25:16.798174Z","caller":"traceutil/trace.go:171","msg":"trace[114491205] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1932; }","duration":"132.402918ms","start":"2026-09-18T02:25:16.665444Z","end":"2026-09-18T02:25:16.797847Z","steps":["trace[114491205] 'agreement among raft nodes before linearized reading' (duration: 131.890981ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:16.819153Z","caller":"traceutil/trace.go:171","msg":"trace[566418527] transaction","detail":"{read_only:false; response_revision:1933; number_of_response:1; }","duration":"151.348602ms","start":"2026-09-18T02:25:16.667772Z","end":"2026-09-18T02:25:16.819121Z","steps":["trace[566418527] 'process raft request' (duration: 151.228191ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:17.324657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.217289ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-09-18T02:25:47.20118Z","caller":"traceutil/trace.go:171","msg":"trace[1522482152] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"121.723204ms","start":"2026-09-18T02:25:47.07942Z","end":"2026-09-18T02:25:47.201143Z","steps":["trace[1522482152] 'process raft request' (duration: 121.410481ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:47.608473Z","caller":"traceutil/trace.go:171","msg":"trace[1522156356] linearizableReadLoop","detail":"{readStateIndex:2236; appliedIndex:2235; }","duration":"138.207931ms","start":"2026-09-18T02:25:47.470234Z","end":"2026-09-18T02:25:47.608442Z","steps":["trace[1522156356] 'read index received' (duration: 81.810848ms)","trace[1522156356] 'applied index is now lower than readState.Index' (duration: 56.395103ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:47.608654Z","caller":"traceutil/trace.go:171","msg":"trace[1093247912] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"142.23671ms","start":"2026-09-18T02:25:47.466361Z","end":"2026-09-18T02:25:47.608598Z","steps":["trace[1093247912] 'process raft request' (duration: 85.635083ms)","trace[1093247912] 'compare' (duration: 56.180171ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:25:47.609072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.812549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-09-18T02:25:47.609163Z","caller":"traceutil/trace.go:171","msg":"trace[1804140950] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2150; }","duration":"138.963631ms","start":"2026-09-18T02:25:47.470173Z","end":"2026-09-18T02:25:47.609137Z","steps":["trace[1804140950] 'agreement among raft nodes before linearized reading' (duration: 138.491696ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:47.870188Z","caller":"traceutil/trace.go:171","msg":"trace[1386148403] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"254.137946ms","start":"2026-09-18T02:25:47.616018Z","end":"2026-09-18T02:25:47.870156Z","steps":["trace[1386148403] 'process raft request' (duration: 252.729799ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:47.903206Z","caller":"traceutil/trace.go:171","msg":"trace[535780499] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"160.138383ms","start":"2026-09-18T02:25:47.743013Z","end":"2026-09-18T02:25:47.903152Z","steps":["trace[535780499] 'process raft request' (duration: 159.777889ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:47.903958Z","caller":"traceutil/trace.go:171","msg":"trace[974574050] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"101.29953ms","start":"2026-09-18T02:25:47.802621Z","end":"2026-09-18T02:25:47.903921Z","steps":["trace[974574050] 'process raft request' (duration: 100.44689ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:54.173314Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5251092378288971751,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-09-18T02:25:54.693262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.168482ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T02:25:54.693441Z","caller":"traceutil/trace.go:171","msg":"trace[1051605969] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"1.033553376s","start":"2026-09-18T02:25:53.659863Z","end":"2026-09-18T02:25:54.693416Z","steps":["trace[1051605969] 'process raft request' (duration: 588.099751ms)","trace[1051605969] 'compare' (duration: 444.99543ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:25:54.693513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:53.659838Z","time spent":"1.033642779s","remote":"127.0.0.1:51786","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-09-18T02:25:54.739036Z","caller":"traceutil/trace.go:171","msg":"trace[394683197] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"793.653297ms","start":"2026-09-18T02:25:53.945355Z","end":"2026-09-18T02:25:54.739008Z","steps":["trace[394683197] 'process raft request' (duration: 793.341744ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:54.739279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:53.945333Z","time spent":"793.824439ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:25:54.739502Z","caller":"traceutil/trace.go:171","msg":"trace[1548800150] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"790.387808ms","start":"2026-09-18T02:25:53.949081Z","end":"2026-09-18T02:25:54.739469Z","steps":["trace[1548800150] 'process raft request' (duration: 789.73351ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:54.739754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:53.949062Z","time spent":"790.51279ms","remote":"127.0.0.1:51786","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-09-18T02:25:54.739762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.066866202s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-18T02:25:54.739906Z","caller":"traceutil/trace.go:171","msg":"trace[1189110961] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2184; }","duration":"1.067069483s","start":"2026-09-18T02:25:53.672818Z","end":"2026-09-18T02:25:54.739888Z","steps":["trace[1189110961] 'agreement among raft nodes before linearized reading' (duration: 1.06673599s)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:54.739934Z","caller":"traceutil/trace.go:171","msg":"trace[1176043897] linearizableReadLoop","detail":"{readStateIndex:2271; appliedIndex:2268; }","duration":"1.066429367s","start":"2026-09-18T02:25:53.672853Z","end":"2026-09-18T02:25:54.739282Z","steps":["trace[1176043897] 'read index received' (duration: 575.227409ms)","trace[1176043897] 'applied index is now lower than readState.Index' (duration: 491.200508ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:25:54.739978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:53.672804Z","time spent":"1.067162074s","remote":"127.0.0.1:57522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-18T02:25:55.05292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.864508ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T02:25:55.053059Z","caller":"traceutil/trace.go:171","msg":"trace[298337619] linearizableReadLoop","detail":"{readStateIndex:2272; appliedIndex:2271; }","duration":"313.008324ms","start":"2026-09-18T02:25:54.74001Z","end":"2026-09-18T02:25:55.053018Z","steps":["trace[298337619] 'read index received' (duration: 59.877711ms)","trace[298337619] 'applied index is now lower than readState.Index' (duration: 253.128863ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:55.053177Z","caller":"traceutil/trace.go:171","msg":"trace[250156358] transaction","detail":"{read_only:false; response_revision:2185; number_of_response:1; }","duration":"458.456708ms","start":"2026-09-18T02:25:54.594704Z","end":"2026-09-18T02:25:55.053161Z","steps":["trace[250156358] 'process raft request' (duration: 205.237885ms)","trace[250156358] 'compare' (duration: 252.501094ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:25:55.053259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:54.594664Z","time spent":"458.54961ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:25:55.053508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.18581927s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:25:55.054214Z","caller":"traceutil/trace.go:171","msg":"trace[1869555281] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2185; }","duration":"1.186542598s","start":"2026-09-18T02:25:53.867647Z","end":"2026-09-18T02:25:55.05419Z","steps":["trace[1869555281] 'agreement among raft nodes before linearized reading' (duration: 1.185724028s)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:55.053542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.295983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18d6492944d6c5ad\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-09-18T02:25:55.054373Z","caller":"traceutil/trace.go:171","msg":"trace[1086548187] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18d6492944d6c5ad; range_end:; response_count:1; response_revision:2185; }","duration":"473.144023ms","start":"2026-09-18T02:25:54.581206Z","end":"2026-09-18T02:25:55.05435Z","steps":["trace[1086548187] 'agreement among raft nodes before linearized reading' (duration: 472.221452ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:55.054469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:54.581195Z","time spent":"473.252334ms","remote":"127.0.0.1:51610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":870,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18d6492944d6c5ad\" "} {"level":"warn","ts":"2026-09-18T02:25:55.053537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.166714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-09-18T02:25:55.054327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:53.867635Z","time spent":"1.18667491s","remote":"127.0.0.1:51502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-18T02:25:55.054798Z","caller":"traceutil/trace.go:171","msg":"trace[1559648156] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2185; }","duration":"716.283158ms","start":"2026-09-18T02:25:54.338301Z","end":"2026-09-18T02:25:55.054584Z","steps":["trace[1559648156] 'agreement among raft nodes before linearized reading' (duration: 715.046433ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:55.055073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:54.33828Z","time spent":"716.775084ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-18T02:25:55.053675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.243772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-18T02:25:55.055258Z","caller":"traceutil/trace.go:171","msg":"trace[1613903776] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2185; }","duration":"527.880892ms","start":"2026-09-18T02:25:54.52736Z","end":"2026-09-18T02:25:55.055241Z","steps":["trace[1613903776] 'agreement among raft nodes before linearized reading' (duration: 526.225482ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:55.055298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:54.527336Z","time spent":"527.950722ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-18T02:25:55.053676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.120926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-09-18T02:25:55.053782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.146091548s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-18T02:25:55.055775Z","caller":"traceutil/trace.go:171","msg":"trace[830927662] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2185; }","duration":"1.148119002s","start":"2026-09-18T02:25:53.907636Z","end":"2026-09-18T02:25:55.055755Z","steps":["trace[830927662] 'agreement among raft nodes before linearized reading' (duration: 1.146018806s)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:55.05583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:53.907617Z","time spent":"1.148196864s","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-18T02:25:55.053677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.20664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12383"} {"level":"info","ts":"2026-09-18T02:25:55.055904Z","caller":"traceutil/trace.go:171","msg":"trace[1634478546] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2185; }","duration":"162.508608ms","start":"2026-09-18T02:25:54.893375Z","end":"2026-09-18T02:25:55.055884Z","steps":["trace[1634478546] 'agreement among raft nodes before linearized reading' (duration: 160.156709ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:55.053656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.475701ms","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-09-18T02:25:55.05617Z","caller":"traceutil/trace.go:171","msg":"trace[582983429] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2185; }","duration":"430.005611ms","start":"2026-09-18T02:25:54.626138Z","end":"2026-09-18T02:25:55.056144Z","steps":["trace[582983429] 'agreement among raft nodes before linearized reading' (duration: 427.442471ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:55.056214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:54.626126Z","time spent":"430.076172ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-18T02:25:55.05547Z","caller":"traceutil/trace.go:171","msg":"trace[963139783] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2185; }","duration":"481.953467ms","start":"2026-09-18T02:25:54.573491Z","end":"2026-09-18T02:25:55.055444Z","steps":["trace[963139783] 'agreement among raft nodes before linearized reading' (duration: 480.074134ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:55.056512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:54.573467Z","time spent":"483.024209ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-18T02:25:55.365458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.228391ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T02:25:55.365815Z","caller":"traceutil/trace.go:171","msg":"trace[2141761132] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"305.988857ms","start":"2026-09-18T02:25:55.059802Z","end":"2026-09-18T02:25:55.365791Z","steps":["trace[2141761132] 'process raft request' (duration: 144.31307ms)","trace[2141761132] 'compare' (duration: 160.997659ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:25:55.365907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:55.059781Z","time spent":"306.080118ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:25:55.36592Z","caller":"traceutil/trace.go:171","msg":"trace[1443034814] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"304.509019ms","start":"2026-09-18T02:25:55.061353Z","end":"2026-09-18T02:25:55.365863Z","steps":["trace[1443034814] 'process raft request' (duration: 304.375527ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:55.366081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:55.06134Z","time spent":"304.673531ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:25:55.36605Z","caller":"traceutil/trace.go:171","msg":"trace[791315431] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"302.942271ms","start":"2026-09-18T02:25:55.063077Z","end":"2026-09-18T02:25:55.366019Z","steps":["trace[791315431] 'process raft request' (duration: 302.710069ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:55.366277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:55.063062Z","time spent":"303.084743ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:25:55.366369Z","caller":"traceutil/trace.go:171","msg":"trace[256971038] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"302.421315ms","start":"2026-09-18T02:25:55.063933Z","end":"2026-09-18T02:25:55.366354Z","steps":["trace[256971038] 'process raft request' (duration: 301.895789ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:55.366461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:55.063921Z","time spent":"302.504806ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:25:55.366378Z","caller":"traceutil/trace.go:171","msg":"trace[1630942435] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"302.348474ms","start":"2026-09-18T02:25:55.064008Z","end":"2026-09-18T02:25:55.366356Z","steps":["trace[1630942435] 'process raft request' (duration: 302.230803ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:55.366605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:55.063998Z","time spent":"302.546626ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:25:55.366567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.754349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:25:55.366699Z","caller":"traceutil/trace.go:171","msg":"trace[207382255] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2191; }","duration":"292.888892ms","start":"2026-09-18T02:25:55.07376Z","end":"2026-09-18T02:25:55.366649Z","steps":["trace[207382255] 'agreement among raft nodes before linearized reading' (duration: 292.72255ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:55.366819Z","caller":"traceutil/trace.go:171","msg":"trace[1808528598] linearizableReadLoop","detail":"{readStateIndex:2278; appliedIndex:2273; }","duration":"292.574237ms","start":"2026-09-18T02:25:55.073802Z","end":"2026-09-18T02:25:55.366376Z","steps":["trace[1808528598] 'read index received' (duration: 130.316074ms)","trace[1808528598] 'applied index is now lower than readState.Index' (duration: 162.255963ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:25:55.366985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.961023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:25:55.367028Z","caller":"traceutil/trace.go:171","msg":"trace[552412749] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2191; }","duration":"293.031533ms","start":"2026-09-18T02:25:55.073986Z","end":"2026-09-18T02:25:55.367018Z","steps":["trace[552412749] 'agreement among raft nodes before linearized reading' (duration: 292.970193ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:55.367302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.296425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-09-18T02:25:55.36734Z","caller":"traceutil/trace.go:171","msg":"trace[1572479011] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2191; }","duration":"255.362567ms","start":"2026-09-18T02:25:55.111967Z","end":"2026-09-18T02:25:55.36733Z","steps":["trace[1572479011] 'agreement among raft nodes before linearized reading' (duration: 255.182555ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:55.590038Z","caller":"traceutil/trace.go:171","msg":"trace[1636882837] linearizableReadLoop","detail":"{readStateIndex:2280; appliedIndex:2279; }","duration":"153.012114ms","start":"2026-09-18T02:25:55.436984Z","end":"2026-09-18T02:25:55.589996Z","steps":["trace[1636882837] 'read index received' (duration: 59.046269ms)","trace[1636882837] 'applied index is now lower than readState.Index' (duration: 93.964925ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:25:55.590422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.434988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-18T02:25:55.590461Z","caller":"traceutil/trace.go:171","msg":"trace[569096431] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2193; }","duration":"153.52032ms","start":"2026-09-18T02:25:55.436928Z","end":"2026-09-18T02:25:55.590448Z","steps":["trace[569096431] 'agreement among raft nodes before linearized reading' (duration: 153.167926ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:55.590486Z","caller":"traceutil/trace.go:171","msg":"trace[73943876] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"219.368491ms","start":"2026-09-18T02:25:55.3711Z","end":"2026-09-18T02:25:55.590468Z","steps":["trace[73943876] 'process raft request' (duration: 124.931501ms)","trace[73943876] 'compare' (duration: 93.732852ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:25:56.039982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.651189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-18T02:25:56.040069Z","caller":"traceutil/trace.go:171","msg":"trace[1597983489] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2193; }","duration":"292.773121ms","start":"2026-09-18T02:25:55.74727Z","end":"2026-09-18T02:25:56.040043Z","steps":["trace[1597983489] 'range keys from in-memory index tree' (duration: 292.464307ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:57.062274Z","caller":"traceutil/trace.go:171","msg":"trace[228674681] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"362.178069ms","start":"2026-09-18T02:25:56.700076Z","end":"2026-09-18T02:25:57.062254Z","steps":["trace[228674681] 'process raft request' (duration: 361.991147ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:57.062437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:56.700052Z","time spent":"362.29225ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:25:57.577044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.358065ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T02:25:57.577506Z","caller":"traceutil/trace.go:171","msg":"trace[386069804] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"831.817265ms","start":"2026-09-18T02:25:56.74563Z","end":"2026-09-18T02:25:57.577447Z","steps":["trace[386069804] 'process raft request' (duration: 655.904293ms)","trace[386069804] 'compare' (duration: 175.135583ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:25:57.577652Z","caller":"traceutil/trace.go:171","msg":"trace[748532621] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"831.578982ms","start":"2026-09-18T02:25:56.746Z","end":"2026-09-18T02:25:57.577579Z","steps":["trace[748532621] 'process raft request' (duration: 831.190067ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:57.57784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:56.745605Z","time spent":"831.996747ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:25:57.57815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:56.74598Z","time spent":"831.815205ms","remote":"127.0.0.1:51786","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-09-18T02:25:57.903065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.763174ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-09-18T02:25:57.903195Z","caller":"traceutil/trace.go:171","msg":"trace[1374334772] linearizableReadLoop","detail":"{readStateIndex:2283; appliedIndex:2280; }","duration":"1.035887449s","start":"2026-09-18T02:25:56.867282Z","end":"2026-09-18T02:25:57.903169Z","steps":["trace[1374334772] 'read index received' (duration: 194.840708ms)","trace[1374334772] 'applied index is now lower than readState.Index' (duration: 841.044781ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:25:57.903437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.036148402s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:25:57.903474Z","caller":"traceutil/trace.go:171","msg":"trace[1102455287] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2196; }","duration":"1.036233102s","start":"2026-09-18T02:25:56.867228Z","end":"2026-09-18T02:25:57.903462Z","steps":["trace[1102455287] 'agreement among raft nodes before linearized reading' (duration: 1.03606973s)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:57.903509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:56.867207Z","time spent":"1.036293332s","remote":"127.0.0.1:51502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-18T02:25:57.903714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"857.608397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-18T02:25:57.903796Z","caller":"traceutil/trace.go:171","msg":"trace[129022032] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2196; }","duration":"857.739499ms","start":"2026-09-18T02:25:57.046034Z","end":"2026-09-18T02:25:57.903773Z","steps":["trace[129022032] 'agreement among raft nodes before linearized reading' (duration: 857.473807ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:57.903839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:57.046014Z","time spent":"857.81589ms","remote":"127.0.0.1:57522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-18T02:25:57.903888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.276758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-09-18T02:25:57.903901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.633169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-09-18T02:25:57.903946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.311528ms","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-09-18T02:25:57.903947Z","caller":"traceutil/trace.go:171","msg":"trace[432525127] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2196; }","duration":"532.335928ms","start":"2026-09-18T02:25:57.371594Z","end":"2026-09-18T02:25:57.90393Z","steps":["trace[432525127] 'agreement among raft nodes before linearized reading' (duration: 532.102156ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:57.90396Z","caller":"traceutil/trace.go:171","msg":"trace[1521844178] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2196; }","duration":"470.725709ms","start":"2026-09-18T02:25:57.433212Z","end":"2026-09-18T02:25:57.903938Z","steps":["trace[1521844178] 'agreement among raft nodes before linearized reading' (duration: 470.530227ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:57.903978Z","caller":"traceutil/trace.go:171","msg":"trace[192990463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2196; }","duration":"532.354509ms","start":"2026-09-18T02:25:57.371613Z","end":"2026-09-18T02:25:57.903968Z","steps":["trace[192990463] 'agreement among raft nodes before linearized reading' (duration: 532.236087ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:57.904003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:57.371609Z","time spent":"532.387959ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-18T02:25:57.903997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:57.433182Z","time spent":"470.805611ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-09-18T02:25:57.904002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:57.37157Z","time spent":"532.41575ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-18T02:25:57.904088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.125607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-09-18T02:25:57.90413Z","caller":"traceutil/trace.go:171","msg":"trace[1131213104] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2196; }","duration":"472.197837ms","start":"2026-09-18T02:25:57.431918Z","end":"2026-09-18T02:25:57.904116Z","steps":["trace[1131213104] 'agreement among raft nodes before linearized reading' (duration: 471.786842ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:57.904173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:57.431896Z","time spent":"472.261688ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":554,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-09-18T02:25:57.904264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.979998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-18T02:25:57.904309Z","caller":"traceutil/trace.go:171","msg":"trace[1114256504] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2196; }","duration":"534.060109ms","start":"2026-09-18T02:25:57.370236Z","end":"2026-09-18T02:25:57.904296Z","steps":["trace[1114256504] 'agreement among raft nodes before linearized reading' (duration: 533.927788ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:57.904336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.485522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-09-18T02:25:57.904346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:57.370219Z","time spent":"534.11646ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-18T02:25:57.904424Z","caller":"traceutil/trace.go:171","msg":"trace[26817748] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2196; }","duration":"533.629194ms","start":"2026-09-18T02:25:57.370779Z","end":"2026-09-18T02:25:57.904408Z","steps":["trace[26817748] 'agreement among raft nodes before linearized reading' (duration: 533.374982ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:57.904468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:57.370757Z","time spent":"533.699735ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-18T02:25:57.904133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.945936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-18T02:25:57.904548Z","caller":"traceutil/trace.go:171","msg":"trace[1035207148] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2196; }","duration":"533.363721ms","start":"2026-09-18T02:25:57.37116Z","end":"2026-09-18T02:25:57.904524Z","steps":["trace[1035207148] 'agreement among raft nodes before linearized reading' (duration: 532.887345ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:57.904638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:57.371152Z","time spent":"533.470572ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-18T02:25:58.154808Z","caller":"traceutil/trace.go:171","msg":"trace[1703299801] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"240.733787ms","start":"2026-09-18T02:25:57.914032Z","end":"2026-09-18T02:25:58.154766Z","steps":["trace[1703299801] 'process raft request' (duration: 240.360653ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:58.154755Z","caller":"traceutil/trace.go:171","msg":"trace[643941049] linearizableReadLoop","detail":"{readStateIndex:2285; appliedIndex:2284; }","duration":"240.402622ms","start":"2026-09-18T02:25:57.914316Z","end":"2026-09-18T02:25:58.154719Z","steps":["trace[643941049] 'read index received' (duration: 240.156019ms)","trace[643941049] 'applied index is now lower than readState.Index' (duration: 245.033µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:25:58.155021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.669505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:25:58.155268Z","caller":"traceutil/trace.go:171","msg":"trace[1934246053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2197; }","duration":"241.022741ms","start":"2026-09-18T02:25:57.914225Z","end":"2026-09-18T02:25:58.155248Z","steps":["trace[1934246053] 'agreement among raft nodes before linearized reading' (duration: 240.605875ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:58.230201Z","caller":"traceutil/trace.go:171","msg":"trace[182355811] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"313.83186ms","start":"2026-09-18T02:25:57.916317Z","end":"2026-09-18T02:25:58.230148Z","steps":["trace[182355811] 'process raft request' (duration: 304.613001ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:58.230615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:57.916285Z","time spent":"314.018893ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:25:58.23118Z","caller":"traceutil/trace.go:171","msg":"trace[258510860] transaction","detail":"{read_only:false; response_revision:2200; number_of_response:1; }","duration":"313.607758ms","start":"2026-09-18T02:25:57.917538Z","end":"2026-09-18T02:25:58.231146Z","steps":["trace[258510860] 'process raft request' (duration: 313.055671ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:58.231407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:57.917521Z","time spent":"313.744999ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:25:58.231599Z","caller":"traceutil/trace.go:171","msg":"trace[1702680555] transaction","detail":"{read_only:false; response_revision:2202; number_of_response:1; }","duration":"312.510925ms","start":"2026-09-18T02:25:57.91907Z","end":"2026-09-18T02:25:58.231581Z","steps":["trace[1702680555] 'process raft request' (duration: 311.939178ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:58.231236Z","caller":"traceutil/trace.go:171","msg":"trace[866923905] transaction","detail":"{read_only:false; response_revision:2201; number_of_response:1; }","duration":"312.437645ms","start":"2026-09-18T02:25:57.918781Z","end":"2026-09-18T02:25:58.231219Z","steps":["trace[866923905] 'process raft request' (duration: 312.143452ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:25:58.231847Z","caller":"traceutil/trace.go:171","msg":"trace[2143473633] transaction","detail":"{read_only:false; response_revision:2203; number_of_response:1; }","duration":"310.033446ms","start":"2026-09-18T02:25:57.921789Z","end":"2026-09-18T02:25:58.231823Z","steps":["trace[2143473633] 'process raft request' (duration: 309.269197ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:58.231924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:57.918746Z","time spent":"313.133203ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:25:58.231955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:57.921776Z","time spent":"310.124797ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:25:58.232124Z","caller":"traceutil/trace.go:171","msg":"trace[1190421176] transaction","detail":"{read_only:false; response_revision:2204; number_of_response:1; }","duration":"186.9326ms","start":"2026-09-18T02:25:58.045174Z","end":"2026-09-18T02:25:58.232107Z","steps":["trace[1190421176] 'process raft request' (duration: 185.932349ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:58.231864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:57.919061Z","time spent":"312.745458ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:25:58.231705Z","caller":"traceutil/trace.go:171","msg":"trace[1460452627] transaction","detail":"{read_only:false; response_revision:2199; number_of_response:1; }","duration":"315.223697ms","start":"2026-09-18T02:25:57.916465Z","end":"2026-09-18T02:25:58.231689Z","steps":["trace[1460452627] 'process raft request' (duration: 313.619849ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:58.231724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.589646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:25:58.232702Z","caller":"traceutil/trace.go:171","msg":"trace[962203356] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:2204; }","duration":"253.647529ms","start":"2026-09-18T02:25:57.979032Z","end":"2026-09-18T02:25:58.232679Z","steps":["trace[962203356] 'agreement among raft nodes before linearized reading' (duration: 252.423434ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:25:58.233181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:25:57.916442Z","time spent":"316.098427ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:28:07.142602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.375063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-18T02:28:07.142669Z","caller":"traceutil/trace.go:171","msg":"trace[244758975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2986; }","duration":"154.516279ms","start":"2026-09-18T02:28:06.988137Z","end":"2026-09-18T02:28:07.142653Z","steps":["trace[244758975] 'range keys from in-memory index tree' (duration: 154.191736ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:28:07.142959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.067555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-18T02:28:07.142991Z","caller":"traceutil/trace.go:171","msg":"trace[1546625905] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2986; }","duration":"142.122227ms","start":"2026-09-18T02:28:07.000861Z","end":"2026-09-18T02:28:07.142983Z","steps":["trace[1546625905] 'range keys from in-memory index tree' (duration: 141.995943ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:28:07.142927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.686958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-18T02:28:07.143107Z","caller":"traceutil/trace.go:171","msg":"trace[897812223] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2986; }","duration":"174.966848ms","start":"2026-09-18T02:28:06.968111Z","end":"2026-09-18T02:28:07.143078Z","steps":["trace[897812223] 'range keys from in-memory index tree' (duration: 174.446619ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:28:07.142949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.464212ms","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-09-18T02:28:07.143664Z","caller":"traceutil/trace.go:171","msg":"trace[1164783136] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2986; }","duration":"153.200099ms","start":"2026-09-18T02:28:06.990443Z","end":"2026-09-18T02:28:07.143643Z","steps":["trace[1164783136] 'range keys from in-memory index tree' (duration: 152.354908ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:28:07.71539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.714137ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-09-18T02:28:07.715701Z","caller":"traceutil/trace.go:171","msg":"trace[2069763767] linearizableReadLoop","detail":"{readStateIndex:3107; appliedIndex:3106; }","duration":"291.794162ms","start":"2026-09-18T02:28:07.423879Z","end":"2026-09-18T02:28:07.715674Z","steps":["trace[2069763767] 'read index received' (duration: 29.811µs)","trace[2069763767] 'applied index is now lower than readState.Index' (duration: 291.761381ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:28:07.715954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.057244ms","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-09-18T02:28:07.716008Z","caller":"traceutil/trace.go:171","msg":"trace[1695117676] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2991; }","duration":"292.143767ms","start":"2026-09-18T02:28:07.423848Z","end":"2026-09-18T02:28:07.715992Z","steps":["trace[1695117676] 'agreement among raft nodes before linearized reading' (duration: 291.885076ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:28:07.745938Z","caller":"traceutil/trace.go:171","msg":"trace[529511556] transaction","detail":"{read_only:false; response_revision:2992; number_of_response:1; }","duration":"296.760147ms","start":"2026-09-18T02:28:07.449154Z","end":"2026-09-18T02:28:07.745914Z","steps":["trace[529511556] 'process raft request' (duration: 296.56058ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:28:07.760697Z","caller":"traceutil/trace.go:171","msg":"trace[881086698] transaction","detail":"{read_only:false; response_revision:2993; number_of_response:1; }","duration":"166.962176ms","start":"2026-09-18T02:28:07.59371Z","end":"2026-09-18T02:28:07.760672Z","steps":["trace[881086698] 'process raft request' (duration: 166.737467ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:28:07.760781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.155683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:28:07.76084Z","caller":"traceutil/trace.go:171","msg":"trace[680062113] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2993; }","duration":"270.260237ms","start":"2026-09-18T02:28:07.490564Z","end":"2026-09-18T02:28:07.760824Z","steps":["trace[680062113] 'agreement among raft nodes before linearized reading' (duration: 270.137662ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:50.006548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.401281ms","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-09-18T02:29:50.006683Z","caller":"traceutil/trace.go:171","msg":"trace[1269442140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3522; }","duration":"119.629216ms","start":"2026-09-18T02:29:49.887028Z","end":"2026-09-18T02:29:50.006657Z","steps":["trace[1269442140] 'range keys from in-memory index tree' (duration: 119.159215ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:32:38.230009Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2829} {"level":"info","ts":"2026-09-18T02:32:38.353565Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2829,"took":"122.524827ms","hash":2690595785,"current-db-size-bytes":44556288,"current-db-size":"45 MB","current-db-size-in-use-bytes":19906560,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-09-18T02:32:38.353633Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2690595785,"revision":2829,"compact-revision":-1} {"level":"info","ts":"2026-09-18T02:32:53.046617Z","caller":"traceutil/trace.go:171","msg":"trace[158746401] linearizableReadLoop","detail":"{readStateIndex:5369; appliedIndex:5367; }","duration":"135.847476ms","start":"2026-09-18T02:32:52.91073Z","end":"2026-09-18T02:32:53.046578Z","steps":["trace[158746401] 'read index received' (duration: 26.513921ms)","trace[158746401] 'applied index is now lower than readState.Index' (duration: 109.331485ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:32:53.04676Z","caller":"traceutil/trace.go:171","msg":"trace[1222022421] transaction","detail":"{read_only:false; response_revision:5164; number_of_response:1; }","duration":"137.308183ms","start":"2026-09-18T02:32:52.909404Z","end":"2026-09-18T02:32:53.046712Z","steps":["trace[1222022421] 'process raft request' (duration: 136.365826ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:32:53.0469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.153211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-18T02:32:53.047017Z","caller":"traceutil/trace.go:171","msg":"trace[1048686439] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5164; }","duration":"136.281884ms","start":"2026-09-18T02:32:52.910717Z","end":"2026-09-18T02:32:53.046999Z","steps":["trace[1048686439] 'agreement among raft nodes before linearized reading' (duration: 136.062649ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:32:53.056617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.884251ms","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-09-18T02:32:53.056734Z","caller":"traceutil/trace.go:171","msg":"trace[904583404] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:5165; }","duration":"112.079065ms","start":"2026-09-18T02:32:52.944631Z","end":"2026-09-18T02:32:53.05671Z","steps":["trace[904583404] 'agreement among raft nodes before linearized reading' (duration: 111.24146ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:32:53.057203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.949775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-09-18T02:32:53.057306Z","caller":"traceutil/trace.go:171","msg":"trace[1269026295] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5165; }","duration":"127.102609ms","start":"2026-09-18T02:32:52.930177Z","end":"2026-09-18T02:32:53.057279Z","steps":["trace[1269026295] 'agreement among raft nodes before linearized reading' (duration: 125.565771ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:32:53.979217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.991772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:32:53.979543Z","caller":"traceutil/trace.go:171","msg":"trace[847796192] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5187; }","duration":"112.331328ms","start":"2026-09-18T02:32:53.867187Z","end":"2026-09-18T02:32:53.979519Z","steps":["trace[847796192] 'range keys from in-memory index tree' (duration: 111.876921ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:33:01.09267Z","caller":"traceutil/trace.go:171","msg":"trace[482024861] linearizableReadLoop","detail":"{readStateIndex:5446; appliedIndex:5445; }","duration":"108.135028ms","start":"2026-09-18T02:33:00.984469Z","end":"2026-09-18T02:33:01.092604Z","steps":["trace[482024861] 'read index received' (duration: 29.526932ms)","trace[482024861] 'applied index is now lower than readState.Index' (duration: 78.606786ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:33:01.092819Z","caller":"traceutil/trace.go:171","msg":"trace[1819441525] transaction","detail":"{read_only:false; response_revision:5239; number_of_response:1; }","duration":"111.750624ms","start":"2026-09-18T02:33:00.981052Z","end":"2026-09-18T02:33:01.092803Z","steps":["trace[1819441525] 'process raft request' (duration: 33.064816ms)","trace[1819441525] 'compare' (duration: 78.227919ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:33:01.093124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.615946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-b4ac18eb-578d-4a13-ac8a-1b948610adb8\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-09-18T02:33:01.09326Z","caller":"traceutil/trace.go:171","msg":"trace[712310807] range","detail":"{range_begin:/registry/persistentvolumes/pvc-b4ac18eb-578d-4a13-ac8a-1b948610adb8; range_end:; response_count:1; response_revision:5239; }","duration":"108.80178ms","start":"2026-09-18T02:33:00.984431Z","end":"2026-09-18T02:33:01.093233Z","steps":["trace[712310807] 'agreement among raft nodes before linearized reading' (duration: 108.480895ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:33:01.093688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.118676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-18T02:33:01.093789Z","caller":"traceutil/trace.go:171","msg":"trace[616559478] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5240; }","duration":"109.235568ms","start":"2026-09-18T02:33:00.984543Z","end":"2026-09-18T02:33:01.093779Z","steps":["trace[616559478] 'agreement among raft nodes before linearized reading' (duration: 108.979984ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:33:03.023463Z","caller":"traceutil/trace.go:171","msg":"trace[1251612511] linearizableReadLoop","detail":"{readStateIndex:5528; appliedIndex:5527; }","duration":"115.876585ms","start":"2026-09-18T02:33:02.907545Z","end":"2026-09-18T02:33:03.023422Z","steps":["trace[1251612511] 'read index received' (duration: 115.614609ms)","trace[1251612511] 'applied index is now lower than readState.Index' (duration: 261.015µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:33:03.023536Z","caller":"traceutil/trace.go:171","msg":"trace[971229804] transaction","detail":"{read_only:false; response_revision:5320; number_of_response:1; }","duration":"116.652029ms","start":"2026-09-18T02:33:02.906845Z","end":"2026-09-18T02:33:03.023497Z","steps":["trace[971229804] 'process raft request' (duration: 116.400235ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:33:03.023768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.18451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-09-18T02:33:03.023812Z","caller":"traceutil/trace.go:171","msg":"trace[67300653] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5320; }","duration":"116.257471ms","start":"2026-09-18T02:33:02.90754Z","end":"2026-09-18T02:33:03.023798Z","steps":["trace[67300653] 'agreement among raft nodes before linearized reading' (duration: 116.029597ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:33:05.282151Z","caller":"traceutil/trace.go:171","msg":"trace[1449278208] transaction","detail":"{read_only:false; response_revision:5344; number_of_response:1; }","duration":"231.787269ms","start":"2026-09-18T02:33:05.050085Z","end":"2026-09-18T02:33:05.281872Z","steps":["trace[1449278208] 'process raft request' (duration: 231.604026ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:33:05.320541Z","caller":"traceutil/trace.go:171","msg":"trace[1220541317] transaction","detail":"{read_only:false; response_revision:5345; number_of_response:1; }","duration":"212.492993ms","start":"2026-09-18T02:33:05.108012Z","end":"2026-09-18T02:33:05.320505Z","steps":["trace[1220541317] 'process raft request' (duration: 210.034409ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:33:05.320696Z","caller":"traceutil/trace.go:171","msg":"trace[169247123] linearizableReadLoop","detail":"{readStateIndex:5553; appliedIndex:5551; }","duration":"193.012372ms","start":"2026-09-18T02:33:05.12765Z","end":"2026-09-18T02:33:05.320663Z","steps":["trace[169247123] 'read index received' (duration: 153.989773ms)","trace[169247123] 'applied index is now lower than readState.Index' (duration: 39.017129ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:33:05.320885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.216447ms","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-09-18T02:33:05.320958Z","caller":"traceutil/trace.go:171","msg":"trace[836778053] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5346; }","duration":"193.304129ms","start":"2026-09-18T02:33:05.127615Z","end":"2026-09-18T02:33:05.320919Z","steps":["trace[836778053] 'agreement among raft nodes before linearized reading' (duration: 193.155976ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:33:05.320978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.214681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-18T02:33:05.321017Z","caller":"traceutil/trace.go:171","msg":"trace[552361953] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5346; }","duration":"191.307843ms","start":"2026-09-18T02:33:05.129699Z","end":"2026-09-18T02:33:05.321007Z","steps":["trace[552361953] 'agreement among raft nodes before linearized reading' (duration: 191.12263ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:33:05.321177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.297205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-09-18T02:33:05.321165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.848177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-18T02:33:05.321201Z","caller":"traceutil/trace.go:171","msg":"trace[696635870] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5346; }","duration":"151.341845ms","start":"2026-09-18T02:33:05.169851Z","end":"2026-09-18T02:33:05.321193Z","steps":["trace[696635870] 'agreement among raft nodes before linearized reading' (duration: 151.267424ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:33:05.321233Z","caller":"traceutil/trace.go:171","msg":"trace[10493749] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5346; }","duration":"145.943519ms","start":"2026-09-18T02:33:05.175272Z","end":"2026-09-18T02:33:05.321216Z","steps":["trace[10493749] 'agreement among raft nodes before linearized reading' (duration: 145.750705ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:33:14.282309Z","caller":"traceutil/trace.go:171","msg":"trace[1329523994] transaction","detail":"{read_only:false; response_revision:5479; number_of_response:1; }","duration":"133.386656ms","start":"2026-09-18T02:33:14.148897Z","end":"2026-09-18T02:33:14.282284Z","steps":["trace[1329523994] 'process raft request' (duration: 99.124275ms)","trace[1329523994] 'compare' (duration: 34.059176ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:33:14.282774Z","caller":"traceutil/trace.go:171","msg":"trace[142178018] transaction","detail":"{read_only:false; response_revision:5481; number_of_response:1; }","duration":"132.249805ms","start":"2026-09-18T02:33:14.150497Z","end":"2026-09-18T02:33:14.282746Z","steps":["trace[142178018] 'process raft request' (duration: 132.097423ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:33:14.282884Z","caller":"traceutil/trace.go:171","msg":"trace[572600339] transaction","detail":"{read_only:false; response_revision:5480; number_of_response:1; }","duration":"133.69382ms","start":"2026-09-18T02:33:14.14917Z","end":"2026-09-18T02:33:14.282864Z","steps":["trace[572600339] 'process raft request' (duration: 133.045689ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:33:51.708454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.229221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-09-18T02:33:51.709134Z","caller":"traceutil/trace.go:171","msg":"trace[1148896293] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5793; }","duration":"133.502444ms","start":"2026-09-18T02:33:51.575602Z","end":"2026-09-18T02:33:51.709104Z","steps":["trace[1148896293] 'range keys from in-memory index tree' (duration: 132.058029ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:33:51.708806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.431859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-18T02:33:51.709353Z","caller":"traceutil/trace.go:171","msg":"trace[252362334] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5793; }","duration":"119.976388ms","start":"2026-09-18T02:33:51.589341Z","end":"2026-09-18T02:33:51.709318Z","steps":["trace[252362334] 'range keys from in-memory index tree' (duration: 119.323397ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:33:51.708916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.570065ms","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-09-18T02:33:51.709655Z","caller":"traceutil/trace.go:171","msg":"trace[1303785453] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5793; }","duration":"130.321638ms","start":"2026-09-18T02:33:51.579317Z","end":"2026-09-18T02:33:51.709638Z","steps":["trace[1303785453] 'range keys from in-memory index tree' (duration: 129.438633ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:33:51.708992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.481418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-18T02:33:51.709779Z","caller":"traceutil/trace.go:171","msg":"trace[866324171] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5793; }","duration":"121.303651ms","start":"2026-09-18T02:33:51.588463Z","end":"2026-09-18T02:33:51.709766Z","steps":["trace[866324171] 'range keys from in-memory index tree' (duration: 120.339685ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:36:18.924214Z","caller":"traceutil/trace.go:171","msg":"trace[1006753978] transaction","detail":"{read_only:false; response_revision:6718; number_of_response:1; }","duration":"596.158746ms","start":"2026-09-18T02:36:18.32804Z","end":"2026-09-18T02:36:18.924198Z","steps":["trace[1006753978] 'process raft request' (duration: 595.966769ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:36:18.924321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:36:18.328023Z","time spent":"596.236018ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:36:18.924331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.513591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:36:18.92417Z","caller":"traceutil/trace.go:171","msg":"trace[91447973] linearizableReadLoop","detail":"{readStateIndex:6971; appliedIndex:6970; }","duration":"447.330934ms","start":"2026-09-18T02:36:18.476817Z","end":"2026-09-18T02:36:18.924148Z","steps":["trace[91447973] 'read index received' (duration: 447.181699ms)","trace[91447973] 'applied index is now lower than readState.Index' (duration: 148.315µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:36:18.924387Z","caller":"traceutil/trace.go:171","msg":"trace[798536653] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:6718; }","duration":"447.617695ms","start":"2026-09-18T02:36:18.476753Z","end":"2026-09-18T02:36:18.92437Z","steps":["trace[798536653] 'agreement among raft nodes before linearized reading' (duration: 447.496881ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:36:18.924513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:36:18.47673Z","time spent":"447.767241ms","remote":"127.0.0.1:39906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-09-18T02:36:19.425014Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5251092378288983185,"retry-timeout":"500ms"} {"level":"info","ts":"2026-09-18T02:36:19.486335Z","caller":"traceutil/trace.go:171","msg":"trace[1354167393] linearizableReadLoop","detail":"{readStateIndex:6972; appliedIndex:6971; }","duration":"561.882766ms","start":"2026-09-18T02:36:18.924417Z","end":"2026-09-18T02:36:19.4863Z","steps":["trace[1354167393] 'read index received' (duration: 561.549204ms)","trace[1354167393] 'applied index is now lower than readState.Index' (duration: 331.842µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:36:19.486446Z","caller":"traceutil/trace.go:171","msg":"trace[79743708] transaction","detail":"{read_only:false; response_revision:6719; number_of_response:1; }","duration":"990.322953ms","start":"2026-09-18T02:36:18.496082Z","end":"2026-09-18T02:36:19.486405Z","steps":["trace[79743708] 'process raft request' (duration: 989.94908ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:36:19.486548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.741741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-09-18T02:36:19.486607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:36:18.496047Z","time spent":"990.466458ms","remote":"127.0.0.1:51752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6923,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:36:19.486629Z","caller":"traceutil/trace.go:171","msg":"trace[898352120] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6719; }","duration":"896.857216ms","start":"2026-09-18T02:36:18.589751Z","end":"2026-09-18T02:36:19.486608Z","steps":["trace[898352120] 'agreement among raft nodes before linearized reading' (duration: 896.616937ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:36:19.486676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:36:18.589738Z","time spent":"896.925878ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-18T02:36:19.4867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"900.210667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-18T02:36:19.486718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.73038ms","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":"info","ts":"2026-09-18T02:36:19.486744Z","caller":"traceutil/trace.go:171","msg":"trace[705025982] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6719; }","duration":"900.307901ms","start":"2026-09-18T02:36:18.586423Z","end":"2026-09-18T02:36:19.48673Z","steps":["trace[705025982] 'agreement among raft nodes before linearized reading' (duration: 900.087112ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:36:19.486781Z","caller":"traceutil/trace.go:171","msg":"trace[1746724239] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:6719; }","duration":"428.832064ms","start":"2026-09-18T02:36:19.057932Z","end":"2026-09-18T02:36:19.486765Z","steps":["trace[1746724239] 'agreement among raft nodes before linearized reading' (duration: 428.73137ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:36:19.486839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:36:19.057913Z","time spent":"428.912097ms","remote":"127.0.0.1:51734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-09-18T02:36:19.486935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"927.668849ms","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-09-18T02:36:19.486974Z","caller":"traceutil/trace.go:171","msg":"trace[1505996045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6719; }","duration":"927.739053ms","start":"2026-09-18T02:36:18.559226Z","end":"2026-09-18T02:36:19.486965Z","steps":["trace[1505996045] 'agreement among raft nodes before linearized reading' (duration: 927.639439ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:36:19.487001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:36:18.55921Z","time spent":"927.784724ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-18T02:36:19.486793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:36:18.586409Z","time spent":"900.374092ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-18T02:36:19.487349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.854817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-09-18T02:36:19.487418Z","caller":"traceutil/trace.go:171","msg":"trace[340107981] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:6719; }","duration":"891.933268ms","start":"2026-09-18T02:36:18.595455Z","end":"2026-09-18T02:36:19.487389Z","steps":["trace[340107981] 'agreement among raft nodes before linearized reading' (duration: 890.881141ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:36:19.487458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:36:18.59544Z","time spent":"892.009332ms","remote":"127.0.0.1:51786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-09-18T02:36:19.6151Z","caller":"traceutil/trace.go:171","msg":"trace[370587852] transaction","detail":"{read_only:false; response_revision:6720; number_of_response:1; }","duration":"122.381096ms","start":"2026-09-18T02:36:19.49269Z","end":"2026-09-18T02:36:19.615071Z","steps":["trace[370587852] 'process raft request' (duration: 89.939736ms)","trace[370587852] 'compare' (duration: 32.316426ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:36:19.674391Z","caller":"traceutil/trace.go:171","msg":"trace[1787925052] transaction","detail":"{read_only:false; response_revision:6721; number_of_response:1; }","duration":"180.709522ms","start":"2026-09-18T02:36:19.493654Z","end":"2026-09-18T02:36:19.674364Z","steps":["trace[1787925052] 'process raft request' (duration: 180.470703ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:36:19.674779Z","caller":"traceutil/trace.go:171","msg":"trace[396256238] linearizableReadLoop","detail":"{readStateIndex:6976; appliedIndex:6972; }","duration":"135.671641ms","start":"2026-09-18T02:36:19.539077Z","end":"2026-09-18T02:36:19.674749Z","steps":["trace[396256238] 'read index received' (duration: 43.594039ms)","trace[396256238] 'applied index is now lower than readState.Index' (duration: 92.072202ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:36:19.674808Z","caller":"traceutil/trace.go:171","msg":"trace[85145462] transaction","detail":"{read_only:false; response_revision:6722; number_of_response:1; }","duration":"181.024353ms","start":"2026-09-18T02:36:19.49373Z","end":"2026-09-18T02:36:19.674754Z","steps":["trace[85145462] 'process raft request' (duration: 180.569348ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:36:19.675108Z","caller":"traceutil/trace.go:171","msg":"trace[1710049115] transaction","detail":"{read_only:false; response_revision:6723; number_of_response:1; }","duration":"181.339024ms","start":"2026-09-18T02:36:19.49375Z","end":"2026-09-18T02:36:19.675089Z","steps":["trace[1710049115] 'process raft request' (duration: 180.920169ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:36:19.675406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.616836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-18T02:36:19.675481Z","caller":"traceutil/trace.go:171","msg":"trace[857357745] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:6723; }","duration":"105.736121ms","start":"2026-09-18T02:36:19.569718Z","end":"2026-09-18T02:36:19.675455Z","steps":["trace[857357745] 'agreement among raft nodes before linearized reading' (duration: 105.546454ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:36:19.676157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.077161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:36:19.676228Z","caller":"traceutil/trace.go:171","msg":"trace[821190977] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:6723; }","duration":"137.158484ms","start":"2026-09-18T02:36:19.539055Z","end":"2026-09-18T02:36:19.676214Z","steps":["trace[821190977] 'agreement among raft nodes before linearized reading' (duration: 136.121517ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:36:20.399243Z","caller":"traceutil/trace.go:171","msg":"trace[1862447826] transaction","detail":"{read_only:false; response_revision:6727; number_of_response:1; }","duration":"168.010016ms","start":"2026-09-18T02:36:20.231173Z","end":"2026-09-18T02:36:20.399183Z","steps":["trace[1862447826] 'process raft request' (duration: 167.945124ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:36:20.399866Z","caller":"traceutil/trace.go:171","msg":"trace[1571081951] transaction","detail":"{read_only:false; response_revision:6726; number_of_response:1; }","duration":"194.917017ms","start":"2026-09-18T02:36:20.204935Z","end":"2026-09-18T02:36:20.399852Z","steps":["trace[1571081951] 'process raft request' (duration: 99.565214ms)","trace[1571081951] 'compare' (duration: 94.43377ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:36:23.63359Z","caller":"traceutil/trace.go:171","msg":"trace[1011266473] transaction","detail":"{read_only:false; response_revision:6742; number_of_response:1; }","duration":"101.131679ms","start":"2026-09-18T02:36:23.532435Z","end":"2026-09-18T02:36:23.633567Z","steps":["trace[1011266473] 'process raft request' (duration: 100.956753ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:37:38.237909Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4587} {"level":"info","ts":"2026-09-18T02:37:38.293759Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4587,"took":"53.351783ms","hash":3413219679,"current-db-size-bytes":44556288,"current-db-size":"45 MB","current-db-size-in-use-bytes":32972800,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-09-18T02:37:38.293961Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3413219679,"revision":4587,"compact-revision":2829}