{"level":"warn","ts":"2026-09-18T02:19:57.572346Z","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:19:57.57244Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.82: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.82:2380","--initial-cluster=instance=https://162.253.55.82:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.82:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.82: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:19:57.572513Z","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:19:57.572522Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.82:2380"]} {"level":"info","ts":"2026-09-18T02:19:57.572537Z","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:19:57.573197Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.82:2379"]} {"level":"info","ts":"2026-09-18T02:19:57.573269Z","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.82:2380"],"listen-peer-urls":["https://162.253.55.82:2380"],"advertise-client-urls":["https://162.253.55.82:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.82:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.82: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:19:57.57764Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.147976ms"} {"level":"info","ts":"2026-09-18T02:19:57.586085Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c5298098e2dc0f92","cluster-id":"e15b04acbd0c3f73"} {"level":"info","ts":"2026-09-18T02:19:57.586188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T02:19:57.586208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became follower at term 0"} {"level":"info","ts":"2026-09-18T02:19:57.586216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c5298098e2dc0f92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T02:19:57.586223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became follower at term 1"} {"level":"info","ts":"2026-09-18T02:19:57.586257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 switched to configuration voters=(14207027893646397330)"} {"level":"warn","ts":"2026-09-18T02:19:57.60069Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T02:19:57.604187Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T02:19:57.605521Z","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:19:57.609567Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c5298098e2dc0f92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T02:19:57.60978Z","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:19:57.609892Z","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:19:57.609905Z","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:19:57.610361Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c5298098e2dc0f92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T02:19:57.612332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 switched to configuration voters=(14207027893646397330)"} {"level":"info","ts":"2026-09-18T02:19:57.612417Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e15b04acbd0c3f73","local-member-id":"c5298098e2dc0f92","added-peer-id":"c5298098e2dc0f92","added-peer-peer-urls":["https://162.253.55.82:2380"]} {"level":"info","ts":"2026-09-18T02:19:57.613581Z","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:19:57.613852Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c5298098e2dc0f92","initial-advertise-peer-urls":["https://162.253.55.82:2380"],"listen-peer-urls":["https://162.253.55.82:2380"],"advertise-client-urls":["https://162.253.55.82:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.82:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T02:19:57.613922Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.82:2380"} {"level":"info","ts":"2026-09-18T02:19:57.613963Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.82:2380"} {"level":"info","ts":"2026-09-18T02:19:57.613926Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T02:19:58.487413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T02:19:58.487493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T02:19:58.487517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 received MsgPreVoteResp from c5298098e2dc0f92 at term 1"} {"level":"info","ts":"2026-09-18T02:19:58.487536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became candidate at term 2"} {"level":"info","ts":"2026-09-18T02:19:58.487546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 received MsgVoteResp from c5298098e2dc0f92 at term 2"} {"level":"info","ts":"2026-09-18T02:19:58.487561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c5298098e2dc0f92 became leader at term 2"} {"level":"info","ts":"2026-09-18T02:19:58.487573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c5298098e2dc0f92 elected leader c5298098e2dc0f92 at term 2"} {"level":"info","ts":"2026-09-18T02:19:58.489235Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:19:58.490154Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c5298098e2dc0f92","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.82:2379]}","request-path":"/0/members/c5298098e2dc0f92/attributes","cluster-id":"e15b04acbd0c3f73","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T02:19:58.490332Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T02:19:58.49039Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T02:19:58.490534Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T02:19:58.490586Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e15b04acbd0c3f73","local-member-id":"c5298098e2dc0f92","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:19:58.490604Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T02:19:58.490671Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:19:58.490695Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:19:58.493605Z","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:19:58.494044Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.82:2379"} {"level":"warn","ts":"2026-09-18T02:20:01.45967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.094836ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-09-18T02:20:01.459865Z","caller":"traceutil/trace.go:171","msg":"trace[1236530571] transaction","detail":"{read_only:false; response_revision:82; number_of_response:1; }","duration":"317.184554ms","start":"2026-09-18T02:20:01.142656Z","end":"2026-09-18T02:20:01.459841Z","steps":["trace[1236530571] 'process raft request' (duration: 181.295285ms)","trace[1236530571] 'compare' (duration: 134.913121ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:20:01.460087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:20:01.142611Z","time spent":"317.401599ms","remote":"127.0.0.1:56192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2012,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T02:20:01.940985Z","caller":"traceutil/trace.go:171","msg":"trace[242388191] transaction","detail":"{read_only:false; response_revision:84; number_of_response:1; }","duration":"403.147389ms","start":"2026-09-18T02:20:01.537664Z","end":"2026-09-18T02:20:01.940811Z","steps":["trace[242388191] 'process raft request' (duration: 327.74338ms)","trace[242388191] 'compare' (duration: 75.218584ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:20:01.941239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:20:01.537624Z","time spent":"403.52339ms","remote":"127.0.0.1:56192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-18T02:20:10.13146Z","caller":"traceutil/trace.go:171","msg":"trace[858217557] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"101.655236ms","start":"2026-09-18T02:20:10.029769Z","end":"2026-09-18T02:20:10.131424Z","steps":["trace[858217557] 'process raft request' (duration: 101.429068ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:20:52.779324Z","caller":"traceutil/trace.go:171","msg":"trace[305561425] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"219.353007ms","start":"2026-09-18T02:20:52.55994Z","end":"2026-09-18T02:20:52.779293Z","steps":["trace[305561425] 'process raft request' (duration: 218.145347ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:20:52.789723Z","caller":"traceutil/trace.go:171","msg":"trace[2017107673] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"169.339296ms","start":"2026-09-18T02:20:52.620332Z","end":"2026-09-18T02:20:52.789671Z","steps":["trace[2017107673] 'process raft request' (duration: 169.019371ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:20:59.339238Z","caller":"traceutil/trace.go:171","msg":"trace[1879008123] linearizableReadLoop","detail":"{readStateIndex:744; appliedIndex:742; }","duration":"169.172088ms","start":"2026-09-18T02:20:59.169977Z","end":"2026-09-18T02:20:59.339149Z","steps":["trace[1879008123] 'read index received' (duration: 33.239547ms)","trace[1879008123] 'applied index is now lower than readState.Index' (duration: 135.930201ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:20:59.339681Z","caller":"traceutil/trace.go:171","msg":"trace[992567404] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"194.62627ms","start":"2026-09-18T02:20:59.145015Z","end":"2026-09-18T02:20:59.339642Z","steps":["trace[992567404] 'process raft request' (duration: 192.887931ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:20:59.340046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.659272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-18T02:20:59.340141Z","caller":"traceutil/trace.go:171","msg":"trace[471240966] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:715; }","duration":"104.838072ms","start":"2026-09-18T02:20:59.23528Z","end":"2026-09-18T02:20:59.340118Z","steps":["trace[471240966] 'agreement among raft nodes before linearized reading' (duration: 104.505565ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:20:59.34004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.017091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-svmdm\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-18T02:20:59.340366Z","caller":"traceutil/trace.go:171","msg":"trace[1974808767] range","detail":"{range_begin:/registry/pods/kube-system/cilium-svmdm; range_end:; response_count:1; response_revision:715; }","duration":"170.380049ms","start":"2026-09-18T02:20:59.169897Z","end":"2026-09-18T02:20:59.340277Z","steps":["trace[1974808767] 'agreement among raft nodes before linearized reading' (duration: 169.878553ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:20:59.596325Z","caller":"traceutil/trace.go:171","msg":"trace[669661131] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"236.38602ms","start":"2026-09-18T02:20:59.359907Z","end":"2026-09-18T02:20:59.596293Z","steps":["trace[669661131] 'process raft request' (duration: 236.215981ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:20:59.625646Z","caller":"traceutil/trace.go:171","msg":"trace[1815197958] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"209.245801ms","start":"2026-09-18T02:20:59.416372Z","end":"2026-09-18T02:20:59.625618Z","steps":["trace[1815197958] 'process raft request' (duration: 209.113715ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:21:00.381123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.946088ms","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:21:00.381224Z","caller":"traceutil/trace.go:171","msg":"trace[1355803919] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:718; }","duration":"618.131207ms","start":"2026-09-18T02:20:59.763072Z","end":"2026-09-18T02:21:00.381204Z","steps":["trace[1355803919] 'range keys from in-memory index tree' (duration: 617.702826ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:21:00.38129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:20:59.763048Z","time spent":"618.210372ms","remote":"127.0.0.1:56108","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":"info","ts":"2026-09-18T02:21:00.448951Z","caller":"traceutil/trace.go:171","msg":"trace[1000604483] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"404.251726ms","start":"2026-09-18T02:21:00.044664Z","end":"2026-09-18T02:21:00.448916Z","steps":["trace[1000604483] 'process raft request' (duration: 403.428984ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:21:00.449396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:21:00.044625Z","time spent":"404.432085ms","remote":"127.0.0.1:55970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036229,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:21:18.203256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.516985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-18T02:21:18.203325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.637571ms","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:21:18.203379Z","caller":"traceutil/trace.go:171","msg":"trace[1860149324] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:852; }","duration":"353.696786ms","start":"2026-09-18T02:21:17.849658Z","end":"2026-09-18T02:21:18.203355Z","steps":["trace[1860149324] 'count revisions from in-memory index tree' (duration: 353.377978ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:21:18.203425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:21:17.84963Z","time spent":"353.78398ms","remote":"127.0.0.1:56086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":1,"response size":31,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"info","ts":"2026-09-18T02:21:18.203426Z","caller":"traceutil/trace.go:171","msg":"trace[2145316398] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:852; }","duration":"710.79994ms","start":"2026-09-18T02:21:17.4926Z","end":"2026-09-18T02:21:18.2034Z","steps":["trace[2145316398] 'range keys from in-memory index tree' (duration: 710.42525ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:21:18.203474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:21:17.49258Z","time spent":"710.885575ms","remote":"127.0.0.1:56108","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:21:18.203287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"698.282928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:21:18.203664Z","caller":"traceutil/trace.go:171","msg":"trace[809480580] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:852; }","duration":"698.672199ms","start":"2026-09-18T02:21:17.504969Z","end":"2026-09-18T02:21:18.203641Z","steps":["trace[809480580] 'range keys from in-memory index tree' (duration: 698.187983ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:21:18.203775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:21:17.504961Z","time spent":"698.796996ms","remote":"127.0.0.1:55872","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:21:18.305938Z","caller":"traceutil/trace.go:171","msg":"trace[1176017203] linearizableReadLoop","detail":"{readStateIndex:887; appliedIndex:886; }","duration":"100.847095ms","start":"2026-09-18T02:21:18.205063Z","end":"2026-09-18T02:21:18.30591Z","steps":["trace[1176017203] 'read index received' (duration: 73.33081ms)","trace[1176017203] 'applied index is now lower than readState.Index' (duration: 27.513405ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:21:18.320182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.057412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:21:18.320346Z","caller":"traceutil/trace.go:171","msg":"trace[119789981] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:853; }","duration":"115.292815ms","start":"2026-09-18T02:21:18.205023Z","end":"2026-09-18T02:21:18.320316Z","steps":["trace[119789981] 'agreement among raft nodes before linearized reading' (duration: 100.989813ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:21:49.825199Z","caller":"traceutil/trace.go:171","msg":"trace[2079712697] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"131.548336ms","start":"2026-09-18T02:21:49.693602Z","end":"2026-09-18T02:21:49.82515Z","steps":["trace[2079712697] 'process raft request' (duration: 129.635223ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:06.687781Z","caller":"traceutil/trace.go:171","msg":"trace[608346647] transaction","detail":"{read_only:false; response_revision:1399; number_of_response:1; }","duration":"126.831784ms","start":"2026-09-18T02:22:06.560918Z","end":"2026-09-18T02:22:06.68775Z","steps":["trace[608346647] 'process raft request' (duration: 126.562197ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:42.033164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.293386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:22:42.03331Z","caller":"traceutil/trace.go:171","msg":"trace[528061166] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1940; }","duration":"123.901635ms","start":"2026-09-18T02:22:41.909378Z","end":"2026-09-18T02:22:42.03328Z","steps":["trace[528061166] 'count revisions from in-memory index tree' (duration: 123.04405ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:42.428095Z","caller":"traceutil/trace.go:171","msg":"trace[1433287848] linearizableReadLoop","detail":"{readStateIndex:2021; appliedIndex:2020; }","duration":"267.137355ms","start":"2026-09-18T02:22:42.160928Z","end":"2026-09-18T02:22:42.428066Z","steps":["trace[1433287848] 'read index received' (duration: 267.005346ms)","trace[1433287848] 'applied index is now lower than readState.Index' (duration: 130.729µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:22:42.428227Z","caller":"traceutil/trace.go:171","msg":"trace[724166729] transaction","detail":"{read_only:false; response_revision:1941; number_of_response:1; }","duration":"365.172296ms","start":"2026-09-18T02:22:42.063017Z","end":"2026-09-18T02:22:42.428189Z","steps":["trace[724166729] 'process raft request' (duration: 364.863816ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:42.428455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:22:42.062988Z","time spent":"365.341776ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:22:42.42854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.566482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"} {"level":"info","ts":"2026-09-18T02:22:42.428656Z","caller":"traceutil/trace.go:171","msg":"trace[1834854864] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1941; }","duration":"267.770244ms","start":"2026-09-18T02:22:42.160862Z","end":"2026-09-18T02:22:42.428632Z","steps":["trace[1834854864] 'agreement among raft nodes before linearized reading' (duration: 267.407882ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:42.428779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.690152ms","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:22:42.428879Z","caller":"traceutil/trace.go:171","msg":"trace[451792947] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1941; }","duration":"227.886034ms","start":"2026-09-18T02:22:42.200976Z","end":"2026-09-18T02:22:42.428862Z","steps":["trace[451792947] 'agreement among raft nodes before linearized reading' (duration: 227.481598ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:42.429387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.745409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f87ad0d4-7fcb-431a-98b0-f5eca6bf4ae6\" ","response":"range_response_count:1 size:3746"} {"level":"info","ts":"2026-09-18T02:22:42.429466Z","caller":"traceutil/trace.go:171","msg":"trace[1691171716] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f87ad0d4-7fcb-431a-98b0-f5eca6bf4ae6; range_end:; response_count:1; response_revision:1941; }","duration":"252.860376ms","start":"2026-09-18T02:22:42.176592Z","end":"2026-09-18T02:22:42.429453Z","steps":["trace[1691171716] 'agreement among raft nodes before linearized reading' (duration: 251.786858ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:42.553293Z","caller":"traceutil/trace.go:171","msg":"trace[1815371993] transaction","detail":"{read_only:false; response_revision:1943; number_of_response:1; }","duration":"118.272314ms","start":"2026-09-18T02:22:42.434991Z","end":"2026-09-18T02:22:42.553263Z","steps":["trace[1815371993] 'process raft request' (duration: 118.218301ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:42.553811Z","caller":"traceutil/trace.go:171","msg":"trace[1426659481] transaction","detail":"{read_only:false; response_revision:1942; number_of_response:1; }","duration":"119.490571ms","start":"2026-09-18T02:22:42.434241Z","end":"2026-09-18T02:22:42.553732Z","steps":["trace[1426659481] 'process raft request' (duration: 66.626334ms)","trace[1426659481] 'compare' (duration: 52.177354ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:22:55.751837Z","caller":"traceutil/trace.go:171","msg":"trace[1425481632] transaction","detail":"{read_only:false; response_revision:2057; number_of_response:1; }","duration":"102.115915ms","start":"2026-09-18T02:22:55.649661Z","end":"2026-09-18T02:22:55.751777Z","steps":["trace[1425481632] 'process raft request' (duration: 74.402695ms)","trace[1425481632] 'compare' (duration: 27.077369ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:22:57.436364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.643053ms","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:22:57.436479Z","caller":"traceutil/trace.go:171","msg":"trace[168293988] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2069; }","duration":"107.793142ms","start":"2026-09-18T02:22:57.32865Z","end":"2026-09-18T02:22:57.436443Z","steps":["trace[168293988] 'range keys from in-memory index tree' (duration: 107.452091ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:23:16.868726Z","caller":"traceutil/trace.go:171","msg":"trace[1880820526] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"108.89884ms","start":"2026-09-18T02:23:16.7598Z","end":"2026-09-18T02:23:16.868698Z","steps":["trace[1880820526] 'process raft request' (duration: 108.26699ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:17.080642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.381402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-18T02:23:17.080762Z","caller":"traceutil/trace.go:171","msg":"trace[1573352679] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2187; }","duration":"159.555923ms","start":"2026-09-18T02:23:16.921181Z","end":"2026-09-18T02:23:17.080737Z","steps":["trace[1573352679] 'range keys from in-memory index tree' (duration: 159.169628ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:23:17.345127Z","caller":"traceutil/trace.go:171","msg":"trace[1017170999] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"147.083245ms","start":"2026-09-18T02:23:17.198019Z","end":"2026-09-18T02:23:17.345102Z","steps":["trace[1017170999] 'process raft request' (duration: 146.898883ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:23:17.789711Z","caller":"traceutil/trace.go:171","msg":"trace[120881363] linearizableReadLoop","detail":"{readStateIndex:2277; appliedIndex:2276; }","duration":"269.358246ms","start":"2026-09-18T02:23:17.520319Z","end":"2026-09-18T02:23:17.789677Z","steps":["trace[120881363] 'read index received' (duration: 269.134282ms)","trace[120881363] 'applied index is now lower than readState.Index' (duration: 222.644µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:23:17.78979Z","caller":"traceutil/trace.go:171","msg":"trace[1508669620] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"276.10948ms","start":"2026-09-18T02:23:17.513637Z","end":"2026-09-18T02:23:17.789747Z","steps":["trace[1508669620] 'process raft request' (duration: 275.821611ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:17.789963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.547278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T02:23:17.790097Z","caller":"traceutil/trace.go:171","msg":"trace[1561651936] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2189; }","duration":"269.786134ms","start":"2026-09-18T02:23:17.520293Z","end":"2026-09-18T02:23:17.790079Z","steps":["trace[1561651936] 'agreement among raft nodes before linearized reading' (duration: 269.505416ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:23:18.204836Z","caller":"traceutil/trace.go:171","msg":"trace[1659951055] linearizableReadLoop","detail":"{readStateIndex:2278; appliedIndex:2277; }","duration":"415.008404ms","start":"2026-09-18T02:23:17.789795Z","end":"2026-09-18T02:23:18.204803Z","steps":["trace[1659951055] 'read index received' (duration: 339.879098ms)","trace[1659951055] 'applied index is now lower than readState.Index' (duration: 75.127316ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:23:18.204879Z","caller":"traceutil/trace.go:171","msg":"trace[2000804441] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"520.947587ms","start":"2026-09-18T02:23:17.68389Z","end":"2026-09-18T02:23:18.204838Z","steps":["trace[2000804441] 'process raft request' (duration: 445.807339ms)","trace[2000804441] 'compare' (duration: 74.849439ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:23:18.204908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.014288ms","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:18.204981Z","caller":"traceutil/trace.go:171","msg":"trace[1523879248] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:2190; }","duration":"563.135266ms","start":"2026-09-18T02:23:17.641827Z","end":"2026-09-18T02:23:18.204962Z","steps":["trace[1523879248] 'agreement among raft nodes before linearized reading' (duration: 562.992817ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:18.205072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:17.641812Z","time spent":"563.20178ms","remote":"127.0.0.1:56662","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/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-09-18T02:23:18.205094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:17.683875Z","time spent":"521.084936ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:23:18.205122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.161172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-09-18T02:23:18.205172Z","caller":"traceutil/trace.go:171","msg":"trace[960001976] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2190; }","duration":"583.234597ms","start":"2026-09-18T02:23:17.621921Z","end":"2026-09-18T02:23:18.205156Z","steps":["trace[960001976] 'agreement among raft nodes before linearized reading' (duration: 583.036614ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:18.205217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:17.62191Z","time spent":"583.296311ms","remote":"127.0.0.1:56044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2012,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-09-18T02:23:18.20531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.477178ms","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:23:18.205421Z","caller":"traceutil/trace.go:171","msg":"trace[208006585] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2190; }","duration":"665.618907ms","start":"2026-09-18T02:23:17.539788Z","end":"2026-09-18T02:23:18.205407Z","steps":["trace[208006585] 'agreement among raft nodes before linearized reading' (duration: 665.266085ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:18.205504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:17.539775Z","time spent":"665.716474ms","remote":"127.0.0.1:56108","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:23:18.205706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"673.025002ms","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:23:18.205875Z","caller":"traceutil/trace.go:171","msg":"trace[1240245708] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2190; }","duration":"673.243706ms","start":"2026-09-18T02:23:17.532566Z","end":"2026-09-18T02:23:18.20581Z","steps":["trace[1240245708] 'agreement among raft nodes before linearized reading' (duration: 672.703271ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:18.205985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:17.532539Z","time spent":"673.429158ms","remote":"127.0.0.1:56108","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:23:18.209171Z","caller":"traceutil/trace.go:171","msg":"trace[258069758] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"357.614279ms","start":"2026-09-18T02:23:17.85153Z","end":"2026-09-18T02:23:18.209144Z","steps":["trace[258069758] 'process raft request' (duration: 357.145919ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:18.209213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.186936ms","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:23:18.209288Z","caller":"traceutil/trace.go:171","msg":"trace[1892356272] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2191; }","duration":"332.307964ms","start":"2026-09-18T02:23:17.876959Z","end":"2026-09-18T02:23:18.209267Z","steps":["trace[1892356272] 'agreement among raft nodes before linearized reading' (duration: 331.825203ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:18.209316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:17.851506Z","time spent":"357.729086ms","remote":"127.0.0.1:56108","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:23:18.209344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:17.876923Z","time spent":"332.411311ms","remote":"127.0.0.1:56108","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":"warn","ts":"2026-09-18T02:23:18.209547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.822572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-18T02:23:18.209588Z","caller":"traceutil/trace.go:171","msg":"trace[54424155] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2191; }","duration":"120.906307ms","start":"2026-09-18T02:23:18.088669Z","end":"2026-09-18T02:23:18.209576Z","steps":["trace[54424155] 'agreement among raft nodes before linearized reading' (duration: 120.773579ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:18.209776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.184432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-18T02:23:18.209854Z","caller":"traceutil/trace.go:171","msg":"trace[1301350667] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2191; }","duration":"319.283848ms","start":"2026-09-18T02:23:17.89055Z","end":"2026-09-18T02:23:18.209834Z","steps":["trace[1301350667] 'agreement among raft nodes before linearized reading' (duration: 319.019311ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:23:18.20991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:23:17.890539Z","time spent":"319.356703ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-18T02:23:18.657114Z","caller":"traceutil/trace.go:171","msg":"trace[2030418658] linearizableReadLoop","detail":"{readStateIndex:2284; appliedIndex:2283; }","duration":"151.366463ms","start":"2026-09-18T02:23:18.505723Z","end":"2026-09-18T02:23:18.657089Z","steps":["trace[2030418658] 'read index received' (duration: 141.553713ms)","trace[2030418658] 'applied index is now lower than readState.Index' (duration: 9.81053ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:23:18.65726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.516874ms","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:18.657299Z","caller":"traceutil/trace.go:171","msg":"trace[634021815] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2196; }","duration":"151.609149ms","start":"2026-09-18T02:23:18.505677Z","end":"2026-09-18T02:23:18.657287Z","steps":["trace[634021815] 'agreement among raft nodes before linearized reading' (duration: 151.504412ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:26.746658Z","caller":"traceutil/trace.go:171","msg":"trace[562127368] linearizableReadLoop","detail":"{readStateIndex:2763; appliedIndex:2762; }","duration":"253.502542ms","start":"2026-09-18T02:24:26.493109Z","end":"2026-09-18T02:24:26.746612Z","steps":["trace[562127368] 'read index received' (duration: 253.401873ms)","trace[562127368] 'applied index is now lower than readState.Index' (duration: 99.879µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:24:26.746938Z","caller":"traceutil/trace.go:171","msg":"trace[1409404059] transaction","detail":"{read_only:false; response_revision:2659; number_of_response:1; }","duration":"268.370477ms","start":"2026-09-18T02:24:26.478553Z","end":"2026-09-18T02:24:26.746924Z","steps":["trace[1409404059] 'process raft request' (duration: 267.94233ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:24:26.747044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.351819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T02:24:26.747157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.669339ms","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:24:26.747162Z","caller":"traceutil/trace.go:171","msg":"trace[1501332355] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2659; }","duration":"238.553698ms","start":"2026-09-18T02:24:26.508585Z","end":"2026-09-18T02:24:26.747139Z","steps":["trace[1501332355] 'agreement among raft nodes before linearized reading' (duration: 238.311989ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:26.747198Z","caller":"traceutil/trace.go:171","msg":"trace[1202929205] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2659; }","duration":"150.735239ms","start":"2026-09-18T02:24:26.596453Z","end":"2026-09-18T02:24:26.747188Z","steps":["trace[1202929205] 'agreement among raft nodes before linearized reading' (duration: 150.56552ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:24:26.747367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.750931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-18T02:24:26.747191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.727711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-18T02:24:26.747472Z","caller":"traceutil/trace.go:171","msg":"trace[2060060311] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2659; }","duration":"138.054599ms","start":"2026-09-18T02:24:26.609411Z","end":"2026-09-18T02:24:26.747466Z","steps":["trace[2060060311] 'agreement among raft nodes before linearized reading' (duration: 137.582812ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:24:26.747523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.373675ms","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:24:26.747585Z","caller":"traceutil/trace.go:171","msg":"trace[869403021] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2659; }","duration":"118.455754ms","start":"2026-09-18T02:24:26.629113Z","end":"2026-09-18T02:24:26.747569Z","steps":["trace[869403021] 'agreement among raft nodes before linearized reading' (duration: 117.827198ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:26.747431Z","caller":"traceutil/trace.go:171","msg":"trace[1796191730] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2659; }","duration":"254.358987ms","start":"2026-09-18T02:24:26.493064Z","end":"2026-09-18T02:24:26.747423Z","steps":["trace[1796191730] 'agreement among raft nodes before linearized reading' (duration: 253.764621ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:36.100631Z","caller":"traceutil/trace.go:171","msg":"trace[577623876] transaction","detail":"{read_only:false; response_revision:4803; number_of_response:1; }","duration":"140.22033ms","start":"2026-09-18T02:29:35.96038Z","end":"2026-09-18T02:29:36.1006Z","steps":["trace[577623876] 'process raft request' (duration: 139.82902ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:36.108044Z","caller":"traceutil/trace.go:171","msg":"trace[1607819643] transaction","detail":"{read_only:false; response_revision:4804; number_of_response:1; }","duration":"145.497284ms","start":"2026-09-18T02:29:35.96252Z","end":"2026-09-18T02:29:36.108017Z","steps":["trace[1607819643] 'process raft request' (duration: 144.944666ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:38.061209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.493118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-09-18T02:29:38.061296Z","caller":"traceutil/trace.go:171","msg":"trace[866379857] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4881; }","duration":"178.632205ms","start":"2026-09-18T02:29:37.882645Z","end":"2026-09-18T02:29:38.061277Z","steps":["trace[866379857] 'range keys from in-memory index tree' (duration: 178.297789ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:38.062103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.764966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:46 size:1954231"} {"level":"info","ts":"2026-09-18T02:29:38.062162Z","caller":"traceutil/trace.go:171","msg":"trace[1536909342] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:46; response_revision:4881; }","duration":"126.871561ms","start":"2026-09-18T02:29:37.935279Z","end":"2026-09-18T02:29:38.06215Z","steps":["trace[1536909342] 'range keys from in-memory index tree' (duration: 125.883112ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:45.433886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.822444ms","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:45.434276Z","caller":"traceutil/trace.go:171","msg":"trace[386744337] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5054; }","duration":"298.283528ms","start":"2026-09-18T02:29:45.135966Z","end":"2026-09-18T02:29:45.434249Z","steps":["trace[386744337] 'range keys from in-memory index tree' (duration: 297.609323ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:45.434506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.204578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-09-18T02:29:45.434618Z","caller":"traceutil/trace.go:171","msg":"trace[1964221782] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5054; }","duration":"196.344655ms","start":"2026-09-18T02:29:45.238246Z","end":"2026-09-18T02:29:45.434591Z","steps":["trace[1964221782] 'range keys from in-memory index tree' (duration: 195.419289ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:45.687552Z","caller":"traceutil/trace.go:171","msg":"trace[1176213012] transaction","detail":"{read_only:false; response_revision:5056; number_of_response:1; }","duration":"171.767495ms","start":"2026-09-18T02:29:45.515754Z","end":"2026-09-18T02:29:45.687521Z","steps":["trace[1176213012] 'process raft request' (duration: 72.357261ms)","trace[1176213012] 'compare' (duration: 99.106969ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:45.687573Z","caller":"traceutil/trace.go:171","msg":"trace[1262510850] transaction","detail":"{read_only:false; response_revision:5057; number_of_response:1; }","duration":"141.73484ms","start":"2026-09-18T02:29:45.545812Z","end":"2026-09-18T02:29:45.687546Z","steps":["trace[1262510850] 'process raft request' (duration: 141.651466ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:45.687744Z","caller":"traceutil/trace.go:171","msg":"trace[559365051] linearizableReadLoop","detail":"{readStateIndex:5252; appliedIndex:5251; }","duration":"149.514873ms","start":"2026-09-18T02:29:45.538191Z","end":"2026-09-18T02:29:45.687706Z","steps":["trace[559365051] 'read index received' (duration: 49.930049ms)","trace[559365051] 'applied index is now lower than readState.Index' (duration: 99.583704ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:29:45.68791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.701372ms","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:29:45.687952Z","caller":"traceutil/trace.go:171","msg":"trace[1158598880] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5057; }","duration":"149.788007ms","start":"2026-09-18T02:29:45.538151Z","end":"2026-09-18T02:29:45.687939Z","steps":["trace[1158598880] 'agreement among raft nodes before linearized reading' (duration: 149.629019ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:46.052148Z","caller":"traceutil/trace.go:171","msg":"trace[905014349] linearizableReadLoop","detail":"{readStateIndex:5254; appliedIndex:5253; }","duration":"139.11353ms","start":"2026-09-18T02:29:45.912992Z","end":"2026-09-18T02:29:46.052105Z","steps":["trace[905014349] 'read index received' (duration: 113.558229ms)","trace[905014349] 'applied index is now lower than readState.Index' (duration: 25.55399ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:46.052264Z","caller":"traceutil/trace.go:171","msg":"trace[799862608] transaction","detail":"{read_only:false; response_revision:5058; number_of_response:1; }","duration":"303.204228ms","start":"2026-09-18T02:29:45.749048Z","end":"2026-09-18T02:29:46.052252Z","steps":["trace[799862608] 'process raft request' (duration: 277.527852ms)","trace[799862608] 'compare' (duration: 25.116138ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:29:46.052387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:45.749018Z","time spent":"303.272031ms","remote":"127.0.0.1:48154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7566,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:29:46.052832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.864792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-cgrdq\" ","response":"range_response_count:1 size:9753"} {"level":"info","ts":"2026-09-18T02:29:46.052931Z","caller":"traceutil/trace.go:171","msg":"trace[742016869] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-cgrdq; range_end:; response_count:1; response_revision:5058; }","duration":"126.006618ms","start":"2026-09-18T02:29:45.926905Z","end":"2026-09-18T02:29:46.052912Z","steps":["trace[742016869] 'agreement among raft nodes before linearized reading' (duration: 125.617969ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:46.052928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.9159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-09-18T02:29:46.053005Z","caller":"traceutil/trace.go:171","msg":"trace[1520672261] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5058; }","duration":"140.054717ms","start":"2026-09-18T02:29:45.912932Z","end":"2026-09-18T02:29:46.052987Z","steps":["trace[1520672261] 'agreement among raft nodes before linearized reading' (duration: 139.787604ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:46.218557Z","caller":"traceutil/trace.go:171","msg":"trace[639357911] transaction","detail":"{read_only:false; response_revision:5059; number_of_response:1; }","duration":"152.745401ms","start":"2026-09-18T02:29:46.065782Z","end":"2026-09-18T02:29:46.218527Z","steps":["trace[639357911] 'process raft request' (duration: 152.534581ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:46.95112Z","caller":"traceutil/trace.go:171","msg":"trace[1094140478] transaction","detail":"{read_only:false; response_revision:5064; number_of_response:1; }","duration":"119.112044ms","start":"2026-09-18T02:29:46.831992Z","end":"2026-09-18T02:29:46.951105Z","steps":["trace[1094140478] 'process raft request' (duration: 91.454618ms)","trace[1094140478] 'compare' (duration: 27.317769ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:47.508714Z","caller":"traceutil/trace.go:171","msg":"trace[479258926] transaction","detail":"{read_only:false; response_revision:5067; number_of_response:1; }","duration":"521.238455ms","start":"2026-09-18T02:29:46.987451Z","end":"2026-09-18T02:29:47.50869Z","steps":["trace[479258926] 'process raft request' (duration: 429.915451ms)","trace[479258926] 'compare' (duration: 91.110063ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:29:47.508869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:46.98741Z","time spent":"521.392232ms","remote":"127.0.0.1:56030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9852,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:29:47.622059Z","caller":"traceutil/trace.go:171","msg":"trace[1259122456] linearizableReadLoop","detail":"{readStateIndex:5264; appliedIndex:5263; }","duration":"116.654784ms","start":"2026-09-18T02:29:47.505383Z","end":"2026-09-18T02:29:47.622038Z","steps":["trace[1259122456] 'read index received' (duration: 116.472185ms)","trace[1259122456] 'applied index is now lower than readState.Index' (duration: 179.479µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:47.622298Z","caller":"traceutil/trace.go:171","msg":"trace[764710806] transaction","detail":"{read_only:false; response_revision:5068; number_of_response:1; }","duration":"291.845005ms","start":"2026-09-18T02:29:47.330442Z","end":"2026-09-18T02:29:47.622287Z","steps":["trace[764710806] 'process raft request' (duration: 291.468256ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:47.622464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.822007ms","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:47.622509Z","caller":"traceutil/trace.go:171","msg":"trace[682683999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5068; }","duration":"106.910242ms","start":"2026-09-18T02:29:47.515587Z","end":"2026-09-18T02:29:47.622497Z","steps":["trace[682683999] 'agreement among raft nodes before linearized reading' (duration: 106.762864ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:47.622696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.303397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:29:47.622749Z","caller":"traceutil/trace.go:171","msg":"trace[1981474833] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5068; }","duration":"117.3573ms","start":"2026-09-18T02:29:47.505378Z","end":"2026-09-18T02:29:47.622735Z","steps":["trace[1981474833] 'agreement among raft nodes before linearized reading' (duration: 117.238234ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:48.755136Z","caller":"traceutil/trace.go:171","msg":"trace[468534741] transaction","detail":"{read_only:false; response_revision:5076; number_of_response:1; }","duration":"113.567053ms","start":"2026-09-18T02:29:48.64154Z","end":"2026-09-18T02:29:48.755107Z","steps":["trace[468534741] 'process raft request' (duration: 113.274028ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:50.935873Z","caller":"traceutil/trace.go:171","msg":"trace[1608163846] transaction","detail":"{read_only:false; response_revision:5087; number_of_response:1; }","duration":"122.850142ms","start":"2026-09-18T02:29:50.812973Z","end":"2026-09-18T02:29:50.935823Z","steps":["trace[1608163846] 'process raft request' (duration: 87.514532ms)","trace[1608163846] 'compare' (duration: 35.227254ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:55.075854Z","caller":"traceutil/trace.go:171","msg":"trace[1098714865] linearizableReadLoop","detail":"{readStateIndex:5368; appliedIndex:5367; }","duration":"238.911868ms","start":"2026-09-18T02:29:54.836892Z","end":"2026-09-18T02:29:55.075804Z","steps":["trace[1098714865] 'read index received' (duration: 224.760719ms)","trace[1098714865] 'applied index is now lower than readState.Index' (duration: 14.149559ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:55.076002Z","caller":"traceutil/trace.go:171","msg":"trace[1785766680] transaction","detail":"{read_only:false; response_revision:5169; number_of_response:1; }","duration":"239.173631ms","start":"2026-09-18T02:29:54.836803Z","end":"2026-09-18T02:29:55.075977Z","steps":["trace[1785766680] 'process raft request' (duration: 224.839172ms)","trace[1785766680] 'compare' (duration: 13.845874ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:29:55.076246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.301148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18d64963bf018ab8\" ","response":"range_response_count:1 size:751"} {"level":"info","ts":"2026-09-18T02:29:55.076305Z","caller":"traceutil/trace.go:171","msg":"trace[1614440455] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18d64963bf018ab8; range_end:; response_count:1; response_revision:5169; }","duration":"239.465536ms","start":"2026-09-18T02:29:54.836827Z","end":"2026-09-18T02:29:55.076293Z","steps":["trace[1614440455] 'agreement among raft nodes before linearized reading' (duration: 239.173021ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:55.076654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.066692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-09-18T02:29:55.076696Z","caller":"traceutil/trace.go:171","msg":"trace[986895527] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5169; }","duration":"222.141696ms","start":"2026-09-18T02:29:54.854542Z","end":"2026-09-18T02:29:55.076684Z","steps":["trace[986895527] 'agreement among raft nodes before linearized reading' (duration: 222.014369ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:55.077543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.026358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-09-18T02:29:55.077587Z","caller":"traceutil/trace.go:171","msg":"trace[1822450842] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:5169; }","duration":"219.111252ms","start":"2026-09-18T02:29:54.858464Z","end":"2026-09-18T02:29:55.077575Z","steps":["trace[1822450842] 'agreement among raft nodes before linearized reading' (duration: 219.003777ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:55.077643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.856256ms","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:29:55.077696Z","caller":"traceutil/trace.go:171","msg":"trace[249557125] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5169; }","duration":"127.942252ms","start":"2026-09-18T02:29:54.949742Z","end":"2026-09-18T02:29:55.077685Z","steps":["trace[249557125] 'agreement among raft nodes before linearized reading' (duration: 127.824016ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:55.353848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.603541ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T02:29:55.354288Z","caller":"traceutil/trace.go:171","msg":"trace[34413158] transaction","detail":"{read_only:false; response_revision:5170; number_of_response:1; }","duration":"272.439338ms","start":"2026-09-18T02:29:55.081803Z","end":"2026-09-18T02:29:55.354242Z","steps":["trace[34413158] 'process raft request' (duration: 162.30583ms)","trace[34413158] 'compare' (duration: 109.406521ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:55.354366Z","caller":"traceutil/trace.go:171","msg":"trace[1277397977] linearizableReadLoop","detail":"{readStateIndex:5373; appliedIndex:5368; }","duration":"267.656704ms","start":"2026-09-18T02:29:55.086692Z","end":"2026-09-18T02:29:55.354348Z","steps":["trace[1277397977] 'read index received' (duration: 157.438802ms)","trace[1277397977] 'applied index is now lower than readState.Index' (duration: 110.216472ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:55.354368Z","caller":"traceutil/trace.go:171","msg":"trace[2045622747] transaction","detail":"{read_only:false; response_revision:5172; number_of_response:1; }","duration":"270.967803ms","start":"2026-09-18T02:29:55.083367Z","end":"2026-09-18T02:29:55.354335Z","steps":["trace[2045622747] 'process raft request' (duration: 270.742532ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:55.354438Z","caller":"traceutil/trace.go:171","msg":"trace[1084763375] transaction","detail":"{read_only:false; response_revision:5174; number_of_response:1; }","duration":"268.671627ms","start":"2026-09-18T02:29:55.085745Z","end":"2026-09-18T02:29:55.354416Z","steps":["trace[1084763375] 'process raft request' (duration: 268.462456ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:55.35455Z","caller":"traceutil/trace.go:171","msg":"trace[2000950620] transaction","detail":"{read_only:false; response_revision:5175; number_of_response:1; }","duration":"246.042747ms","start":"2026-09-18T02:29:55.10849Z","end":"2026-09-18T02:29:55.354533Z","steps":["trace[2000950620] 'process raft request' (duration: 245.764822ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:55.354532Z","caller":"traceutil/trace.go:171","msg":"trace[1639474247] transaction","detail":"{read_only:false; response_revision:5173; number_of_response:1; }","duration":"268.921819ms","start":"2026-09-18T02:29:55.085573Z","end":"2026-09-18T02:29:55.354495Z","steps":["trace[1639474247] 'process raft request' (duration: 268.590182ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:55.354713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.702637ms","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":"warn","ts":"2026-09-18T02:29:55.354703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.987752ms","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:29:55.354751Z","caller":"traceutil/trace.go:171","msg":"trace[127246083] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5175; }","duration":"219.818133ms","start":"2026-09-18T02:29:55.134919Z","end":"2026-09-18T02:29:55.354737Z","steps":["trace[127246083] 'agreement among raft nodes before linearized reading' (duration: 219.659925ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:55.354781Z","caller":"traceutil/trace.go:171","msg":"trace[1179258082] 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:5175; }","duration":"268.090107ms","start":"2026-09-18T02:29:55.086664Z","end":"2026-09-18T02:29:55.354754Z","steps":["trace[1179258082] 'agreement among raft nodes before linearized reading' (duration: 267.825363ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:55.354816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.771268ms","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":"info","ts":"2026-09-18T02:29:55.354849Z","caller":"traceutil/trace.go:171","msg":"trace[867903429] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:5175; }","duration":"155.863682ms","start":"2026-09-18T02:29:55.198974Z","end":"2026-09-18T02:29:55.354838Z","steps":["trace[867903429] 'agreement among raft nodes before linearized reading' (duration: 155.799239ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:55.354852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.961267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:29:55.354907Z","caller":"traceutil/trace.go:171","msg":"trace[1337349883] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:5175; }","duration":"180.055762ms","start":"2026-09-18T02:29:55.174835Z","end":"2026-09-18T02:29:55.35489Z","steps":["trace[1337349883] 'agreement among raft nodes before linearized reading' (duration: 179.961897ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:55.354257Z","caller":"traceutil/trace.go:171","msg":"trace[2135733776] transaction","detail":"{read_only:false; response_revision:5171; number_of_response:1; }","duration":"271.479469ms","start":"2026-09-18T02:29:55.082737Z","end":"2026-09-18T02:29:55.354216Z","steps":["trace[2135733776] 'process raft request' (duration: 271.29094ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:55.866934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.747219ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T02:29:55.867894Z","caller":"traceutil/trace.go:171","msg":"trace[2054725394] linearizableReadLoop","detail":"{readStateIndex:5381; appliedIndex:5380; }","duration":"244.74595ms","start":"2026-09-18T02:29:55.623118Z","end":"2026-09-18T02:29:55.867864Z","steps":["trace[2054725394] 'read index received' (duration: 86.079265ms)","trace[2054725394] 'applied index is now lower than readState.Index' (duration: 158.658605ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:55.867995Z","caller":"traceutil/trace.go:171","msg":"trace[402098404] transaction","detail":"{read_only:false; response_revision:5182; number_of_response:1; }","duration":"311.850041ms","start":"2026-09-18T02:29:55.556077Z","end":"2026-09-18T02:29:55.867927Z","steps":["trace[402098404] 'process raft request' (duration: 152.972595ms)","trace[402098404] 'compare' (duration: 157.534408ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:29:55.868176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:55.556048Z","time spent":"312.02544ms","remote":"127.0.0.1:48154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7566,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:29:55.868192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.066616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-19ff65ad-8aa7-4126-8a57-6fd148edb2be\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-09-18T02:29:55.868246Z","caller":"traceutil/trace.go:171","msg":"trace[1527123156] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-19ff65ad-8aa7-4126-8a57-6fd148edb2be; range_end:; response_count:1; response_revision:5182; }","duration":"245.174372ms","start":"2026-09-18T02:29:55.623054Z","end":"2026-09-18T02:29:55.868229Z","steps":["trace[1527123156] 'agreement among raft nodes before linearized reading' (duration: 244.95646ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:55.885238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.425464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-09-18T02:29:55.885344Z","caller":"traceutil/trace.go:171","msg":"trace[1254211775] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5183; }","duration":"183.588182ms","start":"2026-09-18T02:29:55.701735Z","end":"2026-09-18T02:29:55.885323Z","steps":["trace[1254211775] 'agreement among raft nodes before linearized reading' (duration: 183.288586ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:56.066783Z","caller":"traceutil/trace.go:171","msg":"trace[1804672828] linearizableReadLoop","detail":"{readStateIndex:5384; appliedIndex:5382; }","duration":"139.802338ms","start":"2026-09-18T02:29:55.92694Z","end":"2026-09-18T02:29:56.066742Z","steps":["trace[1804672828] 'read index received' (duration: 12.855993ms)","trace[1804672828] 'applied index is now lower than readState.Index' (duration: 126.945275ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:29:56.067014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.049301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-09-18T02:29:56.067052Z","caller":"traceutil/trace.go:171","msg":"trace[632640679] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5185; }","duration":"140.162776ms","start":"2026-09-18T02:29:55.926878Z","end":"2026-09-18T02:29:56.067041Z","steps":["trace[632640679] 'agreement among raft nodes before linearized reading' (duration: 139.975137ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:56.06732Z","caller":"traceutil/trace.go:171","msg":"trace[927976845] transaction","detail":"{read_only:false; response_revision:5185; number_of_response:1; }","duration":"172.151682ms","start":"2026-09-18T02:29:55.895143Z","end":"2026-09-18T02:29:56.067295Z","steps":["trace[927976845] 'process raft request' (duration: 130.82463ms)","trace[927976845] 'compare' (duration: 40.608016ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:56.199763Z","caller":"traceutil/trace.go:171","msg":"trace[1532163349] transaction","detail":"{read_only:false; response_revision:5186; number_of_response:1; }","duration":"113.929135ms","start":"2026-09-18T02:29:56.085802Z","end":"2026-09-18T02:29:56.199731Z","steps":["trace[1532163349] 'process raft request' (duration: 108.33263ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:56.201912Z","caller":"traceutil/trace.go:171","msg":"trace[1448979146] transaction","detail":"{read_only:false; response_revision:5187; number_of_response:1; }","duration":"100.991037ms","start":"2026-09-18T02:29:56.10088Z","end":"2026-09-18T02:29:56.20187Z","steps":["trace[1448979146] 'process raft request' (duration: 100.712663ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:58.533568Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2836} {"level":"info","ts":"2026-09-18T02:29:58.622272Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2836,"took":"87.810403ms","hash":2898301621,"current-db-size-bytes":50302976,"current-db-size":"50 MB","current-db-size-in-use-bytes":26882048,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-18T02:29:58.622327Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2898301621,"revision":2836,"compact-revision":-1} {"level":"info","ts":"2026-09-18T02:30:05.483002Z","caller":"traceutil/trace.go:171","msg":"trace[1256701605] transaction","detail":"{read_only:false; response_revision:5318; number_of_response:1; }","duration":"145.978931ms","start":"2026-09-18T02:30:05.336985Z","end":"2026-09-18T02:30:05.482963Z","steps":["trace[1256701605] 'process raft request' (duration: 145.042763ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:05.615022Z","caller":"traceutil/trace.go:171","msg":"trace[438417797] transaction","detail":"{read_only:false; response_revision:5319; number_of_response:1; }","duration":"125.440981ms","start":"2026-09-18T02:30:05.489559Z","end":"2026-09-18T02:30:05.615Z","steps":["trace[438417797] 'process raft request' (duration: 83.777078ms)","trace[438417797] 'compare' (duration: 41.491214ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:30:05.615339Z","caller":"traceutil/trace.go:171","msg":"trace[206057411] transaction","detail":"{read_only:false; response_revision:5320; number_of_response:1; }","duration":"120.440155ms","start":"2026-09-18T02:30:05.494869Z","end":"2026-09-18T02:30:05.61531Z","steps":["trace[206057411] 'process raft request' (duration: 120.101547ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:05.615613Z","caller":"traceutil/trace.go:171","msg":"trace[664360962] transaction","detail":"{read_only:false; response_revision:5321; number_of_response:1; }","duration":"120.620874ms","start":"2026-09-18T02:30:05.49498Z","end":"2026-09-18T02:30:05.615601Z","steps":["trace[664360962] 'process raft request' (duration: 120.238684ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:05.615433Z","caller":"traceutil/trace.go:171","msg":"trace[1270015306] linearizableReadLoop","detail":"{readStateIndex:5526; appliedIndex:5523; }","duration":"102.671235ms","start":"2026-09-18T02:30:05.512753Z","end":"2026-09-18T02:30:05.615424Z","steps":["trace[1270015306] 'read index received' (duration: 60.595031ms)","trace[1270015306] 'applied index is now lower than readState.Index' (duration: 42.075594ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:30:05.615758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.991501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:30:05.61578Z","caller":"traceutil/trace.go:171","msg":"trace[976198019] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5321; }","duration":"103.081896ms","start":"2026-09-18T02:30:05.512691Z","end":"2026-09-18T02:30:05.615772Z","steps":["trace[976198019] 'agreement among raft nodes before linearized reading' (duration: 103.020893ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.156435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"910.355962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10394"} {"level":"info","ts":"2026-09-18T02:30:11.156507Z","caller":"traceutil/trace.go:171","msg":"trace[1161133128] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5364; }","duration":"910.480528ms","start":"2026-09-18T02:30:10.24601Z","end":"2026-09-18T02:30:11.156491Z","steps":["trace[1161133128] 'range keys from in-memory index tree' (duration: 910.178153ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.156545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:10.245985Z","time spent":"910.551192ms","remote":"127.0.0.1:56030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10418,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-09-18T02:30:11.157225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"848.469614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-09-18T02:30:11.15727Z","caller":"traceutil/trace.go:171","msg":"trace[1732998722] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5364; }","duration":"848.570569ms","start":"2026-09-18T02:30:10.308688Z","end":"2026-09-18T02:30:11.157259Z","steps":["trace[1732998722] 'range keys from in-memory index tree' (duration: 848.363168ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.15733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:10.308669Z","time spent":"848.652854ms","remote":"127.0.0.1:56012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1889,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-09-18T02:30:11.37393Z","caller":"traceutil/trace.go:171","msg":"trace[936890264] transaction","detail":"{read_only:false; response_revision:5365; number_of_response:1; }","duration":"986.896859ms","start":"2026-09-18T02:30:10.387007Z","end":"2026-09-18T02:30:11.373904Z","steps":["trace[936890264] 'process raft request' (duration: 986.771343ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.374067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:10.386971Z","time spent":"987.023096ms","remote":"127.0.0.1:56108","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:30:11.425971Z","caller":"traceutil/trace.go:171","msg":"trace[1066408879] linearizableReadLoop","detail":"{readStateIndex:5572; appliedIndex:5571; }","duration":"268.798472ms","start":"2026-09-18T02:30:11.157151Z","end":"2026-09-18T02:30:11.425949Z","steps":["trace[1066408879] 'read index received' (duration: 216.834911ms)","trace[1066408879] 'applied index is now lower than readState.Index' (duration: 51.962481ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:30:11.426376Z","caller":"traceutil/trace.go:171","msg":"trace[1283370863] transaction","detail":"{read_only:false; response_revision:5366; number_of_response:1; }","duration":"938.292286ms","start":"2026-09-18T02:30:10.48807Z","end":"2026-09-18T02:30:11.426362Z","steps":["trace[1283370863] 'process raft request' (duration: 937.664014ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.426537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:10.488033Z","time spent":"938.424333ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:30:11.42692Z","caller":"traceutil/trace.go:171","msg":"trace[1331599349] transaction","detail":"{read_only:false; response_revision:5367; number_of_response:1; }","duration":"257.461309ms","start":"2026-09-18T02:30:11.169438Z","end":"2026-09-18T02:30:11.426899Z","steps":["trace[1331599349] 'process raft request' (duration: 256.419936ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.427036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.395247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-19ff65ad-8aa7-4126-8a57-6fd148edb2be\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-09-18T02:30:11.427134Z","caller":"traceutil/trace.go:171","msg":"trace[913091383] range","detail":"{range_begin:/registry/persistentvolumes/pvc-19ff65ad-8aa7-4126-8a57-6fd148edb2be; range_end:; response_count:1; response_revision:5368; }","duration":"265.579736ms","start":"2026-09-18T02:30:11.16153Z","end":"2026-09-18T02:30:11.42711Z","steps":["trace[913091383] 'agreement among raft nodes before linearized reading' (duration: 265.307172ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.427593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.310137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-18T02:30:11.427652Z","caller":"traceutil/trace.go:171","msg":"trace[2017186334] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5368; }","duration":"239.38407ms","start":"2026-09-18T02:30:11.188245Z","end":"2026-09-18T02:30:11.42763Z","steps":["trace[2017186334] 'agreement among raft nodes before linearized reading' (duration: 239.255363ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.426543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.35504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:30:11.427908Z","caller":"traceutil/trace.go:171","msg":"trace[209093078] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:5368; }","duration":"270.800805ms","start":"2026-09-18T02:30:11.157097Z","end":"2026-09-18T02:30:11.427897Z","steps":["trace[209093078] 'agreement among raft nodes before linearized reading' (duration: 269.322439ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:11.427527Z","caller":"traceutil/trace.go:171","msg":"trace[1663406216] transaction","detail":"{read_only:false; response_revision:5368; number_of_response:1; }","duration":"145.306896ms","start":"2026-09-18T02:30:11.281804Z","end":"2026-09-18T02:30:11.427111Z","steps":["trace[1663406216] 'process raft request' (duration: 144.104855ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.770399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.423288ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T02:30:11.770515Z","caller":"traceutil/trace.go:171","msg":"trace[650432147] transaction","detail":"{read_only:false; response_revision:5369; number_of_response:1; }","duration":"338.128104ms","start":"2026-09-18T02:30:11.432363Z","end":"2026-09-18T02:30:11.770491Z","steps":["trace[650432147] 'process raft request' (duration: 29.501186ms)","trace[650432147] 'compare' (duration: 308.228407ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:30:11.770595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:11.432343Z","time spent":"338.212728ms","remote":"127.0.0.1:56108","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:30:11.838053Z","caller":"traceutil/trace.go:171","msg":"trace[1299884232] transaction","detail":"{read_only:false; response_revision:5370; number_of_response:1; }","duration":"402.582656ms","start":"2026-09-18T02:30:11.435442Z","end":"2026-09-18T02:30:11.838025Z","steps":["trace[1299884232] 'process raft request' (duration: 402.341484ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.838278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:11.43542Z","time spent":"402.745944ms","remote":"127.0.0.1:56124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1428,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:30:11.838385Z","caller":"traceutil/trace.go:171","msg":"trace[1202304839] transaction","detail":"{read_only:false; response_revision:5371; number_of_response:1; }","duration":"402.152893ms","start":"2026-09-18T02:30:11.436207Z","end":"2026-09-18T02:30:11.83836Z","steps":["trace[1202304839] 'process raft request' (duration: 401.774434ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.838672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:11.43619Z","time spent":"402.375835ms","remote":"127.0.0.1:56124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1505,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:30:11.838785Z","caller":"traceutil/trace.go:171","msg":"trace[1953184544] transaction","detail":"{read_only:false; response_revision:5372; number_of_response:1; }","duration":"402.206336ms","start":"2026-09-18T02:30:11.436543Z","end":"2026-09-18T02:30:11.838749Z","steps":["trace[1953184544] 'process raft request' (duration: 401.68876ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.838884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:11.436519Z","time spent":"402.310211ms","remote":"127.0.0.1:56016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":892,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:30:11.838963Z","caller":"traceutil/trace.go:171","msg":"trace[1338171092] transaction","detail":"{read_only:false; response_revision:5373; number_of_response:1; }","duration":"401.218516ms","start":"2026-09-18T02:30:11.437733Z","end":"2026-09-18T02:30:11.838951Z","steps":["trace[1338171092] 'process raft request' (duration: 400.615745ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.839033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:11.437719Z","time spent":"401.275049ms","remote":"127.0.0.1:56016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:30:11.839392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.746736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:30:11.839438Z","caller":"traceutil/trace.go:171","msg":"trace[1046651928] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5373; }","duration":"331.860102ms","start":"2026-09-18T02:30:11.507567Z","end":"2026-09-18T02:30:11.839427Z","steps":["trace[1046651928] 'agreement among raft nodes before linearized reading' (duration: 331.785148ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.839466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:11.506608Z","time spent":"332.851503ms","remote":"127.0.0.1:55872","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:30:11.839771Z","caller":"traceutil/trace.go:171","msg":"trace[1074190338] linearizableReadLoop","detail":"{readStateIndex:5579; appliedIndex:5575; }","duration":"330.708013ms","start":"2026-09-18T02:30:11.507685Z","end":"2026-09-18T02:30:11.838393Z","steps":["trace[1074190338] 'read index received' (duration: 330.002317ms)","trace[1074190338] 'applied index is now lower than readState.Index' (duration: 704.756µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:30:11.839935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.91879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T02:30:11.839982Z","caller":"traceutil/trace.go:171","msg":"trace[1382653564] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:5373; }","duration":"220.008175ms","start":"2026-09-18T02:30:11.619963Z","end":"2026-09-18T02:30:11.839971Z","steps":["trace[1382653564] 'agreement among raft nodes before linearized reading' (duration: 219.921181ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.84032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.928375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3244"} {"level":"info","ts":"2026-09-18T02:30:11.840359Z","caller":"traceutil/trace.go:171","msg":"trace[1923948108] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5373; }","duration":"101.01414ms","start":"2026-09-18T02:30:11.739331Z","end":"2026-09-18T02:30:11.840345Z","steps":["trace[1923948108] 'agreement among raft nodes before linearized reading' (duration: 100.831111ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.840582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.581159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-09-18T02:30:11.840614Z","caller":"traceutil/trace.go:171","msg":"trace[2112270912] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5373; }","duration":"173.637572ms","start":"2026-09-18T02:30:11.666968Z","end":"2026-09-18T02:30:11.840605Z","steps":["trace[2112270912] 'agreement among raft nodes before linearized reading' (duration: 173.544197ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.84079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.90117ms","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:30:11.840821Z","caller":"traceutil/trace.go:171","msg":"trace[1246458857] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5373; }","duration":"190.951922ms","start":"2026-09-18T02:30:11.649861Z","end":"2026-09-18T02:30:11.840813Z","steps":["trace[1246458857] 'agreement among raft nodes before linearized reading' (duration: 190.870748ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.840989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.624977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-18T02:30:11.841037Z","caller":"traceutil/trace.go:171","msg":"trace[1752995289] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5373; }","duration":"191.658509ms","start":"2026-09-18T02:30:11.649356Z","end":"2026-09-18T02:30:11.841014Z","steps":["trace[1752995289] 'agreement among raft nodes before linearized reading' (duration: 191.576714ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:11.841196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.808111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-09-18T02:30:11.841222Z","caller":"traceutil/trace.go:171","msg":"trace[1438236704] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5373; }","duration":"202.855084ms","start":"2026-09-18T02:30:11.638358Z","end":"2026-09-18T02:30:11.841213Z","steps":["trace[1438236704] 'agreement among raft nodes before linearized reading' (duration: 202.78552ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:12.162085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.063271ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T02:30:12.162285Z","caller":"traceutil/trace.go:171","msg":"trace[634102346] linearizableReadLoop","detail":"{readStateIndex:5580; appliedIndex:5579; }","duration":"315.927818ms","start":"2026-09-18T02:30:11.846337Z","end":"2026-09-18T02:30:12.162265Z","steps":["trace[634102346] 'read index received' (duration: 45.618184ms)","trace[634102346] 'applied index is now lower than readState.Index' (duration: 270.308144ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:30:12.162393Z","caller":"traceutil/trace.go:171","msg":"trace[614966078] transaction","detail":"{read_only:false; response_revision:5374; number_of_response:1; }","duration":"316.381471ms","start":"2026-09-18T02:30:11.845999Z","end":"2026-09-18T02:30:12.16238Z","steps":["trace[614966078] 'process raft request' (duration: 45.94021ms)","trace[614966078] 'compare' (duration: 269.915104ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:30:12.162457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:11.845974Z","time spent":"316.441815ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:30:12.162484Z","caller":"traceutil/trace.go:171","msg":"trace[1674564679] transaction","detail":"{read_only:false; response_revision:5376; number_of_response:1; }","duration":"314.645952ms","start":"2026-09-18T02:30:11.847818Z","end":"2026-09-18T02:30:12.162464Z","steps":["trace[1674564679] 'process raft request' (duration: 314.414ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:12.162729Z","caller":"traceutil/trace.go:171","msg":"trace[1274785094] transaction","detail":"{read_only:false; response_revision:5375; number_of_response:1; }","duration":"315.534808ms","start":"2026-09-18T02:30:11.847173Z","end":"2026-09-18T02:30:12.162708Z","steps":["trace[1274785094] 'process raft request' (duration: 315.007451ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:12.16282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:11.847162Z","time spent":"315.616232ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:30:12.16256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.213442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-09-18T02:30:12.162879Z","caller":"traceutil/trace.go:171","msg":"trace[1915277835] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5376; }","duration":"316.588212ms","start":"2026-09-18T02:30:11.846274Z","end":"2026-09-18T02:30:12.162862Z","steps":["trace[1915277835] 'agreement among raft nodes before linearized reading' (duration: 316.118658ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:12.162943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:11.84626Z","time spent":"316.666466ms","remote":"127.0.0.1:56030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-09-18T02:30:12.163142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:11.847792Z","time spent":"315.269844ms","remote":"127.0.0.1:56108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:30:12.177827Z","caller":"traceutil/trace.go:171","msg":"trace[924660583] transaction","detail":"{read_only:false; response_revision:5377; number_of_response:1; }","duration":"213.739279ms","start":"2026-09-18T02:30:11.964053Z","end":"2026-09-18T02:30:12.177793Z","steps":["trace[924660583] 'process raft request' (duration: 213.554689ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:12.178427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.951242ms","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:30:12.178276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.814483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1162"} {"level":"info","ts":"2026-09-18T02:30:12.178707Z","caller":"traceutil/trace.go:171","msg":"trace[287622323] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:5377; }","duration":"330.190962ms","start":"2026-09-18T02:30:11.848396Z","end":"2026-09-18T02:30:12.178587Z","steps":["trace[287622323] 'agreement among raft nodes before linearized reading' (duration: 329.57547ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:12.178944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:30:11.848383Z","time spent":"330.471036ms","remote":"127.0.0.1:55970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1186,"request content":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" "} {"level":"info","ts":"2026-09-18T02:30:12.178514Z","caller":"traceutil/trace.go:171","msg":"trace[1361302356] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5377; }","duration":"137.084338ms","start":"2026-09-18T02:30:12.04141Z","end":"2026-09-18T02:30:12.178494Z","steps":["trace[1361302356] 'agreement among raft nodes before linearized reading' (duration: 136.815524ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:12.380541Z","caller":"traceutil/trace.go:171","msg":"trace[1678371189] linearizableReadLoop","detail":"{readStateIndex:5586; appliedIndex:5585; }","duration":"138.419186ms","start":"2026-09-18T02:30:12.242093Z","end":"2026-09-18T02:30:12.380512Z","steps":["trace[1678371189] 'read index received' (duration: 96.049308ms)","trace[1678371189] 'applied index is now lower than readState.Index' (duration: 42.368838ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:30:12.380673Z","caller":"traceutil/trace.go:171","msg":"trace[1049813565] transaction","detail":"{read_only:false; response_revision:5380; number_of_response:1; }","duration":"143.254945ms","start":"2026-09-18T02:30:12.237354Z","end":"2026-09-18T02:30:12.380608Z","steps":["trace[1049813565] 'process raft request' (duration: 100.109927ms)","trace[1049813565] 'compare' (duration: 42.762019ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:30:12.380965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.842949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9637"} {"level":"info","ts":"2026-09-18T02:30:12.381043Z","caller":"traceutil/trace.go:171","msg":"trace[544721311] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:5380; }","duration":"138.985826ms","start":"2026-09-18T02:30:12.24204Z","end":"2026-09-18T02:30:12.381026Z","steps":["trace[544721311] 'agreement among raft nodes before linearized reading' (duration: 138.607836ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:16.35712Z","caller":"traceutil/trace.go:171","msg":"trace[963277040] transaction","detail":"{read_only:false; response_revision:5417; number_of_response:1; }","duration":"142.78517ms","start":"2026-09-18T02:30:16.214309Z","end":"2026-09-18T02:30:16.357094Z","steps":["trace[963277040] 'process raft request' (duration: 142.387479ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:16.357461Z","caller":"traceutil/trace.go:171","msg":"trace[17249392] linearizableReadLoop","detail":"{readStateIndex:5625; appliedIndex:5623; }","duration":"126.390274ms","start":"2026-09-18T02:30:16.231057Z","end":"2026-09-18T02:30:16.357447Z","steps":["trace[17249392] 'read index received' (duration: 1.079745ms)","trace[17249392] 'applied index is now lower than readState.Index' (duration: 125.309679ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:30:16.357563Z","caller":"traceutil/trace.go:171","msg":"trace[319336295] transaction","detail":"{read_only:false; response_revision:5418; number_of_response:1; }","duration":"143.17869ms","start":"2026-09-18T02:30:16.214362Z","end":"2026-09-18T02:30:16.357541Z","steps":["trace[319336295] 'process raft request' (duration: 142.673154ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:16.357956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.555647ms","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:30:16.358002Z","caller":"traceutil/trace.go:171","msg":"trace[3569974] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5418; }","duration":"116.651612ms","start":"2026-09-18T02:30:16.241339Z","end":"2026-09-18T02:30:16.357991Z","steps":["trace[3569974] 'agreement among raft nodes before linearized reading' (duration: 116.504355ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:16.358305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.254369ms","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:30:16.358341Z","caller":"traceutil/trace.go:171","msg":"trace[116082549] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5418; }","duration":"127.368345ms","start":"2026-09-18T02:30:16.230964Z","end":"2026-09-18T02:30:16.358332Z","steps":["trace[116082549] 'agreement among raft nodes before linearized reading' (duration: 126.598205ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:57.230712Z","caller":"traceutil/trace.go:171","msg":"trace[980365999] transaction","detail":"{read_only:false; response_revision:5745; number_of_response:1; }","duration":"137.775282ms","start":"2026-09-18T02:30:57.092907Z","end":"2026-09-18T02:30:57.230682Z","steps":["trace[980365999] 'process raft request' (duration: 137.448615ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:31:08.652936Z","caller":"traceutil/trace.go:171","msg":"trace[1272365603] linearizableReadLoop","detail":"{readStateIndex:6045; appliedIndex:6043; }","duration":"113.158253ms","start":"2026-09-18T02:31:08.539737Z","end":"2026-09-18T02:31:08.652896Z","steps":["trace[1272365603] 'read index received' (duration: 2.199176ms)","trace[1272365603] 'applied index is now lower than readState.Index' (duration: 110.957527ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:31:08.653072Z","caller":"traceutil/trace.go:171","msg":"trace[1434313021] transaction","detail":"{read_only:false; response_revision:5825; number_of_response:1; }","duration":"122.177509ms","start":"2026-09-18T02:31:08.530878Z","end":"2026-09-18T02:31:08.653055Z","steps":["trace[1434313021] 'process raft request' (duration: 89.621108ms)","trace[1434313021] 'compare' (duration: 32.166141ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:31:08.653453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.702662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-09-18T02:31:08.653565Z","caller":"traceutil/trace.go:171","msg":"trace[375851917] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5826; }","duration":"113.84375ms","start":"2026-09-18T02:31:08.539693Z","end":"2026-09-18T02:31:08.653536Z","steps":["trace[375851917] 'agreement among raft nodes before linearized reading' (duration: 113.333993ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:34:58.543573Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5219} {"level":"info","ts":"2026-09-18T02:34:58.627713Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5219,"took":"82.551914ms","hash":2162814487,"current-db-size-bytes":50302976,"current-db-size":"50 MB","current-db-size-in-use-bytes":19365888,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-18T02:34:58.627918Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2162814487,"revision":5219,"compact-revision":2836} {"level":"warn","ts":"2026-09-18T02:35:44.464615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.409803ms","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:35:44.464719Z","caller":"traceutil/trace.go:171","msg":"trace[190522519] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7620; }","duration":"136.566075ms","start":"2026-09-18T02:35:44.328128Z","end":"2026-09-18T02:35:44.464694Z","steps":["trace[190522519] 'range keys from in-memory index tree' (duration: 136.23252ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:35:51.24283Z","caller":"traceutil/trace.go:171","msg":"trace[1735805376] transaction","detail":"{read_only:false; response_revision:7656; number_of_response:1; }","duration":"168.935269ms","start":"2026-09-18T02:35:51.073869Z","end":"2026-09-18T02:35:51.242805Z","steps":["trace[1735805376] 'process raft request' (duration: 168.656794ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:35:56.940312Z","caller":"traceutil/trace.go:171","msg":"trace[1815016286] transaction","detail":"{read_only:false; response_revision:7684; number_of_response:1; }","duration":"114.45788ms","start":"2026-09-18T02:35:56.82583Z","end":"2026-09-18T02:35:56.940287Z","steps":["trace[1815016286] 'process raft request' (duration: 37.284259ms)","trace[1815016286] 'compare' (duration: 76.883526ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:37:04.508265Z","caller":"traceutil/trace.go:171","msg":"trace[1578393242] linearizableReadLoop","detail":"{readStateIndex:8324; appliedIndex:8323; }","duration":"136.928693ms","start":"2026-09-18T02:37:04.371311Z","end":"2026-09-18T02:37:04.508239Z","steps":["trace[1578393242] 'read index received' (duration: 136.772559ms)","trace[1578393242] 'applied index is now lower than readState.Index' (duration: 155.014µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:37:04.508369Z","caller":"traceutil/trace.go:171","msg":"trace[1907908596] transaction","detail":"{read_only:false; response_revision:8023; number_of_response:1; }","duration":"165.810775ms","start":"2026-09-18T02:37:04.342539Z","end":"2026-09-18T02:37:04.508349Z","steps":["trace[1907908596] 'process raft request' (duration: 165.517728ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:37:04.508512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.180769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-09-18T02:37:04.508547Z","caller":"traceutil/trace.go:171","msg":"trace[682383128] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pv-protection-controller; range_end:; response_count:1; response_revision:8023; }","duration":"137.263521ms","start":"2026-09-18T02:37:04.371271Z","end":"2026-09-18T02:37:04.508534Z","steps":["trace[682383128] 'agreement among raft nodes before linearized reading' (duration: 137.104227ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:37:04.513488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.586789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-09-18T02:37:04.513542Z","caller":"traceutil/trace.go:171","msg":"trace[1439126689] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pod-garbage-collector; range_end:; response_count:1; response_revision:8024; }","duration":"128.663361ms","start":"2026-09-18T02:37:04.384867Z","end":"2026-09-18T02:37:04.513531Z","steps":["trace[1439126689] 'agreement among raft nodes before linearized reading' (duration: 128.536798ms)"],"step_count":1}