{"level":"warn","ts":"2026-09-18T02:19:47.600546Z","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:47.600698Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.203: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.203:2380","--initial-cluster=instance=https://162.253.55.203:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.203:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.203: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:47.600774Z","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:47.600789Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.203:2380"]} {"level":"info","ts":"2026-09-18T02:19:47.600809Z","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:47.601442Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.203:2379"]} {"level":"info","ts":"2026-09-18T02:19:47.601514Z","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.203:2380"],"listen-peer-urls":["https://162.253.55.203:2380"],"advertise-client-urls":["https://162.253.55.203:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.203:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.203: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:47.609209Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.36028ms"} {"level":"info","ts":"2026-09-18T02:19:47.622859Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a656331365382b34","cluster-id":"84e77d9b2eaf556a"} {"level":"info","ts":"2026-09-18T02:19:47.623044Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T02:19:47.623149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 became follower at term 0"} {"level":"info","ts":"2026-09-18T02:19:47.62322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a656331365382b34 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T02:19:47.623278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 became follower at term 1"} {"level":"info","ts":"2026-09-18T02:19:47.623394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 switched to configuration voters=(11985823616688728884)"} {"level":"warn","ts":"2026-09-18T02:19:47.631307Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T02:19:47.632888Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T02:19:47.634291Z","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:47.637968Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a656331365382b34","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T02:19:47.638173Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a656331365382b34","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T02:19:47.638312Z","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:47.638676Z","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:47.639561Z","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:47.639709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 switched to configuration voters=(11985823616688728884)"} {"level":"info","ts":"2026-09-18T02:19:47.639828Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"84e77d9b2eaf556a","local-member-id":"a656331365382b34","added-peer-id":"a656331365382b34","added-peer-peer-urls":["https://162.253.55.203:2380"]} {"level":"info","ts":"2026-09-18T02:19:47.646776Z","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:47.646926Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.203:2380"} {"level":"info","ts":"2026-09-18T02:19:47.646991Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.203:2380"} {"level":"info","ts":"2026-09-18T02:19:47.648582Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a656331365382b34","initial-advertise-peer-urls":["https://162.253.55.203:2380"],"listen-peer-urls":["https://162.253.55.203:2380"],"advertise-client-urls":["https://162.253.55.203:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.203:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T02:19:47.648643Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T02:19:48.324283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T02:19:48.32438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T02:19:48.324419Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 received MsgPreVoteResp from a656331365382b34 at term 1"} {"level":"info","ts":"2026-09-18T02:19:48.32446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 became candidate at term 2"} {"level":"info","ts":"2026-09-18T02:19:48.324494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 received MsgVoteResp from a656331365382b34 at term 2"} {"level":"info","ts":"2026-09-18T02:19:48.324519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a656331365382b34 became leader at term 2"} {"level":"info","ts":"2026-09-18T02:19:48.324546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a656331365382b34 elected leader a656331365382b34 at term 2"} {"level":"info","ts":"2026-09-18T02:19:48.325739Z","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:48.326559Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a656331365382b34","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.203:2379]}","request-path":"/0/members/a656331365382b34/attributes","cluster-id":"84e77d9b2eaf556a","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T02:19:48.326718Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T02:19:48.326807Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T02:19:48.327031Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T02:19:48.327062Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T02:19:48.3273Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"84e77d9b2eaf556a","local-member-id":"a656331365382b34","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:19:48.327389Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:19:48.327446Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T02:19:48.329118Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.203:2379"} {"level":"info","ts":"2026-09-18T02:19:48.331932Z","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:20:37.09857Z","caller":"traceutil/trace.go:171","msg":"trace[761587846] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"119.481727ms","start":"2026-09-18T02:20:36.979064Z","end":"2026-09-18T02:20:37.098546Z","steps":["trace[761587846] 'process raft request' (duration: 64.710451ms)","trace[761587846] 'compare' (duration: 54.675073ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:20:40.990069Z","caller":"traceutil/trace.go:171","msg":"trace[2126712965] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"102.53299ms","start":"2026-09-18T02:20:40.887511Z","end":"2026-09-18T02:20:40.990044Z","steps":["trace[2126712965] 'process raft request' (duration: 81.246389ms)","trace[2126712965] 'compare' (duration: 20.974401ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:20:43.13531Z","caller":"traceutil/trace.go:171","msg":"trace[1850518808] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"159.617237ms","start":"2026-09-18T02:20:42.975637Z","end":"2026-09-18T02:20:43.135254Z","steps":["trace[1850518808] 'process raft request' (duration: 112.851094ms)","trace[1850518808] 'compare' (duration: 46.253547ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:20:43.713877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.184843ms","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:20:43.713983Z","caller":"traceutil/trace.go:171","msg":"trace[1759703424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:623; }","duration":"138.297017ms","start":"2026-09-18T02:20:43.575666Z","end":"2026-09-18T02:20:43.713963Z","steps":["trace[1759703424] 'range keys from in-memory index tree' (duration: 138.021558ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:20:43.713968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.860193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4zrjg\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-18T02:20:43.714029Z","caller":"traceutil/trace.go:171","msg":"trace[271324798] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4zrjg; range_end:; response_count:1; response_revision:623; }","duration":"203.962226ms","start":"2026-09-18T02:20:43.510051Z","end":"2026-09-18T02:20:43.714013Z","steps":["trace[271324798] 'range keys from in-memory index tree' (duration: 203.783611ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:20:44.006016Z","caller":"traceutil/trace.go:171","msg":"trace[859740079] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"288.178872ms","start":"2026-09-18T02:20:43.717808Z","end":"2026-09-18T02:20:44.005987Z","steps":["trace[859740079] 'process raft request' (duration: 288.002507ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:20:44.256895Z","caller":"traceutil/trace.go:171","msg":"trace[1011880839] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"530.67848ms","start":"2026-09-18T02:20:43.726189Z","end":"2026-09-18T02:20:44.256868Z","steps":["trace[1011880839] 'process raft request' (duration: 530.520795ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:20:44.257635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:20:43.726165Z","time spent":"530.823015ms","remote":"127.0.0.1:50588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:20:44.263653Z","caller":"traceutil/trace.go:171","msg":"trace[1779377577] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"523.372191ms","start":"2026-09-18T02:20:43.74021Z","end":"2026-09-18T02:20:44.263582Z","steps":["trace[1779377577] 'process raft request' (duration: 521.770752ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:20:44.263875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:20:43.740185Z","time spent":"523.590048ms","remote":"127.0.0.1:50486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:20:44.265127Z","caller":"traceutil/trace.go:171","msg":"trace[2024555136] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"211.528458ms","start":"2026-09-18T02:20:44.053572Z","end":"2026-09-18T02:20:44.2651Z","steps":["trace[2024555136] 'process raft request' (duration: 209.195606ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:20:44.265425Z","caller":"traceutil/trace.go:171","msg":"trace[1305871241] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:654; }","duration":"353.325868ms","start":"2026-09-18T02:20:43.911979Z","end":"2026-09-18T02:20:44.265305Z","steps":["trace[1305871241] 'read index received' (duration: 93.942548ms)","trace[1305871241] 'applied index is now lower than readState.Index' (duration: 259.247016ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:20:44.265821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.825573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:20:44.265897Z","caller":"traceutil/trace.go:171","msg":"trace[1885102967] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"353.964738ms","start":"2026-09-18T02:20:43.911908Z","end":"2026-09-18T02:20:44.265873Z","steps":["trace[1885102967] 'agreement among raft nodes before linearized reading' (duration: 353.682579ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:20:44.265949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:20:43.911883Z","time spent":"354.056821ms","remote":"127.0.0.1:50388","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:00.234067Z","caller":"traceutil/trace.go:171","msg":"trace[819610613] transaction","detail":"{read_only:false; response_revision:793; number_of_response:1; }","duration":"151.872982ms","start":"2026-09-18T02:21:00.082167Z","end":"2026-09-18T02:21:00.23404Z","steps":["trace[819610613] 'process raft request' (duration: 151.712368ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:21:18.230418Z","caller":"traceutil/trace.go:171","msg":"trace[569085952] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"193.498984ms","start":"2026-09-18T02:21:18.036891Z","end":"2026-09-18T02:21:18.23039Z","steps":["trace[569085952] 'process raft request' (duration: 96.266875ms)","trace[569085952] 'compare' (duration: 97.076395ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:21:18.236014Z","caller":"traceutil/trace.go:171","msg":"trace[1710291660] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"108.064956ms","start":"2026-09-18T02:21:18.127937Z","end":"2026-09-18T02:21:18.236002Z","steps":["trace[1710291660] 'process raft request' (duration: 108.013045ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:21:18.236176Z","caller":"traceutil/trace.go:171","msg":"trace[1312846222] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"199.103242ms","start":"2026-09-18T02:21:18.037037Z","end":"2026-09-18T02:21:18.23614Z","steps":["trace[1312846222] 'process raft request' (duration: 198.823646ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:21:18.466667Z","caller":"traceutil/trace.go:171","msg":"trace[657660702] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"123.158802ms","start":"2026-09-18T02:21:18.343451Z","end":"2026-09-18T02:21:18.466609Z","steps":["trace[657660702] 'process raft request' (duration: 110.583204ms)","trace[657660702] 'compare' (duration: 12.329693ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:21:18.466762Z","caller":"traceutil/trace.go:171","msg":"trace[1418558367] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"119.185161ms","start":"2026-09-18T02:21:18.347549Z","end":"2026-09-18T02:21:18.466734Z","steps":["trace[1418558367] 'process raft request' (duration: 119.041798ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:21:18.467134Z","caller":"traceutil/trace.go:171","msg":"trace[1259541440] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"118.672969ms","start":"2026-09-18T02:21:18.348435Z","end":"2026-09-18T02:21:18.467108Z","steps":["trace[1259541440] 'process raft request' (duration: 118.243269ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:21:18.467232Z","caller":"traceutil/trace.go:171","msg":"trace[214861849] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"112.546519ms","start":"2026-09-18T02:21:18.354657Z","end":"2026-09-18T02:21:18.467203Z","steps":["trace[214861849] 'process raft request' (duration: 112.204741ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:21:18.467607Z","caller":"traceutil/trace.go:171","msg":"trace[1319573335] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"122.032406ms","start":"2026-09-18T02:21:18.344906Z","end":"2026-09-18T02:21:18.466939Z","steps":["trace[1319573335] 'process raft request' (duration: 121.622297ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:21:30.65028Z","caller":"traceutil/trace.go:171","msg":"trace[1940244745] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"193.29756ms","start":"2026-09-18T02:21:30.456944Z","end":"2026-09-18T02:21:30.650241Z","steps":["trace[1940244745] 'process raft request' (duration: 193.035424ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:21:45.994786Z","caller":"traceutil/trace.go:171","msg":"trace[289086030] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"114.31781ms","start":"2026-09-18T02:21:45.880413Z","end":"2026-09-18T02:21:45.994731Z","steps":["trace[289086030] 'process raft request' (duration: 111.417005ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:21:52.190698Z","caller":"traceutil/trace.go:171","msg":"trace[1933772472] linearizableReadLoop","detail":"{readStateIndex:1503; appliedIndex:1502; }","duration":"171.456001ms","start":"2026-09-18T02:21:52.01921Z","end":"2026-09-18T02:21:52.190666Z","steps":["trace[1933772472] 'read index received' (duration: 171.172246ms)","trace[1933772472] 'applied index is now lower than readState.Index' (duration: 282.345µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:21:52.190756Z","caller":"traceutil/trace.go:171","msg":"trace[483763518] transaction","detail":"{read_only:false; response_revision:1453; number_of_response:1; }","duration":"175.358762ms","start":"2026-09-18T02:21:52.015364Z","end":"2026-09-18T02:21:52.190723Z","steps":["trace[483763518] 'process raft request' (duration: 175.060607ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:21:52.190941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.719685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-18T02:21:52.191022Z","caller":"traceutil/trace.go:171","msg":"trace[1929421952] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1453; }","duration":"171.850958ms","start":"2026-09-18T02:21:52.019156Z","end":"2026-09-18T02:21:52.191006Z","steps":["trace[1929421952] 'agreement among raft nodes before linearized reading' (duration: 171.656425ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:21:54.303105Z","caller":"traceutil/trace.go:171","msg":"trace[1315442608] linearizableReadLoop","detail":"{readStateIndex:1512; appliedIndex:1511; }","duration":"100.711235ms","start":"2026-09-18T02:21:54.202371Z","end":"2026-09-18T02:21:54.303082Z","steps":["trace[1315442608] 'read index received' (duration: 100.47131ms)","trace[1315442608] 'applied index is now lower than readState.Index' (duration: 238.555µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:21:54.303387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.99611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-18T02:21:54.303431Z","caller":"traceutil/trace.go:171","msg":"trace[1175847553] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1462; }","duration":"101.090852ms","start":"2026-09-18T02:21:54.202329Z","end":"2026-09-18T02:21:54.30342Z","steps":["trace[1175847553] 'agreement among raft nodes before linearized reading' (duration: 100.877418ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:21:54.303645Z","caller":"traceutil/trace.go:171","msg":"trace[22448565] transaction","detail":"{read_only:false; response_revision:1462; number_of_response:1; }","duration":"106.008411ms","start":"2026-09-18T02:21:54.197598Z","end":"2026-09-18T02:21:54.303606Z","steps":["trace[22448565] 'process raft request' (duration: 105.230317ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:19.381012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.006177ms","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":"warn","ts":"2026-09-18T02:22:19.381058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.540737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-09-18T02:22:19.381088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.857213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6d222502-25d2-40c6-aef6-bf15f3746195\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-18T02:22:19.381133Z","caller":"traceutil/trace.go:171","msg":"trace[1563770573] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1866; }","duration":"530.232131ms","start":"2026-09-18T02:22:18.850876Z","end":"2026-09-18T02:22:19.381108Z","steps":["trace[1563770573] 'range keys from in-memory index tree' (duration: 529.718202ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:19.381139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.614148ms","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:22:19.381187Z","caller":"traceutil/trace.go:171","msg":"trace[537970173] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6d222502-25d2-40c6-aef6-bf15f3746195; range_end:; response_count:1; response_revision:1866; }","duration":"163.992916ms","start":"2026-09-18T02:22:19.217168Z","end":"2026-09-18T02:22:19.381161Z","steps":["trace[537970173] 'range keys from in-memory index tree' (duration: 163.64046ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:19.3812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:22:18.850854Z","time spent":"530.329982ms","remote":"127.0.0.1:58796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5468,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-09-18T02:22:19.381242Z","caller":"traceutil/trace.go:171","msg":"trace[1282065746] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1866; }","duration":"321.73938ms","start":"2026-09-18T02:22:19.059477Z","end":"2026-09-18T02:22:19.381216Z","steps":["trace[1282065746] 'range keys from in-memory index tree' (duration: 321.393364ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:19.381272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.271403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-09-18T02:22:19.381306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:22:19.05946Z","time spent":"321.833002ms","remote":"127.0.0.1:50692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-18T02:22:19.381327Z","caller":"traceutil/trace.go:171","msg":"trace[1727187772] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1866; }","duration":"439.358444ms","start":"2026-09-18T02:22:18.941949Z","end":"2026-09-18T02:22:19.381308Z","steps":["trace[1727187772] 'range keys from in-memory index tree' (duration: 439.145191ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:19.381375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:22:18.941929Z","time spent":"439.431316ms","remote":"127.0.0.1:50692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-18T02:22:19.381138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.010004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6d222502-25d2-40c6-aef6-bf15f3746195\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-18T02:22:19.381564Z","caller":"traceutil/trace.go:171","msg":"trace[667790622] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6d222502-25d2-40c6-aef6-bf15f3746195; range_end:; response_count:1; response_revision:1866; }","duration":"355.469082ms","start":"2026-09-18T02:22:19.026044Z","end":"2026-09-18T02:22:19.381513Z","steps":["trace[667790622] 'range keys from in-memory index tree' (duration: 354.832571ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:19.381628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:22:19.026025Z","time spent":"355.584564ms","remote":"127.0.0.1:50588","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6d222502-25d2-40c6-aef6-bf15f3746195\" "} {"level":"info","ts":"2026-09-18T02:22:19.381181Z","caller":"traceutil/trace.go:171","msg":"trace[51955437] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1866; }","duration":"321.792081ms","start":"2026-09-18T02:22:19.059361Z","end":"2026-09-18T02:22:19.381153Z","steps":["trace[51955437] 'range keys from in-memory index tree' (duration: 321.219511ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:19.381809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:22:19.059329Z","time spent":"322.466692ms","remote":"127.0.0.1:50692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-18T02:22:19.507861Z","caller":"traceutil/trace.go:171","msg":"trace[737998327] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"121.770647ms","start":"2026-09-18T02:22:19.386056Z","end":"2026-09-18T02:22:19.507827Z","steps":["trace[737998327] 'process raft request' (duration: 121.527703ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:19.569068Z","caller":"traceutil/trace.go:171","msg":"trace[772938449] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"181.578868ms","start":"2026-09-18T02:22:19.387465Z","end":"2026-09-18T02:22:19.569044Z","steps":["trace[772938449] 'process raft request' (duration: 181.356924ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:19.569111Z","caller":"traceutil/trace.go:171","msg":"trace[1979762562] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"181.485996ms","start":"2026-09-18T02:22:19.387586Z","end":"2026-09-18T02:22:19.569072Z","steps":["trace[1979762562] 'process raft request' (duration: 181.361164ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:19.569396Z","caller":"traceutil/trace.go:171","msg":"trace[564382294] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"178.384127ms","start":"2026-09-18T02:22:19.390954Z","end":"2026-09-18T02:22:19.569338Z","steps":["trace[564382294] 'process raft request' (duration: 178.038781ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:19.803063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.270076ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T02:22:19.80321Z","caller":"traceutil/trace.go:171","msg":"trace[213398596] linearizableReadLoop","detail":"{readStateIndex:1948; appliedIndex:1947; }","duration":"135.926424ms","start":"2026-09-18T02:22:19.667262Z","end":"2026-09-18T02:22:19.803188Z","steps":["trace[213398596] 'read index received' (duration: 56.411µs)","trace[213398596] 'applied index is now lower than readState.Index' (duration: 135.868163ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:22:19.803303Z","caller":"traceutil/trace.go:171","msg":"trace[1142581342] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"228.840778ms","start":"2026-09-18T02:22:19.574439Z","end":"2026-09-18T02:22:19.80328Z","steps":["trace[1142581342] 'process raft request' (duration: 20.071383ms)","trace[1142581342] 'compare' (duration: 208.076264ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:22:19.803383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.124067ms","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:22:19.803585Z","caller":"traceutil/trace.go:171","msg":"trace[90148247] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1871; }","duration":"136.234029ms","start":"2026-09-18T02:22:19.667185Z","end":"2026-09-18T02:22:19.803419Z","steps":["trace[90148247] 'agreement among raft nodes before linearized reading' (duration: 136.058766ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:20.118117Z","caller":"traceutil/trace.go:171","msg":"trace[1932116707] linearizableReadLoop","detail":"{readStateIndex:1950; appliedIndex:1949; }","duration":"204.999987ms","start":"2026-09-18T02:22:19.91309Z","end":"2026-09-18T02:22:20.11809Z","steps":["trace[1932116707] 'read index received' (duration: 188.617845ms)","trace[1932116707] 'applied index is now lower than readState.Index' (duration: 16.380982ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:22:20.118189Z","caller":"traceutil/trace.go:171","msg":"trace[1847946652] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"278.651011ms","start":"2026-09-18T02:22:19.839487Z","end":"2026-09-18T02:22:20.118138Z","steps":["trace[1847946652] 'process raft request' (duration: 262.295519ms)","trace[1847946652] 'compare' (duration: 16.074007ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:22:20.118257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.141909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:22:20.118311Z","caller":"traceutil/trace.go:171","msg":"trace[242405339] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1873; }","duration":"205.21303ms","start":"2026-09-18T02:22:19.913083Z","end":"2026-09-18T02:22:20.118296Z","steps":["trace[242405339] 'agreement among raft nodes before linearized reading' (duration: 205.113709ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:35.245491Z","caller":"traceutil/trace.go:171","msg":"trace[28674460] transaction","detail":"{read_only:false; response_revision:2004; number_of_response:1; }","duration":"112.103835ms","start":"2026-09-18T02:22:35.133371Z","end":"2026-09-18T02:22:35.245475Z","steps":["trace[28674460] 'process raft request' (duration: 111.969243ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:54.554912Z","caller":"traceutil/trace.go:171","msg":"trace[1684330604] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"184.30159ms","start":"2026-09-18T02:22:54.37059Z","end":"2026-09-18T02:22:54.554892Z","steps":["trace[1684330604] 'process raft request' (duration: 184.034667ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:54.7692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.636859ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T02:22:54.769292Z","caller":"traceutil/trace.go:171","msg":"trace[1315341005] linearizableReadLoop","detail":"{readStateIndex:2204; appliedIndex:2203; }","duration":"120.901065ms","start":"2026-09-18T02:22:54.648375Z","end":"2026-09-18T02:22:54.769276Z","steps":["trace[1315341005] 'read index received' (duration: 3.035683ms)","trace[1315341005] 'applied index is now lower than readState.Index' (duration: 117.864242ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:22:54.769338Z","caller":"traceutil/trace.go:171","msg":"trace[604328224] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"215.537177ms","start":"2026-09-18T02:22:54.553772Z","end":"2026-09-18T02:22:54.769309Z","steps":["trace[604328224] 'process raft request' (duration: 97.671085ms)","trace[604328224] 'compare' (duration: 117.539827ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:22:54.769559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.180799ms","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:22:54.769597Z","caller":"traceutil/trace.go:171","msg":"trace[2145273352] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2119; }","duration":"121.248931ms","start":"2026-09-18T02:22:54.648338Z","end":"2026-09-18T02:22:54.769587Z","steps":["trace[2145273352] 'agreement among raft nodes before linearized reading' (duration: 121.014957ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:54.938782Z","caller":"traceutil/trace.go:171","msg":"trace[1366163881] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"105.398454ms","start":"2026-09-18T02:22:54.833358Z","end":"2026-09-18T02:22:54.938756Z","steps":["trace[1366163881] 'process raft request' (duration: 52.343067ms)","trace[1366163881] 'compare' (duration: 52.814174ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:22:56.015791Z","caller":"traceutil/trace.go:171","msg":"trace[1536426534] linearizableReadLoop","detail":"{readStateIndex:2208; appliedIndex:2207; }","duration":"249.768995ms","start":"2026-09-18T02:22:55.765997Z","end":"2026-09-18T02:22:56.015766Z","steps":["trace[1536426534] 'read index received' (duration: 249.549382ms)","trace[1536426534] 'applied index is now lower than readState.Index' (duration: 218.683µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:22:56.015837Z","caller":"traceutil/trace.go:171","msg":"trace[344808730] transaction","detail":"{read_only:false; response_revision:2123; number_of_response:1; }","duration":"324.509128ms","start":"2026-09-18T02:22:55.691279Z","end":"2026-09-18T02:22:56.015788Z","steps":["trace[344808730] 'process raft request' (duration: 324.334586ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:56.016061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:22:55.69126Z","time spent":"324.675261ms","remote":"127.0.0.1:50692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:22:56.016175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.10612ms","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:22:56.016236Z","caller":"traceutil/trace.go:171","msg":"trace[1735766019] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2123; }","duration":"250.281253ms","start":"2026-09-18T02:22:55.765939Z","end":"2026-09-18T02:22:56.01622Z","steps":["trace[1735766019] 'agreement among raft nodes before linearized reading' (duration: 249.974368ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:56.016482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.490435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-18T02:22:56.016526Z","caller":"traceutil/trace.go:171","msg":"trace[1474842749] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2123; }","duration":"250.574477ms","start":"2026-09-18T02:22:55.765939Z","end":"2026-09-18T02:22:56.016514Z","steps":["trace[1474842749] 'agreement among raft nodes before linearized reading' (duration: 250.477845ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:56.016806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.791273ms","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:22:56.01686Z","caller":"traceutil/trace.go:171","msg":"trace[1329556604] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2123; }","duration":"239.861364ms","start":"2026-09-18T02:22:55.77698Z","end":"2026-09-18T02:22:56.016841Z","steps":["trace[1329556604] 'agreement among raft nodes before linearized reading' (duration: 239.688932ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:56.017461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.093296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:22:56.017552Z","caller":"traceutil/trace.go:171","msg":"trace[531606865] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2123; }","duration":"105.210718ms","start":"2026-09-18T02:22:55.912293Z","end":"2026-09-18T02:22:56.017504Z","steps":["trace[531606865] 'agreement among raft nodes before linearized reading' (duration: 105.094716ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:56.341554Z","caller":"traceutil/trace.go:171","msg":"trace[1037929551] linearizableReadLoop","detail":"{readStateIndex:2210; appliedIndex:2208; }","duration":"298.723061ms","start":"2026-09-18T02:22:56.042757Z","end":"2026-09-18T02:22:56.34148Z","steps":["trace[1037929551] 'read index received' (duration: 63.430451ms)","trace[1037929551] 'applied index is now lower than readState.Index' (duration: 235.29158ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:22:56.341735Z","caller":"traceutil/trace.go:171","msg":"trace[1692862121] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"316.751786ms","start":"2026-09-18T02:22:56.02496Z","end":"2026-09-18T02:22:56.341712Z","steps":["trace[1692862121] 'process raft request' (duration: 237.40226ms)","trace[1692862121] 'compare' (duration: 78.971741ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:22:56.341876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:22:56.024928Z","time spent":"316.857818ms","remote":"127.0.0.1:50692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:22:56.34221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.451981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-18T02:22:56.342274Z","caller":"traceutil/trace.go:171","msg":"trace[181567208] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2125; }","duration":"299.551043ms","start":"2026-09-18T02:22:56.042706Z","end":"2026-09-18T02:22:56.342257Z","steps":["trace[181567208] 'agreement among raft nodes before linearized reading' (duration: 299.36491ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:22:56.342594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.82936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-18T02:22:56.34264Z","caller":"traceutil/trace.go:171","msg":"trace[1408189971] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2125; }","duration":"252.919991ms","start":"2026-09-18T02:22:56.089703Z","end":"2026-09-18T02:22:56.342622Z","steps":["trace[1408189971] 'agreement among raft nodes before linearized reading' (duration: 252.16013ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:56.472588Z","caller":"traceutil/trace.go:171","msg":"trace[526148393] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"125.791846ms","start":"2026-09-18T02:22:56.346731Z","end":"2026-09-18T02:22:56.472523Z","steps":["trace[526148393] 'process raft request' (duration: 116.060058ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:22:56.472759Z","caller":"traceutil/trace.go:171","msg":"trace[2091939896] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"124.086051ms","start":"2026-09-18T02:22:56.34865Z","end":"2026-09-18T02:22:56.472736Z","steps":["trace[2091939896] 'process raft request' (duration: 123.3284ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:01.339031Z","caller":"traceutil/trace.go:171","msg":"trace[286857041] transaction","detail":"{read_only:false; response_revision:2574; number_of_response:1; }","duration":"282.441321ms","start":"2026-09-18T02:24:01.056556Z","end":"2026-09-18T02:24:01.338997Z","steps":["trace[286857041] 'process raft request' (duration: 282.234058ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:01.373928Z","caller":"traceutil/trace.go:171","msg":"trace[1505822935] linearizableReadLoop","detail":"{readStateIndex:2676; appliedIndex:2674; }","duration":"213.122641ms","start":"2026-09-18T02:24:01.160779Z","end":"2026-09-18T02:24:01.373901Z","steps":["trace[1505822935] 'read index received' (duration: 177.998686ms)","trace[1505822935] 'applied index is now lower than readState.Index' (duration: 35.123035ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:24:01.37411Z","caller":"traceutil/trace.go:171","msg":"trace[1005770708] transaction","detail":"{read_only:false; response_revision:2575; number_of_response:1; }","duration":"260.888937ms","start":"2026-09-18T02:24:01.113182Z","end":"2026-09-18T02:24:01.374071Z","steps":["trace[1005770708] 'process raft request' (duration: 252.545642ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:24:01.374184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.357705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-18T02:24:01.374368Z","caller":"traceutil/trace.go:171","msg":"trace[1111109766] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2575; }","duration":"213.565798ms","start":"2026-09-18T02:24:01.160769Z","end":"2026-09-18T02:24:01.374335Z","steps":["trace[1111109766] 'agreement among raft nodes before linearized reading' (duration: 213.234724ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:26.670023Z","caller":"traceutil/trace.go:171","msg":"trace[359932215] transaction","detail":"{read_only:false; response_revision:2713; number_of_response:1; }","duration":"125.376521ms","start":"2026-09-18T02:24:26.544625Z","end":"2026-09-18T02:24:26.670001Z","steps":["trace[359932215] 'process raft request' (duration: 125.019273ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:24:38.256957Z","caller":"traceutil/trace.go:171","msg":"trace[983602145] transaction","detail":"{read_only:false; response_revision:2776; number_of_response:1; }","duration":"104.897377ms","start":"2026-09-18T02:24:38.152028Z","end":"2026-09-18T02:24:38.256926Z","steps":["trace[983602145] 'process raft request' (duration: 104.730059ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:27.202152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.96277ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T02:29:27.202437Z","caller":"traceutil/trace.go:171","msg":"trace[771165287] linearizableReadLoop","detail":"{readStateIndex:4971; appliedIndex:4969; }","duration":"100.435499ms","start":"2026-09-18T02:29:27.10198Z","end":"2026-09-18T02:29:27.202415Z","steps":["trace[771165287] 'read index received' (duration: 20.035201ms)","trace[771165287] 'applied index is now lower than readState.Index' (duration: 80.398158ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:27.202487Z","caller":"traceutil/trace.go:171","msg":"trace[1221219172] transaction","detail":"{read_only:false; response_revision:4779; number_of_response:1; }","duration":"151.694395ms","start":"2026-09-18T02:29:27.050773Z","end":"2026-09-18T02:29:27.202467Z","steps":["trace[1221219172] 'process raft request' (duration: 32.256886ms)","trace[1221219172] 'compare' (duration: 118.814707ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:29:27.20262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.627463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:29:27.202604Z","caller":"traceutil/trace.go:171","msg":"trace[425144130] transaction","detail":"{read_only:false; response_revision:4780; number_of_response:1; }","duration":"129.259367ms","start":"2026-09-18T02:29:27.073312Z","end":"2026-09-18T02:29:27.202572Z","steps":["trace[425144130] 'process raft request' (duration: 128.975081ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:27.202678Z","caller":"traceutil/trace.go:171","msg":"trace[1865925054] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:4780; }","duration":"100.735975ms","start":"2026-09-18T02:29:27.101925Z","end":"2026-09-18T02:29:27.202661Z","steps":["trace[1865925054] 'agreement among raft nodes before linearized reading' (duration: 100.557482ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:27.26473Z","caller":"traceutil/trace.go:171","msg":"trace[148307757] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4780; }","duration":"162.4241ms","start":"2026-09-18T02:29:27.10227Z","end":"2026-09-18T02:29:27.264694Z","steps":["trace[148307757] 'process raft request' (duration: 162.220096ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:27.273715Z","caller":"traceutil/trace.go:171","msg":"trace[1538277530] transaction","detail":"{read_only:false; response_revision:4781; number_of_response:1; }","duration":"143.788267ms","start":"2026-09-18T02:29:27.129888Z","end":"2026-09-18T02:29:27.273677Z","steps":["trace[1538277530] 'process raft request' (duration: 143.246066ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:28.49942Z","caller":"traceutil/trace.go:171","msg":"trace[1981790693] transaction","detail":"{read_only:false; response_revision:4799; number_of_response:1; }","duration":"125.592591ms","start":"2026-09-18T02:29:28.373754Z","end":"2026-09-18T02:29:28.499346Z","steps":["trace[1981790693] 'process raft request' (duration: 63.725444ms)","trace[1981790693] 'compare' (duration: 61.587481ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:28.508897Z","caller":"traceutil/trace.go:171","msg":"trace[1064754750] transaction","detail":"{read_only:false; response_revision:4801; number_of_response:1; }","duration":"131.755565ms","start":"2026-09-18T02:29:28.377079Z","end":"2026-09-18T02:29:28.508834Z","steps":["trace[1064754750] 'process raft request' (duration: 131.554701ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:28.509211Z","caller":"traceutil/trace.go:171","msg":"trace[1807967846] transaction","detail":"{read_only:false; response_revision:4800; number_of_response:1; }","duration":"134.459628ms","start":"2026-09-18T02:29:28.374733Z","end":"2026-09-18T02:29:28.509193Z","steps":["trace[1807967846] 'process raft request' (duration: 133.695082ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:28.684835Z","caller":"traceutil/trace.go:171","msg":"trace[1715507058] transaction","detail":"{read_only:false; response_revision:4803; number_of_response:1; }","duration":"165.776524ms","start":"2026-09-18T02:29:28.519012Z","end":"2026-09-18T02:29:28.684788Z","steps":["trace[1715507058] 'process raft request' (duration: 116.57759ms)","trace[1715507058] 'compare' (duration: 49.0088ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:28.706343Z","caller":"traceutil/trace.go:171","msg":"trace[2035868955] transaction","detail":"{read_only:false; response_revision:4805; number_of_response:1; }","duration":"155.09849ms","start":"2026-09-18T02:29:28.551225Z","end":"2026-09-18T02:29:28.706324Z","steps":["trace[2035868955] 'process raft request' (duration: 155.003539ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:28.706337Z","caller":"traceutil/trace.go:171","msg":"trace[1760647845] transaction","detail":"{read_only:false; response_revision:4804; number_of_response:1; }","duration":"183.806794ms","start":"2026-09-18T02:29:28.522499Z","end":"2026-09-18T02:29:28.706306Z","steps":["trace[1760647845] 'process raft request' (duration: 183.572849ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:29.874676Z","caller":"traceutil/trace.go:171","msg":"trace[929296978] transaction","detail":"{read_only:false; response_revision:4859; number_of_response:1; }","duration":"108.930735ms","start":"2026-09-18T02:29:29.765717Z","end":"2026-09-18T02:29:29.874648Z","steps":["trace[929296978] 'process raft request' (duration: 108.70626ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:35.515919Z","caller":"traceutil/trace.go:171","msg":"trace[1134660538] linearizableReadLoop","detail":"{readStateIndex:5199; appliedIndex:5198; }","duration":"109.366518ms","start":"2026-09-18T02:29:35.406541Z","end":"2026-09-18T02:29:35.515907Z","steps":["trace[1134660538] 'read index received' (duration: 58.678213ms)","trace[1134660538] 'applied index is now lower than readState.Index' (duration: 50.687655ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:35.515906Z","caller":"traceutil/trace.go:171","msg":"trace[168197540] transaction","detail":"{read_only:false; response_revision:5003; number_of_response:1; }","duration":"112.071622ms","start":"2026-09-18T02:29:35.403805Z","end":"2026-09-18T02:29:35.515877Z","steps":["trace[168197540] 'process raft request' (duration: 61.399687ms)","trace[168197540] 'compare' (duration: 50.500771ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:29:35.516437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.862838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-09-18T02:29:35.516533Z","caller":"traceutil/trace.go:171","msg":"trace[689808126] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5004; }","duration":"109.97573ms","start":"2026-09-18T02:29:35.406535Z","end":"2026-09-18T02:29:35.51651Z","steps":["trace[689808126] 'agreement among raft nodes before linearized reading' (duration: 109.491891ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:36.083373Z","caller":"traceutil/trace.go:171","msg":"trace[146093087] linearizableReadLoop","detail":"{readStateIndex:5211; appliedIndex:5210; }","duration":"223.785335ms","start":"2026-09-18T02:29:35.859513Z","end":"2026-09-18T02:29:36.083298Z","steps":["trace[146093087] 'read index received' (duration: 223.343546ms)","trace[146093087] 'applied index is now lower than readState.Index' (duration: 440.459µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:36.083671Z","caller":"traceutil/trace.go:171","msg":"trace[480501857] transaction","detail":"{read_only:false; response_revision:5014; number_of_response:1; }","duration":"224.689563ms","start":"2026-09-18T02:29:35.858909Z","end":"2026-09-18T02:29:36.083599Z","steps":["trace[480501857] 'process raft request' (duration: 224.089491ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:36.08407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.5441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-09-18T02:29:36.084363Z","caller":"traceutil/trace.go:171","msg":"trace[502758775] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:5014; }","duration":"222.939338ms","start":"2026-09-18T02:29:35.861381Z","end":"2026-09-18T02:29:36.08432Z","steps":["trace[502758775] 'agreement among raft nodes before linearized reading' (duration: 222.455238ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:36.084495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.695792ms","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:36.084548Z","caller":"traceutil/trace.go:171","msg":"trace[517208309] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5014; }","duration":"172.797504ms","start":"2026-09-18T02:29:35.911734Z","end":"2026-09-18T02:29:36.084532Z","steps":["trace[517208309] 'agreement among raft nodes before linearized reading' (duration: 172.714383ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:36.084963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.486549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-09-18T02:29:36.085185Z","caller":"traceutil/trace.go:171","msg":"trace[492815991] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:5014; }","duration":"225.5837ms","start":"2026-09-18T02:29:35.8595Z","end":"2026-09-18T02:29:36.085083Z","steps":["trace[492815991] 'agreement among raft nodes before linearized reading' (duration: 224.305285ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:37.128568Z","caller":"traceutil/trace.go:171","msg":"trace[106901701] linearizableReadLoop","detail":"{readStateIndex:5224; appliedIndex:5223; }","duration":"159.303371ms","start":"2026-09-18T02:29:36.969235Z","end":"2026-09-18T02:29:37.128539Z","steps":["trace[106901701] 'read index received' (duration: 134.884338ms)","trace[106901701] 'applied index is now lower than readState.Index' (duration: 24.417393ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:29:37.128903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.621187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-09-18T02:29:37.129057Z","caller":"traceutil/trace.go:171","msg":"trace[434051130] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5026; }","duration":"159.857672ms","start":"2026-09-18T02:29:36.969187Z","end":"2026-09-18T02:29:37.129045Z","steps":["trace[434051130] 'agreement among raft nodes before linearized reading' (duration: 159.433223ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:37.130122Z","caller":"traceutil/trace.go:171","msg":"trace[1430588736] transaction","detail":"{read_only:false; response_revision:5028; number_of_response:1; }","duration":"153.269531ms","start":"2026-09-18T02:29:36.976812Z","end":"2026-09-18T02:29:37.130082Z","steps":["trace[1430588736] 'process raft request' (duration: 153.126028ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:37.130125Z","caller":"traceutil/trace.go:171","msg":"trace[812292336] transaction","detail":"{read_only:false; response_revision:5027; number_of_response:1; }","duration":"154.72181ms","start":"2026-09-18T02:29:36.975362Z","end":"2026-09-18T02:29:37.130084Z","steps":["trace[812292336] 'process raft request' (duration: 154.389954ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:43.176866Z","caller":"traceutil/trace.go:171","msg":"trace[1893621781] linearizableReadLoop","detail":"{readStateIndex:5269; appliedIndex:5268; }","duration":"404.759017ms","start":"2026-09-18T02:29:42.772084Z","end":"2026-09-18T02:29:43.176843Z","steps":["trace[1893621781] 'read index received' (duration: 404.616414ms)","trace[1893621781] 'applied index is now lower than readState.Index' (duration: 141.473µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:43.177224Z","caller":"traceutil/trace.go:171","msg":"trace[1467665443] transaction","detail":"{read_only:false; response_revision:5069; number_of_response:1; }","duration":"410.52126ms","start":"2026-09-18T02:29:42.766682Z","end":"2026-09-18T02:29:43.177204Z","steps":["trace[1467665443] 'process raft request' (duration: 410.000739ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:43.177366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:42.766645Z","time spent":"410.617542ms","remote":"127.0.0.1:50692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:29:43.178294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.187154ms","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:43.18037Z","caller":"traceutil/trace.go:171","msg":"trace[1383433697] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5069; }","duration":"408.292596ms","start":"2026-09-18T02:29:42.772048Z","end":"2026-09-18T02:29:43.180341Z","steps":["trace[1383433697] 'agreement among raft nodes before linearized reading' (duration: 405.502041ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:43.180458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:42.772036Z","time spent":"408.404718ms","remote":"127.0.0.1:50692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-18T02:29:43.202779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.058483ms","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:29:43.202832Z","caller":"traceutil/trace.go:171","msg":"trace[494747045] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5071; }","duration":"430.131355ms","start":"2026-09-18T02:29:42.772686Z","end":"2026-09-18T02:29:43.202817Z","steps":["trace[494747045] 'agreement among raft nodes before linearized reading' (duration: 429.974181ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:43.202865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:42.772675Z","time spent":"430.181215ms","remote":"127.0.0.1:50692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-18T02:29:43.203043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.907913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T02:29:43.20309Z","caller":"traceutil/trace.go:171","msg":"trace[1314905610] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:5071; }","duration":"241.993435ms","start":"2026-09-18T02:29:42.961086Z","end":"2026-09-18T02:29:43.203079Z","steps":["trace[1314905610] 'agreement among raft nodes before linearized reading' (duration: 241.873022ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:43.20331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.854227ms","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:29:43.203345Z","caller":"traceutil/trace.go:171","msg":"trace[1211988962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5071; }","duration":"406.930979ms","start":"2026-09-18T02:29:42.796405Z","end":"2026-09-18T02:29:43.203336Z","steps":["trace[1211988962] 'agreement among raft nodes before linearized reading' (duration: 406.834587ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:43.203368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:42.796382Z","time spent":"406.980139ms","remote":"127.0.0.1:50692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-18T02:29:43.524826Z","caller":"traceutil/trace.go:171","msg":"trace[257784087] transaction","detail":"{read_only:false; response_revision:5073; number_of_response:1; }","duration":"315.153651ms","start":"2026-09-18T02:29:43.209635Z","end":"2026-09-18T02:29:43.524788Z","steps":["trace[257784087] 'process raft request' (duration: 231.756092ms)","trace[257784087] 'compare' (duration: 82.987051ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:29:43.525383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:43.20951Z","time spent":"315.393586ms","remote":"127.0.0.1:50692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:29:43.591491Z","caller":"traceutil/trace.go:171","msg":"trace[538080288] transaction","detail":"{read_only:false; response_revision:5074; number_of_response:1; }","duration":"381.640537ms","start":"2026-09-18T02:29:43.209817Z","end":"2026-09-18T02:29:43.591458Z","steps":["trace[538080288] 'process raft request' (duration: 381.395132ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:43.591678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:43.209805Z","time spent":"381.78265ms","remote":"127.0.0.1:50692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:29:43.591794Z","caller":"traceutil/trace.go:171","msg":"trace[1870412794] linearizableReadLoop","detail":"{readStateIndex:5274; appliedIndex:5272; }","duration":"367.53858ms","start":"2026-09-18T02:29:43.224231Z","end":"2026-09-18T02:29:43.591769Z","steps":["trace[1870412794] 'read index received' (duration: 217.066865ms)","trace[1870412794] 'applied index is now lower than readState.Index' (duration: 150.469375ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:43.591904Z","caller":"traceutil/trace.go:171","msg":"trace[2097957538] transaction","detail":"{read_only:false; response_revision:5076; number_of_response:1; }","duration":"235.784492ms","start":"2026-09-18T02:29:43.356102Z","end":"2026-09-18T02:29:43.591886Z","steps":["trace[2097957538] 'process raft request' (duration: 235.602728ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:43.591899Z","caller":"traceutil/trace.go:171","msg":"trace[1095115285] transaction","detail":"{read_only:false; response_revision:5075; number_of_response:1; }","duration":"247.241337ms","start":"2026-09-18T02:29:43.344597Z","end":"2026-09-18T02:29:43.591838Z","steps":["trace[1095115285] 'process raft request' (duration: 246.784718ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:43.592133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.861854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-09-18T02:29:43.592189Z","caller":"traceutil/trace.go:171","msg":"trace[399539779] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5076; }","duration":"345.946756ms","start":"2026-09-18T02:29:43.246213Z","end":"2026-09-18T02:29:43.59216Z","steps":["trace[399539779] 'agreement among raft nodes before linearized reading' (duration: 345.801533ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:43.592227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:43.24618Z","time spent":"346.038338ms","remote":"127.0.0.1:50692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":595,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-09-18T02:29:43.592291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.557378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-18T02:29:43.592344Z","caller":"traceutil/trace.go:171","msg":"trace[173125992] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5076; }","duration":"204.613489ms","start":"2026-09-18T02:29:43.387717Z","end":"2026-09-18T02:29:43.59233Z","steps":["trace[173125992] 'agreement among raft nodes before linearized reading' (duration: 204.467577ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:43.592414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.303738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-09-18T02:29:43.592442Z","caller":"traceutil/trace.go:171","msg":"trace[1705502297] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5076; }","duration":"249.377128ms","start":"2026-09-18T02:29:43.343055Z","end":"2026-09-18T02:29:43.592432Z","steps":["trace[1705502297] 'agreement among raft nodes before linearized reading' (duration: 249.292887ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:43.592571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.345416ms","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:29:43.592602Z","caller":"traceutil/trace.go:171","msg":"trace[2140694536] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5076; }","duration":"368.417138ms","start":"2026-09-18T02:29:43.224176Z","end":"2026-09-18T02:29:43.592593Z","steps":["trace[2140694536] 'agreement among raft nodes before linearized reading' (duration: 368.313545ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:43.592627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:43.224155Z","time spent":"368.464798ms","remote":"127.0.0.1:50692","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:29:43.5927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.772654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:29:43.592832Z","caller":"traceutil/trace.go:171","msg":"trace[1962395805] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5076; }","duration":"284.951058ms","start":"2026-09-18T02:29:43.307871Z","end":"2026-09-18T02:29:43.592822Z","steps":["trace[1962395805] 'agreement among raft nodes before linearized reading' (duration: 284.760344ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:44.552448Z","caller":"traceutil/trace.go:171","msg":"trace[1236880653] transaction","detail":"{read_only:false; response_revision:5087; number_of_response:1; }","duration":"198.547316ms","start":"2026-09-18T02:29:44.353864Z","end":"2026-09-18T02:29:44.552411Z","steps":["trace[1236880653] 'process raft request' (duration: 198.329892ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:44.600873Z","caller":"traceutil/trace.go:171","msg":"trace[1686156285] linearizableReadLoop","detail":"{readStateIndex:5288; appliedIndex:5286; }","duration":"188.686392ms","start":"2026-09-18T02:29:44.41216Z","end":"2026-09-18T02:29:44.600846Z","steps":["trace[1686156285] 'read index received' (duration: 140.120779ms)","trace[1686156285] 'applied index is now lower than readState.Index' (duration: 48.564443ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:44.601068Z","caller":"traceutil/trace.go:171","msg":"trace[1392993056] transaction","detail":"{read_only:false; response_revision:5088; number_of_response:1; }","duration":"234.560622ms","start":"2026-09-18T02:29:44.366484Z","end":"2026-09-18T02:29:44.601045Z","steps":["trace[1392993056] 'process raft request' (duration: 234.188945ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:44.601207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.178072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T02:29:44.601248Z","caller":"traceutil/trace.go:171","msg":"trace[509954234] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:5088; }","duration":"137.301264ms","start":"2026-09-18T02:29:44.46393Z","end":"2026-09-18T02:29:44.601231Z","steps":["trace[509954234] 'agreement among raft nodes before linearized reading' (duration: 137.169061ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:44.601385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.217693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-18T02:29:44.601441Z","caller":"traceutil/trace.go:171","msg":"trace[878174738] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5088; }","duration":"189.315535ms","start":"2026-09-18T02:29:44.412106Z","end":"2026-09-18T02:29:44.601422Z","steps":["trace[878174738] 'agreement among raft nodes before linearized reading' (duration: 188.925567ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:47.376245Z","caller":"traceutil/trace.go:171","msg":"trace[2105083596] transaction","detail":"{read_only:false; response_revision:5111; number_of_response:1; }","duration":"164.879845ms","start":"2026-09-18T02:29:47.211334Z","end":"2026-09-18T02:29:47.376214Z","steps":["trace[2105083596] 'process raft request' (duration: 164.66335ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:47.412703Z","caller":"traceutil/trace.go:171","msg":"trace[1584517651] linearizableReadLoop","detail":"{readStateIndex:5313; appliedIndex:5311; }","duration":"175.785878ms","start":"2026-09-18T02:29:47.236893Z","end":"2026-09-18T02:29:47.412679Z","steps":["trace[1584517651] 'read index received' (duration: 139.163692ms)","trace[1584517651] 'applied index is now lower than readState.Index' (duration: 36.621456ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:47.412815Z","caller":"traceutil/trace.go:171","msg":"trace[58830862] transaction","detail":"{read_only:false; response_revision:5112; number_of_response:1; }","duration":"192.127057ms","start":"2026-09-18T02:29:47.220629Z","end":"2026-09-18T02:29:47.412756Z","steps":["trace[58830862] 'process raft request' (duration: 191.866382ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:47.412895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.973801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:29:47.412942Z","caller":"traceutil/trace.go:171","msg":"trace[2113711608] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:5113; }","duration":"176.064924ms","start":"2026-09-18T02:29:47.236849Z","end":"2026-09-18T02:29:47.412914Z","steps":["trace[2113711608] 'agreement among raft nodes before linearized reading' (duration: 175.964082ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:47.413036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.135406ms","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:29:47.413075Z","caller":"traceutil/trace.go:171","msg":"trace[928077951] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5113; }","duration":"128.217689ms","start":"2026-09-18T02:29:47.284848Z","end":"2026-09-18T02:29:47.413066Z","steps":["trace[928077951] 'agreement among raft nodes before linearized reading' (duration: 127.997484ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:47.413486Z","caller":"traceutil/trace.go:171","msg":"trace[1477419864] transaction","detail":"{read_only:false; response_revision:5113; number_of_response:1; }","duration":"169.138568ms","start":"2026-09-18T02:29:47.243633Z","end":"2026-09-18T02:29:47.412771Z","steps":["trace[1477419864] 'process raft request' (duration: 169.014025ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:47.674036Z","caller":"traceutil/trace.go:171","msg":"trace[1345520293] linearizableReadLoop","detail":"{readStateIndex:5317; appliedIndex:5316; }","duration":"122.429205ms","start":"2026-09-18T02:29:47.551571Z","end":"2026-09-18T02:29:47.674Z","steps":["trace[1345520293] 'read index received' (duration: 122.110179ms)","trace[1345520293] 'applied index is now lower than readState.Index' (duration: 317.976µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:47.674052Z","caller":"traceutil/trace.go:171","msg":"trace[211517783] transaction","detail":"{read_only:false; response_revision:5116; number_of_response:1; }","duration":"180.222126ms","start":"2026-09-18T02:29:47.493801Z","end":"2026-09-18T02:29:47.674023Z","steps":["trace[211517783] 'process raft request' (duration: 179.9444ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:47.674365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.70256ms","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:29:47.674417Z","caller":"traceutil/trace.go:171","msg":"trace[321405068] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5116; }","duration":"122.882234ms","start":"2026-09-18T02:29:47.551518Z","end":"2026-09-18T02:29:47.6744Z","steps":["trace[321405068] 'agreement among raft nodes before linearized reading' (duration: 122.629029ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:48.409757Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2828} {"level":"info","ts":"2026-09-18T02:29:48.732269Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2828,"took":"321.264236ms","hash":2478505877,"current-db-size-bytes":51224576,"current-db-size":"51 MB","current-db-size-in-use-bytes":27250688,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-18T02:29:48.732362Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2478505877,"revision":2828,"compact-revision":-1} {"level":"info","ts":"2026-09-18T02:29:53.823603Z","caller":"traceutil/trace.go:171","msg":"trace[1810951258] transaction","detail":"{read_only:false; response_revision:5248; number_of_response:1; }","duration":"385.728087ms","start":"2026-09-18T02:29:53.437822Z","end":"2026-09-18T02:29:53.82355Z","steps":["trace[1810951258] 'process raft request' (duration: 385.672166ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:29:53.823672Z","caller":"traceutil/trace.go:171","msg":"trace[1662004389] transaction","detail":"{read_only:false; response_revision:5247; number_of_response:1; }","duration":"387.591923ms","start":"2026-09-18T02:29:53.436002Z","end":"2026-09-18T02:29:53.823594Z","steps":["trace[1662004389] 'process raft request' (duration: 387.307068ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:53.823825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:53.437782Z","time spent":"385.935791ms","remote":"127.0.0.1:50692","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:29:53.82395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:53.435972Z","time spent":"387.806608ms","remote":"127.0.0.1:50692","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:29:53.839716Z","caller":"traceutil/trace.go:171","msg":"trace[2037358070] linearizableReadLoop","detail":"{readStateIndex:5454; appliedIndex:5453; }","duration":"350.728697ms","start":"2026-09-18T02:29:53.488956Z","end":"2026-09-18T02:29:53.839685Z","steps":["trace[2037358070] 'read index received' (duration: 335.098613ms)","trace[2037358070] 'applied index is now lower than readState.Index' (duration: 15.628234ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:29:53.839864Z","caller":"traceutil/trace.go:171","msg":"trace[1530462311] transaction","detail":"{read_only:false; response_revision:5249; number_of_response:1; }","duration":"365.072515ms","start":"2026-09-18T02:29:53.474771Z","end":"2026-09-18T02:29:53.839844Z","steps":["trace[1530462311] 'process raft request' (duration: 364.708668ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:53.840045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:53.474694Z","time spent":"365.256349ms","remote":"127.0.0.1:50588","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T02:29:53.840094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.819312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-09-18T02:29:53.840208Z","caller":"traceutil/trace.go:171","msg":"trace[902006044] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5249; }","duration":"326.991925ms","start":"2026-09-18T02:29:53.513183Z","end":"2026-09-18T02:29:53.840175Z","steps":["trace[902006044] 'agreement among raft nodes before linearized reading' (duration: 326.70104ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:53.840276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:53.51316Z","time spent":"327.102707ms","remote":"127.0.0.1:50692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":583,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-09-18T02:29:53.840547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.559603ms","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:53.840642Z","caller":"traceutil/trace.go:171","msg":"trace[931336842] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5249; }","duration":"351.728656ms","start":"2026-09-18T02:29:53.488893Z","end":"2026-09-18T02:29:53.840622Z","steps":["trace[931336842] 'agreement among raft nodes before linearized reading' (duration: 351.523712ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:29:53.840693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:29:53.488852Z","time spent":"351.830968ms","remote":"127.0.0.1:50692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-18T02:30:05.894534Z","caller":"traceutil/trace.go:171","msg":"trace[1126261118] linearizableReadLoop","detail":"{readStateIndex:5565; appliedIndex:5561; }","duration":"165.675112ms","start":"2026-09-18T02:30:05.728826Z","end":"2026-09-18T02:30:05.894501Z","steps":["trace[1126261118] 'read index received' (duration: 144.653298ms)","trace[1126261118] 'applied index is now lower than readState.Index' (duration: 21.020734ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:30:05.894618Z","caller":"traceutil/trace.go:171","msg":"trace[1418386997] transaction","detail":"{read_only:false; response_revision:5354; number_of_response:1; }","duration":"235.780968ms","start":"2026-09-18T02:30:05.658811Z","end":"2026-09-18T02:30:05.894592Z","steps":["trace[1418386997] 'process raft request' (duration: 214.705503ms)","trace[1418386997] 'compare' (duration: 20.470873ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:30:05.894642Z","caller":"traceutil/trace.go:171","msg":"trace[635951453] transaction","detail":"{read_only:false; response_revision:5357; number_of_response:1; }","duration":"235.682076ms","start":"2026-09-18T02:30:05.658928Z","end":"2026-09-18T02:30:05.89461Z","steps":["trace[635951453] 'process raft request' (duration: 235.519233ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:05.894633Z","caller":"traceutil/trace.go:171","msg":"trace[766539931] transaction","detail":"{read_only:false; response_revision:5356; number_of_response:1; }","duration":"235.701137ms","start":"2026-09-18T02:30:05.658894Z","end":"2026-09-18T02:30:05.894595Z","steps":["trace[766539931] 'process raft request' (duration: 235.495083ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:05.894747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.891946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:30:05.894749Z","caller":"traceutil/trace.go:171","msg":"trace[1875784829] transaction","detail":"{read_only:false; response_revision:5355; number_of_response:1; }","duration":"235.708157ms","start":"2026-09-18T02:30:05.658878Z","end":"2026-09-18T02:30:05.894587Z","steps":["trace[1875784829] 'process raft request' (duration: 235.410261ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:05.894843Z","caller":"traceutil/trace.go:171","msg":"trace[1283360243] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:5357; }","duration":"166.088939ms","start":"2026-09-18T02:30:05.728737Z","end":"2026-09-18T02:30:05.894825Z","steps":["trace[1283360243] 'agreement among raft nodes before linearized reading' (duration: 165.931856ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:06.100567Z","caller":"traceutil/trace.go:171","msg":"trace[1047190851] linearizableReadLoop","detail":"{readStateIndex:5568; appliedIndex:5566; }","duration":"188.412716ms","start":"2026-09-18T02:30:05.912123Z","end":"2026-09-18T02:30:06.100535Z","steps":["trace[1047190851] 'read index received' (duration: 11.892299ms)","trace[1047190851] 'applied index is now lower than readState.Index' (duration: 176.519067ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:30:06.100606Z","caller":"traceutil/trace.go:171","msg":"trace[713304946] transaction","detail":"{read_only:false; response_revision:5360; number_of_response:1; }","duration":"189.6589ms","start":"2026-09-18T02:30:05.910925Z","end":"2026-09-18T02:30:06.100584Z","steps":["trace[713304946] 'process raft request' (duration: 189.388615ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:06.100741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.60126ms","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:06.100811Z","caller":"traceutil/trace.go:171","msg":"trace[8285370] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5360; }","duration":"188.724702ms","start":"2026-09-18T02:30:05.912076Z","end":"2026-09-18T02:30:06.1008Z","steps":["trace[8285370] 'agreement among raft nodes before linearized reading' (duration: 188.60661ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:06.100983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.732852ms","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:06.101039Z","caller":"traceutil/trace.go:171","msg":"trace[865059599] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5360; }","duration":"150.811864ms","start":"2026-09-18T02:30:05.950212Z","end":"2026-09-18T02:30:06.101024Z","steps":["trace[865059599] 'agreement among raft nodes before linearized reading' (duration: 150.674111ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:06.101169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.897786ms","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:06.101226Z","caller":"traceutil/trace.go:171","msg":"trace[1741413263] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5360; }","duration":"150.982587ms","start":"2026-09-18T02:30:05.950229Z","end":"2026-09-18T02:30:06.101211Z","steps":["trace[1741413263] 'agreement among raft nodes before linearized reading' (duration: 150.791863ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:06.101258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.738141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"warn","ts":"2026-09-18T02:30:06.101361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.901442ms","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:30:06.101451Z","caller":"traceutil/trace.go:171","msg":"trace[1004700554] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5360; }","duration":"156.018834ms","start":"2026-09-18T02:30:05.945401Z","end":"2026-09-18T02:30:06.10142Z","steps":["trace[1004700554] 'agreement among raft nodes before linearized reading' (duration: 155.378152ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:06.101377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.185201ms","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:30:06.101608Z","caller":"traceutil/trace.go:171","msg":"trace[109807293] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5360; }","duration":"151.471766ms","start":"2026-09-18T02:30:05.950108Z","end":"2026-09-18T02:30:06.10158Z","steps":["trace[109807293] 'agreement among raft nodes before linearized reading' (duration: 150.838444ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:06.101888Z","caller":"traceutil/trace.go:171","msg":"trace[462492417] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5360; }","duration":"152.834223ms","start":"2026-09-18T02:30:05.948455Z","end":"2026-09-18T02:30:06.101289Z","steps":["trace[462492417] 'agreement among raft nodes before linearized reading' (duration: 152.606898ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:30:06.101794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.801653ms","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:06.102351Z","caller":"traceutil/trace.go:171","msg":"trace[349906135] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5360; }","duration":"140.158049ms","start":"2026-09-18T02:30:05.961956Z","end":"2026-09-18T02:30:06.102114Z","steps":["trace[349906135] 'agreement among raft nodes before linearized reading' (duration: 139.045628ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:43.104009Z","caller":"traceutil/trace.go:171","msg":"trace[524111419] transaction","detail":"{read_only:false; response_revision:5687; number_of_response:1; }","duration":"162.426322ms","start":"2026-09-18T02:30:42.941547Z","end":"2026-09-18T02:30:43.103974Z","steps":["trace[524111419] 'process raft request' (duration: 162.184568ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:43.854198Z","caller":"traceutil/trace.go:171","msg":"trace[1924563464] linearizableReadLoop","detail":"{readStateIndex:5907; appliedIndex:5906; }","duration":"158.526579ms","start":"2026-09-18T02:30:43.69565Z","end":"2026-09-18T02:30:43.854176Z","steps":["trace[1924563464] 'read index received' (duration: 158.275014ms)","trace[1924563464] 'applied index is now lower than readState.Index' (duration: 250.795µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T02:30:43.854414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.725833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T02:30:43.854451Z","caller":"traceutil/trace.go:171","msg":"trace[624081271] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:5689; }","duration":"158.853525ms","start":"2026-09-18T02:30:43.695583Z","end":"2026-09-18T02:30:43.854436Z","steps":["trace[624081271] 'agreement among raft nodes before linearized reading' (duration: 158.731752ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:30:43.854537Z","caller":"traceutil/trace.go:171","msg":"trace[865293847] transaction","detail":"{read_only:false; response_revision:5689; number_of_response:1; }","duration":"172.56391ms","start":"2026-09-18T02:30:43.681952Z","end":"2026-09-18T02:30:43.854516Z","steps":["trace[865293847] 'process raft request' (duration: 172.070341ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:34:48.416189Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5125} {"level":"info","ts":"2026-09-18T02:34:48.493572Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5125,"took":"75.937901ms","hash":2431954807,"current-db-size-bytes":51224576,"current-db-size":"51 MB","current-db-size-in-use-bytes":19337216,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-18T02:34:48.493746Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2431954807,"revision":5125,"compact-revision":2828} {"level":"info","ts":"2026-09-18T02:35:52.000911Z","caller":"traceutil/trace.go:171","msg":"trace[771616780] linearizableReadLoop","detail":"{readStateIndex:7957; appliedIndex:7956; }","duration":"284.311916ms","start":"2026-09-18T02:35:51.716577Z","end":"2026-09-18T02:35:52.000889Z","steps":["trace[771616780] 'read index received' (duration: 284.13483ms)","trace[771616780] 'applied index is now lower than readState.Index' (duration: 176.246µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:35:52.000966Z","caller":"traceutil/trace.go:171","msg":"trace[776375288] transaction","detail":"{read_only:false; response_revision:7668; number_of_response:1; }","duration":"284.910185ms","start":"2026-09-18T02:35:51.716024Z","end":"2026-09-18T02:35:52.000934Z","steps":["trace[776375288] 'process raft request' (duration: 284.74114ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:35:52.001118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.516182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.203\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-18T02:35:52.00117Z","caller":"traceutil/trace.go:171","msg":"trace[760566867] range","detail":"{range_begin:/registry/masterleases/162.253.55.203; range_end:; response_count:1; response_revision:7668; }","duration":"284.625346ms","start":"2026-09-18T02:35:51.716536Z","end":"2026-09-18T02:35:52.001161Z","steps":["trace[760566867] 'agreement among raft nodes before linearized reading' (duration: 284.46149ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:35:52.001163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.868193ms","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:52.001201Z","caller":"traceutil/trace.go:171","msg":"trace[859615819] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7668; }","duration":"248.960727ms","start":"2026-09-18T02:35:51.75223Z","end":"2026-09-18T02:35:52.001191Z","steps":["trace[859615819] 'agreement among raft nodes before linearized reading' (duration: 248.839713ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:35:52.001262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.477387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-09-18T02:35:52.001367Z","caller":"traceutil/trace.go:171","msg":"trace[860306799] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7668; }","duration":"282.598021ms","start":"2026-09-18T02:35:51.718745Z","end":"2026-09-18T02:35:52.001343Z","steps":["trace[860306799] 'agreement among raft nodes before linearized reading' (duration: 282.297761ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T02:37:04.851368Z","caller":"traceutil/trace.go:171","msg":"trace[1925054012] linearizableReadLoop","detail":"{readStateIndex:8339; appliedIndex:8338; }","duration":"299.498672ms","start":"2026-09-18T02:37:04.551841Z","end":"2026-09-18T02:37:04.851339Z","steps":["trace[1925054012] 'read index received' (duration: 299.275605ms)","trace[1925054012] 'applied index is now lower than readState.Index' (duration: 221.757µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T02:37:04.85153Z","caller":"traceutil/trace.go:171","msg":"trace[1960666816] transaction","detail":"{read_only:false; response_revision:8035; number_of_response:1; }","duration":"320.710137ms","start":"2026-09-18T02:37:04.530792Z","end":"2026-09-18T02:37:04.851502Z","steps":["trace[1960666816] 'process raft request' (duration: 320.328236ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:37:04.851663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.807001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"warn","ts":"2026-09-18T02:37:04.851672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T02:37:04.530775Z","time spent":"320.812909ms","remote":"127.0.0.1:50692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T02:37:04.851704Z","caller":"traceutil/trace.go:171","msg":"trace[953750968] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:8035; }","duration":"299.885673ms","start":"2026-09-18T02:37:04.551808Z","end":"2026-09-18T02:37:04.851693Z","steps":["trace[953750968] 'agreement among raft nodes before linearized reading' (duration: 299.687838ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:37:04.851869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.9214ms","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:37:04.851917Z","caller":"traceutil/trace.go:171","msg":"trace[1900366548] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8035; }","duration":"143.007723ms","start":"2026-09-18T02:37:04.708895Z","end":"2026-09-18T02:37:04.851903Z","steps":["trace[1900366548] 'agreement among raft nodes before linearized reading' (duration: 142.721754ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T02:37:04.851968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.541245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-09-18T02:37:04.852019Z","caller":"traceutil/trace.go:171","msg":"trace[2053530204] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:8035; }","duration":"296.623877ms","start":"2026-09-18T02:37:04.555384Z","end":"2026-09-18T02:37:04.852007Z","steps":["trace[2053530204] 'agreement among raft nodes before linearized reading' (duration: 296.198804ms)"],"step_count":1}