{"level":"warn","ts":"2026-04-07T05:51:51.996299Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T05:51:51.996391Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.102: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://199.204.45.102:2380","--initial-cluster=instance=https://199.204.45.102:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.102:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.102: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-04-07T05:51:51.996457Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T05:51:51.996471Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.102:2380"]} {"level":"info","ts":"2026-04-07T05:51:51.996488Z","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-04-07T05:51:51.997045Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.102:2379"]} {"level":"info","ts":"2026-04-07T05:51:51.997111Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.102:2380"],"listen-peer-urls":["https://199.204.45.102:2380"],"advertise-client-urls":["https://199.204.45.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.102: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-04-07T05:51:52.002056Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.744478ms"} {"level":"info","ts":"2026-04-07T05:51:52.008275Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6e7960f761c1028e","cluster-id":"502e2b31b867adf"} {"level":"info","ts":"2026-04-07T05:51:52.008325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T05:51:52.008341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became follower at term 0"} {"level":"info","ts":"2026-04-07T05:51:52.008356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6e7960f761c1028e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T05:51:52.008366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became follower at term 1"} {"level":"info","ts":"2026-04-07T05:51:52.008393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e switched to configuration voters=(7960500431967289998)"} {"level":"warn","ts":"2026-04-07T05:51:52.020467Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T05:51:52.025029Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T05:51:52.026455Z","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-04-07T05:51:52.029608Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6e7960f761c1028e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T05:51:52.029856Z","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-04-07T05:51:52.029918Z","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-04-07T05:51:52.02993Z","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-04-07T05:51:52.029972Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6e7960f761c1028e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T05:51:52.030737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e switched to configuration voters=(7960500431967289998)"} {"level":"info","ts":"2026-04-07T05:51:52.030931Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"502e2b31b867adf","local-member-id":"6e7960f761c1028e","added-peer-id":"6e7960f761c1028e","added-peer-peer-urls":["https://199.204.45.102:2380"]} {"level":"info","ts":"2026-04-07T05:51:52.035948Z","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-04-07T05:51:52.03608Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.102:2380"} {"level":"info","ts":"2026-04-07T05:51:52.036133Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.102:2380"} {"level":"info","ts":"2026-04-07T05:51:52.036548Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6e7960f761c1028e","initial-advertise-peer-urls":["https://199.204.45.102:2380"],"listen-peer-urls":["https://199.204.45.102:2380"],"advertise-client-urls":["https://199.204.45.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T05:51:52.0366Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T05:51:52.809264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T05:51:52.809334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T05:51:52.80938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e received MsgPreVoteResp from 6e7960f761c1028e at term 1"} {"level":"info","ts":"2026-04-07T05:51:52.809517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became candidate at term 2"} {"level":"info","ts":"2026-04-07T05:51:52.809541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e received MsgVoteResp from 6e7960f761c1028e at term 2"} {"level":"info","ts":"2026-04-07T05:51:52.809587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became leader at term 2"} {"level":"info","ts":"2026-04-07T05:51:52.809612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6e7960f761c1028e elected leader 6e7960f761c1028e at term 2"} {"level":"info","ts":"2026-04-07T05:51:52.810984Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:51:52.811782Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6e7960f761c1028e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.102:2379]}","request-path":"/0/members/6e7960f761c1028e/attributes","cluster-id":"502e2b31b867adf","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T05:51:52.811834Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T05:51:52.8118Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T05:51:52.812191Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T05:51:52.812264Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T05:51:52.812376Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"502e2b31b867adf","local-member-id":"6e7960f761c1028e","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:51:52.812656Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:51:52.812721Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:51:52.813695Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T05:51:52.818886Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.102:2379"} {"level":"info","ts":"2026-04-07T05:52:12.891744Z","caller":"traceutil/trace.go:171","msg":"trace[237727947] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"154.26032ms","start":"2026-04-07T05:52:12.737465Z","end":"2026-04-07T05:52:12.891725Z","steps":["trace[237727947] 'process raft request' (duration: 154.152337ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.405991Z","caller":"traceutil/trace.go:171","msg":"trace[106164338] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"189.809298ms","start":"2026-04-07T05:52:22.216161Z","end":"2026-04-07T05:52:22.405971Z","steps":["trace[106164338] 'process raft request' (duration: 188.640758ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.435629Z","caller":"traceutil/trace.go:171","msg":"trace[1824905868] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"202.298987ms","start":"2026-04-07T05:52:22.233304Z","end":"2026-04-07T05:52:22.435603Z","steps":["trace[1824905868] 'process raft request' (duration: 201.987098ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.43576Z","caller":"traceutil/trace.go:171","msg":"trace[554618055] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"196.347646ms","start":"2026-04-07T05:52:22.239377Z","end":"2026-04-07T05:52:22.435724Z","steps":["trace[554618055] 'process raft request' (duration: 196.032317ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.435846Z","caller":"traceutil/trace.go:171","msg":"trace[1047843628] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"202.519362ms","start":"2026-04-07T05:52:22.233304Z","end":"2026-04-07T05:52:22.435824Z","steps":["trace[1047843628] 'process raft request' (duration: 202.029159ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.435921Z","caller":"traceutil/trace.go:171","msg":"trace[1028926866] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"195.468141ms","start":"2026-04-07T05:52:22.240445Z","end":"2026-04-07T05:52:22.435913Z","steps":["trace[1028926866] 'process raft request' (duration: 195.002599ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.435962Z","caller":"traceutil/trace.go:171","msg":"trace[1093371290] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"200.94839ms","start":"2026-04-07T05:52:22.235001Z","end":"2026-04-07T05:52:22.435949Z","steps":["trace[1093371290] 'process raft request' (duration: 200.376764ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.435795Z","caller":"traceutil/trace.go:171","msg":"trace[530294318] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"210.489786ms","start":"2026-04-07T05:52:22.225296Z","end":"2026-04-07T05:52:22.435785Z","steps":["trace[530294318] 'process raft request' (duration: 209.936961ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.435912Z","caller":"traceutil/trace.go:171","msg":"trace[200661080] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"167.414455ms","start":"2026-04-07T05:52:22.268474Z","end":"2026-04-07T05:52:22.435888Z","steps":["trace[200661080] 'process raft request' (duration: 167.107476ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.435649Z","caller":"traceutil/trace.go:171","msg":"trace[406370858] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"210.452406ms","start":"2026-04-07T05:52:22.225173Z","end":"2026-04-07T05:52:22.435626Z","steps":["trace[406370858] 'process raft request' (duration: 209.922092ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.435902Z","caller":"traceutil/trace.go:171","msg":"trace[1878650758] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"175.42776ms","start":"2026-04-07T05:52:22.260385Z","end":"2026-04-07T05:52:22.435812Z","steps":["trace[1878650758] 'process raft request' (duration: 175.104102ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.436043Z","caller":"traceutil/trace.go:171","msg":"trace[914178571] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"157.489388ms","start":"2026-04-07T05:52:22.278546Z","end":"2026-04-07T05:52:22.436035Z","steps":["trace[914178571] 'process raft request' (duration: 157.092537ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.628931Z","caller":"traceutil/trace.go:171","msg":"trace[2072502198] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"182.298046ms","start":"2026-04-07T05:52:22.446607Z","end":"2026-04-07T05:52:22.628905Z","steps":["trace[2072502198] 'process raft request' (duration: 182.07146ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.628996Z","caller":"traceutil/trace.go:171","msg":"trace[1514062106] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"134.738624ms","start":"2026-04-07T05:52:22.494234Z","end":"2026-04-07T05:52:22.628972Z","steps":["trace[1514062106] 'process raft request' (duration: 134.702553ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.629057Z","caller":"traceutil/trace.go:171","msg":"trace[839797525] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"179.83534ms","start":"2026-04-07T05:52:22.449214Z","end":"2026-04-07T05:52:22.629049Z","steps":["trace[839797525] 'process raft request' (duration: 179.491251ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.629053Z","caller":"traceutil/trace.go:171","msg":"trace[1450835795] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"183.801317ms","start":"2026-04-07T05:52:22.44522Z","end":"2026-04-07T05:52:22.629022Z","steps":["trace[1450835795] 'process raft request' (duration: 183.412226ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.628943Z","caller":"traceutil/trace.go:171","msg":"trace[1881612792] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"186.587471ms","start":"2026-04-07T05:52:22.44229Z","end":"2026-04-07T05:52:22.628877Z","steps":["trace[1881612792] 'process raft request' (duration: 186.301054ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.629182Z","caller":"traceutil/trace.go:171","msg":"trace[2096377608] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"174.68824ms","start":"2026-04-07T05:52:22.454485Z","end":"2026-04-07T05:52:22.629173Z","steps":["trace[2096377608] 'process raft request' (duration: 174.323791ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.629026Z","caller":"traceutil/trace.go:171","msg":"trace[2038406836] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"178.338499ms","start":"2026-04-07T05:52:22.450678Z","end":"2026-04-07T05:52:22.629016Z","steps":["trace[2038406836] 'process raft request' (duration: 178.064482ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.629237Z","caller":"traceutil/trace.go:171","msg":"trace[660451363] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"168.331549ms","start":"2026-04-07T05:52:22.460897Z","end":"2026-04-07T05:52:22.629228Z","steps":["trace[660451363] 'process raft request' (duration: 167.98665ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.629333Z","caller":"traceutil/trace.go:171","msg":"trace[178883718] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"186.709705ms","start":"2026-04-07T05:52:22.441967Z","end":"2026-04-07T05:52:22.628677Z","steps":["trace[178883718] 'process raft request' (duration: 170.067176ms)","trace[178883718] 'compare' (duration: 16.400222ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:52:22.640366Z","caller":"traceutil/trace.go:171","msg":"trace[352374831] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"113.775749ms","start":"2026-04-07T05:52:22.526572Z","end":"2026-04-07T05:52:22.640348Z","steps":["trace[352374831] 'process raft request' (duration: 113.713747ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.640576Z","caller":"traceutil/trace.go:171","msg":"trace[83522895] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"119.317438ms","start":"2026-04-07T05:52:22.521249Z","end":"2026-04-07T05:52:22.640566Z","steps":["trace[83522895] 'process raft request' (duration: 118.850975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:22.863415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.188872ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:52:22.863686Z","caller":"traceutil/trace.go:171","msg":"trace[1775798486] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"212.491761ms","start":"2026-04-07T05:52:22.651161Z","end":"2026-04-07T05:52:22.863652Z","steps":["trace[1775798486] 'process raft request' (duration: 111.272781ms)","trace[1775798486] 'compare' (duration: 100.058458ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:52:22.863939Z","caller":"traceutil/trace.go:171","msg":"trace[1108379239] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"206.291484ms","start":"2026-04-07T05:52:22.657613Z","end":"2026-04-07T05:52:22.863904Z","steps":["trace[1108379239] 'process raft request' (duration: 205.964575ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.864095Z","caller":"traceutil/trace.go:171","msg":"trace[359874908] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"178.696789ms","start":"2026-04-07T05:52:22.685375Z","end":"2026-04-07T05:52:22.864072Z","steps":["trace[359874908] 'process raft request' (duration: 178.36014ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.864175Z","caller":"traceutil/trace.go:171","msg":"trace[463353371] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"159.707546ms","start":"2026-04-07T05:52:22.704445Z","end":"2026-04-07T05:52:22.864153Z","steps":["trace[463353371] 'process raft request' (duration: 159.533661ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.864257Z","caller":"traceutil/trace.go:171","msg":"trace[1429906418] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"126.78678ms","start":"2026-04-07T05:52:22.737453Z","end":"2026-04-07T05:52:22.864239Z","steps":["trace[1429906418] 'process raft request' (duration: 126.739368ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.864313Z","caller":"traceutil/trace.go:171","msg":"trace[2061552028] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"129.651607ms","start":"2026-04-07T05:52:22.734627Z","end":"2026-04-07T05:52:22.864279Z","steps":["trace[2061552028] 'process raft request' (duration: 129.438831ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:22.864167Z","caller":"traceutil/trace.go:171","msg":"trace[1509821492] linearizableReadLoop","detail":"{readStateIndex:517; appliedIndex:511; }","duration":"150.474317ms","start":"2026-04-07T05:52:22.713675Z","end":"2026-04-07T05:52:22.864149Z","steps":["trace[1509821492] 'read index received' (duration: 13.415611ms)","trace[1509821492] 'applied index is now lower than readState.Index' (duration: 137.056826ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:52:22.864398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.702674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T05:52:22.864469Z","caller":"traceutil/trace.go:171","msg":"trace[1181432794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:500; }","duration":"150.824518ms","start":"2026-04-07T05:52:22.713628Z","end":"2026-04-07T05:52:22.864453Z","steps":["trace[1181432794] 'agreement among raft nodes before linearized reading' (duration: 150.584681ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:23.220256Z","caller":"traceutil/trace.go:171","msg":"trace[613001556] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"191.464964ms","start":"2026-04-07T05:52:23.028767Z","end":"2026-04-07T05:52:23.220232Z","steps":["trace[613001556] 'process raft request' (duration: 191.348921ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:23.22033Z","caller":"traceutil/trace.go:171","msg":"trace[1346733760] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"198.094303ms","start":"2026-04-07T05:52:23.022183Z","end":"2026-04-07T05:52:23.220277Z","steps":["trace[1346733760] 'process raft request' (duration: 119.02083ms)","trace[1346733760] 'compare' (duration: 78.668782ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:52:23.222146Z","caller":"traceutil/trace.go:171","msg":"trace[1330531912] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"149.573293ms","start":"2026-04-07T05:52:23.072551Z","end":"2026-04-07T05:52:23.222125Z","steps":["trace[1330531912] 'process raft request' (duration: 149.354278ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:23.391015Z","caller":"traceutil/trace.go:171","msg":"trace[1876629285] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"147.289393ms","start":"2026-04-07T05:52:23.2437Z","end":"2026-04-07T05:52:23.39099Z","steps":["trace[1876629285] 'process raft request' (duration: 147.236771ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:23.391033Z","caller":"traceutil/trace.go:171","msg":"trace[2073311260] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"157.509918ms","start":"2026-04-07T05:52:23.233467Z","end":"2026-04-07T05:52:23.390977Z","steps":["trace[2073311260] 'process raft request' (duration: 90.47318ms)","trace[2073311260] 'compare' (duration: 66.827333ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:52:23.421471Z","caller":"traceutil/trace.go:171","msg":"trace[1920929100] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"136.43789ms","start":"2026-04-07T05:52:23.285002Z","end":"2026-04-07T05:52:23.421439Z","steps":["trace[1920929100] 'process raft request' (duration: 136.270565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:24.15798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.482294ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:52:24.158101Z","caller":"traceutil/trace.go:171","msg":"trace[1945448627] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"519.396657ms","start":"2026-04-07T05:52:23.638681Z","end":"2026-04-07T05:52:24.158077Z","steps":["trace[1945448627] 'process raft request' (duration: 386.700877ms)","trace[1945448627] 'compare' (duration: 132.123234ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:52:24.158168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:23.638658Z","time spent":"519.476169ms","remote":"127.0.0.1:55984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7684,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:52:24.191755Z","caller":"traceutil/trace.go:171","msg":"trace[1581831094] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"490.058717ms","start":"2026-04-07T05:52:23.701652Z","end":"2026-04-07T05:52:24.19171Z","steps":["trace[1581831094] 'process raft request' (duration: 489.630175ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:24.192012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.362215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:52:24.192066Z","caller":"traceutil/trace.go:171","msg":"trace[1569967892] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:524; }","duration":"371.468278ms","start":"2026-04-07T05:52:23.820583Z","end":"2026-04-07T05:52:24.192051Z","steps":["trace[1569967892] 'agreement among raft nodes before linearized reading' (duration: 371.310584ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:24.19202Z","caller":"traceutil/trace.go:171","msg":"trace[1366450167] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"476.050418ms","start":"2026-04-07T05:52:23.715885Z","end":"2026-04-07T05:52:24.191936Z","steps":["trace[1366450167] 'process raft request' (duration: 475.737909ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:24.192107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:23.820561Z","time spent":"371.538539ms","remote":"127.0.0.1:58520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T05:52:24.192029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:23.701631Z","time spent":"490.288913ms","remote":"127.0.0.1:55984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":151221,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:52:24.192257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:23.715863Z","time spent":"476.303666ms","remote":"127.0.0.1:55984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T05:52:24.191845Z","caller":"traceutil/trace.go:171","msg":"trace[28297140] linearizableReadLoop","detail":"{readStateIndex:543; appliedIndex:540; }","duration":"371.14244ms","start":"2026-04-07T05:52:23.820643Z","end":"2026-04-07T05:52:24.191786Z","steps":["trace[28297140] 'read index received' (duration: 204.771463ms)","trace[28297140] 'applied index is now lower than readState.Index' (duration: 166.370037ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:52:24.527296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.153119ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:52:24.527397Z","caller":"traceutil/trace.go:171","msg":"trace[468800596] linearizableReadLoop","detail":"{readStateIndex:544; appliedIndex:543; }","duration":"335.022795ms","start":"2026-04-07T05:52:24.19236Z","end":"2026-04-07T05:52:24.527383Z","steps":["trace[468800596] 'read index received' (duration: 204.792934ms)","trace[468800596] 'applied index is now lower than readState.Index' (duration: 130.228841ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:52:24.527638Z","caller":"traceutil/trace.go:171","msg":"trace[1996238070] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"359.986009ms","start":"2026-04-07T05:52:24.167634Z","end":"2026-04-07T05:52:24.52762Z","steps":["trace[1996238070] 'process raft request' (duration: 229.430268ms)","trace[1996238070] 'compare' (duration: 129.834081ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:52:24.527709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.829916ms","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-04-07T05:52:24.52775Z","caller":"traceutil/trace.go:171","msg":"trace[563286716] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:525; }","duration":"497.894398ms","start":"2026-04-07T05:52:24.029841Z","end":"2026-04-07T05:52:24.527736Z","steps":["trace[563286716] 'agreement among raft nodes before linearized reading' (duration: 497.771675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:24.527746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:24.167606Z","time spent":"360.086631ms","remote":"127.0.0.1:55984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18032,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:52:24.527777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:24.029821Z","time spent":"497.951488ms","remote":"127.0.0.1:56190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-07T05:52:24.53711Z","caller":"traceutil/trace.go:171","msg":"trace[1326652845] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"257.520055ms","start":"2026-04-07T05:52:24.279571Z","end":"2026-04-07T05:52:24.537091Z","steps":["trace[1326652845] 'process raft request' (duration: 257.481355ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:24.537432Z","caller":"traceutil/trace.go:171","msg":"trace[1495714564] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"323.405142ms","start":"2026-04-07T05:52:24.21402Z","end":"2026-04-07T05:52:24.537425Z","steps":["trace[1495714564] 'process raft request' (duration: 322.913668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:24.53753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:24.213987Z","time spent":"323.470333ms","remote":"127.0.0.1:55984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7693,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:52:24.537795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.803142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:52:24.537824Z","caller":"traceutil/trace.go:171","msg":"trace[1201887004] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:527; }","duration":"343.862233ms","start":"2026-04-07T05:52:24.193956Z","end":"2026-04-07T05:52:24.537818Z","steps":["trace[1201887004] 'agreement among raft nodes before linearized reading' (duration: 343.816941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:24.537842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:24.193931Z","time spent":"343.907084ms","remote":"127.0.0.1:58522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T05:52:24.53799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.593567ms","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-04-07T05:52:24.538019Z","caller":"traceutil/trace.go:171","msg":"trace[2110422534] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:527; }","duration":"336.637327ms","start":"2026-04-07T05:52:24.201376Z","end":"2026-04-07T05:52:24.538014Z","steps":["trace[2110422534] 'agreement among raft nodes before linearized reading' (duration: 336.548026ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:24.538034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:24.201369Z","time spent":"336.66155ms","remote":"127.0.0.1:56190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T05:52:24.973795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.278787ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:52:24.973988Z","caller":"traceutil/trace.go:171","msg":"trace[723729448] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"423.951483ms","start":"2026-04-07T05:52:24.550015Z","end":"2026-04-07T05:52:24.973966Z","steps":["trace[723729448] 'process raft request' (duration: 205.426149ms)","trace[723729448] 'compare' (duration: 218.157874ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:52:24.974076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:24.549993Z","time spent":"424.044896ms","remote":"127.0.0.1:56190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:52:24.974135Z","caller":"traceutil/trace.go:171","msg":"trace[907321440] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"401.091476ms","start":"2026-04-07T05:52:24.573031Z","end":"2026-04-07T05:52:24.974123Z","steps":["trace[907321440] 'process raft request' (duration: 400.986003ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:24.974202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:24.572996Z","time spent":"401.174289ms","remote":"127.0.0.1:55984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98689,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:52:24.974174Z","caller":"traceutil/trace.go:171","msg":"trace[300975753] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"417.805427ms","start":"2026-04-07T05:52:24.556331Z","end":"2026-04-07T05:52:24.974136Z","steps":["trace[300975753] 'process raft request' (duration: 417.562761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:24.974333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:24.5563Z","time spent":"417.951121ms","remote":"127.0.0.1:55984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18041,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:52:24.995127Z","caller":"traceutil/trace.go:171","msg":"trace[1543639229] linearizableReadLoop","detail":"{readStateIndex:551; appliedIndex:550; }","duration":"174.062515ms","start":"2026-04-07T05:52:24.821034Z","end":"2026-04-07T05:52:24.995097Z","steps":["trace[1543639229] 'read index received' (duration: 173.571381ms)","trace[1543639229] 'applied index is now lower than readState.Index' (duration: 490.214µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:52:24.995189Z","caller":"traceutil/trace.go:171","msg":"trace[1935279555] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"312.429735ms","start":"2026-04-07T05:52:24.682736Z","end":"2026-04-07T05:52:24.995166Z","steps":["trace[1935279555] 'process raft request' (duration: 312.069636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:24.99531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.254839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:52:24.995351Z","caller":"traceutil/trace.go:171","msg":"trace[2006936686] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:532; }","duration":"174.344361ms","start":"2026-04-07T05:52:24.820996Z","end":"2026-04-07T05:52:24.995341Z","steps":["trace[2006936686] 'agreement among raft nodes before linearized reading' (duration: 174.241999ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:24.99546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:24.682698Z","time spent":"312.535878ms","remote":"127.0.0.1:55984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T05:52:24.995636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.840618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T05:52:24.995708Z","caller":"traceutil/trace.go:171","msg":"trace[1756941280] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:532; }","duration":"117.962661ms","start":"2026-04-07T05:52:24.87773Z","end":"2026-04-07T05:52:24.995692Z","steps":["trace[1756941280] 'agreement among raft nodes before linearized reading' (duration: 117.766865ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:29.656889Z","caller":"traceutil/trace.go:171","msg":"trace[1264313578] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"443.291868ms","start":"2026-04-07T05:52:29.213522Z","end":"2026-04-07T05:52:29.656814Z","steps":["trace[1264313578] 'process raft request' (duration: 441.630474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:29.657183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:29.213505Z","time spent":"443.601718ms","remote":"127.0.0.1:56110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":182,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T05:52:30.025375Z","caller":"traceutil/trace.go:171","msg":"trace[1164415151] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"811.723099ms","start":"2026-04-07T05:52:29.213617Z","end":"2026-04-07T05:52:30.02534Z","steps":["trace[1164415151] 'process raft request' (duration: 809.486608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:30.025537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:29.213598Z","time spent":"811.860812ms","remote":"127.0.0.1:56034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1749,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T05:52:30.025712Z","caller":"traceutil/trace.go:171","msg":"trace[2106316930] linearizableReadLoop","detail":"{readStateIndex:584; appliedIndex:582; }","duration":"522.803753ms","start":"2026-04-07T05:52:29.502883Z","end":"2026-04-07T05:52:30.025687Z","steps":["trace[2106316930] 'read index received' (duration: 152.38441ms)","trace[2106316930] 'applied index is now lower than readState.Index' (duration: 370.418443ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:52:30.025762Z","caller":"traceutil/trace.go:171","msg":"trace[676701283] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"442.57251ms","start":"2026-04-07T05:52:29.583178Z","end":"2026-04-07T05:52:30.025751Z","steps":["trace[676701283] 'process raft request' (duration: 442.224601ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:30.025816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:29.583139Z","time spent":"442.653502ms","remote":"127.0.0.1:56026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T05:52:30.025933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.183907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:52:30.025968Z","caller":"traceutil/trace.go:171","msg":"trace[668260553] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:565; }","duration":"205.28079ms","start":"2026-04-07T05:52:29.820678Z","end":"2026-04-07T05:52:30.025958Z","steps":["trace[668260553] 'agreement among raft nodes before linearized reading' (duration: 205.164567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:30.026067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.176064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mpnf8\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-07T05:52:30.026155Z","caller":"traceutil/trace.go:171","msg":"trace[1077209771] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mpnf8; range_end:; response_count:1; response_revision:565; }","duration":"523.319577ms","start":"2026-04-07T05:52:29.502813Z","end":"2026-04-07T05:52:30.026132Z","steps":["trace[1077209771] 'agreement among raft nodes before linearized reading' (duration: 523.01443ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:30.0263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:29.502787Z","time spent":"523.490532ms","remote":"127.0.0.1:56096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-mpnf8\" "} {"level":"warn","ts":"2026-04-07T05:52:45.10471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.590062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T05:52:45.104774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.472145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-07T05:52:45.104825Z","caller":"traceutil/trace.go:171","msg":"trace[708271861] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:730; }","duration":"283.739225ms","start":"2026-04-07T05:52:44.821063Z","end":"2026-04-07T05:52:45.104803Z","steps":["trace[708271861] 'range keys from in-memory index tree' (duration: 283.493099ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:45.104911Z","caller":"traceutil/trace.go:171","msg":"trace[211540207] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:730; }","duration":"297.65014ms","start":"2026-04-07T05:52:44.807237Z","end":"2026-04-07T05:52:45.104887Z","steps":["trace[211540207] 'range keys from in-memory index tree' (duration: 297.258919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:45.104957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.488025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gfdmb\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-07T05:52:45.10553Z","caller":"traceutil/trace.go:171","msg":"trace[455733340] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gfdmb; range_end:; response_count:1; response_revision:730; }","duration":"516.797082ms","start":"2026-04-07T05:52:44.588398Z","end":"2026-04-07T05:52:45.105195Z","steps":["trace[455733340] 'range keys from in-memory index tree' (duration: 515.93151ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:52:45.105619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:52:44.588375Z","time spent":"517.223444ms","remote":"127.0.0.1:56096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-gfdmb\" "} {"level":"info","ts":"2026-04-07T05:52:45.225535Z","caller":"traceutil/trace.go:171","msg":"trace[1265485885] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"116.060954ms","start":"2026-04-07T05:52:45.109446Z","end":"2026-04-07T05:52:45.225507Z","steps":["trace[1265485885] 'process raft request' (duration: 115.903161ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:45.23393Z","caller":"traceutil/trace.go:171","msg":"trace[1662152956] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"123.646969ms","start":"2026-04-07T05:52:45.110273Z","end":"2026-04-07T05:52:45.23392Z","steps":["trace[1662152956] 'process raft request' (duration: 123.552447ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:52:45.234139Z","caller":"traceutil/trace.go:171","msg":"trace[1151965601] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"120.157965ms","start":"2026-04-07T05:52:45.11394Z","end":"2026-04-07T05:52:45.234098Z","steps":["trace[1151965601] 'process raft request' (duration: 119.93987ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:00.945012Z","caller":"traceutil/trace.go:171","msg":"trace[1901376121] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"139.764162ms","start":"2026-04-07T05:53:00.805223Z","end":"2026-04-07T05:53:00.944987Z","steps":["trace[1901376121] 'process raft request' (duration: 139.7165ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:00.945047Z","caller":"traceutil/trace.go:171","msg":"trace[1794200939] transaction","detail":"{read_only:false; response_revision:931; number_of_response:1; }","duration":"143.45186ms","start":"2026-04-07T05:53:00.801564Z","end":"2026-04-07T05:53:00.945016Z","steps":["trace[1794200939] 'process raft request' (duration: 143.280435ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:01.013419Z","caller":"traceutil/trace.go:171","msg":"trace[1179902539] transaction","detail":"{read_only:false; response_revision:935; number_of_response:1; }","duration":"125.402777ms","start":"2026-04-07T05:53:00.887993Z","end":"2026-04-07T05:53:01.013395Z","steps":["trace[1179902539] 'process raft request' (duration: 125.310504ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:01.013512Z","caller":"traceutil/trace.go:171","msg":"trace[132503898] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"139.31286ms","start":"2026-04-07T05:53:00.874168Z","end":"2026-04-07T05:53:01.013481Z","steps":["trace[132503898] 'process raft request' (duration: 108.256186ms)","trace[132503898] 'compare' (duration: 30.706964ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:53:01.013539Z","caller":"traceutil/trace.go:171","msg":"trace[609393752] transaction","detail":"{read_only:false; response_revision:934; number_of_response:1; }","duration":"125.755555ms","start":"2026-04-07T05:53:00.887718Z","end":"2026-04-07T05:53:01.013474Z","steps":["trace[609393752] 'process raft request' (duration: 125.537979ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:01.013646Z","caller":"traceutil/trace.go:171","msg":"trace[115906832] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"125.049717ms","start":"2026-04-07T05:53:00.888571Z","end":"2026-04-07T05:53:01.013621Z","steps":["trace[115906832] 'process raft request' (duration: 124.998745ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:01.013691Z","caller":"traceutil/trace.go:171","msg":"trace[681403477] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"125.55718ms","start":"2026-04-07T05:53:00.888102Z","end":"2026-04-07T05:53:01.013659Z","steps":["trace[681403477] 'process raft request' (duration: 125.375355ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:01.013548Z","caller":"traceutil/trace.go:171","msg":"trace[1865240733] transaction","detail":"{read_only:false; response_revision:938; number_of_response:1; }","duration":"125.483628ms","start":"2026-04-07T05:53:00.888046Z","end":"2026-04-07T05:53:01.013529Z","steps":["trace[1865240733] 'process raft request' (duration: 125.340135ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:01.013707Z","caller":"traceutil/trace.go:171","msg":"trace[1011562598] transaction","detail":"{read_only:false; response_revision:936; number_of_response:1; }","duration":"125.644023ms","start":"2026-04-07T05:53:00.888007Z","end":"2026-04-07T05:53:01.013651Z","steps":["trace[1011562598] 'process raft request' (duration: 125.328045ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:01.013799Z","caller":"traceutil/trace.go:171","msg":"trace[1936320147] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"125.606512ms","start":"2026-04-07T05:53:00.888183Z","end":"2026-04-07T05:53:01.01379Z","steps":["trace[1936320147] 'process raft request' (duration: 125.316735ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:01.013837Z","caller":"traceutil/trace.go:171","msg":"trace[1309578959] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"125.416167ms","start":"2026-04-07T05:53:00.888412Z","end":"2026-04-07T05:53:01.013829Z","steps":["trace[1309578959] 'process raft request' (duration: 125.108919ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:01.013648Z","caller":"traceutil/trace.go:171","msg":"trace[1144793475] transaction","detail":"{read_only:false; response_revision:937; number_of_response:1; }","duration":"125.595021ms","start":"2026-04-07T05:53:00.888041Z","end":"2026-04-07T05:53:01.013636Z","steps":["trace[1144793475] 'process raft request' (duration: 125.320243ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:01.013885Z","caller":"traceutil/trace.go:171","msg":"trace[1175093464] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"125.765976ms","start":"2026-04-07T05:53:00.888109Z","end":"2026-04-07T05:53:01.013875Z","steps":["trace[1175093464] 'process raft request' (duration: 125.337095ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:01.013883Z","caller":"traceutil/trace.go:171","msg":"trace[530282963] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"125.755036ms","start":"2026-04-07T05:53:00.888102Z","end":"2026-04-07T05:53:01.013857Z","steps":["trace[530282963] 'process raft request' (duration: 125.309674ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:01.013901Z","caller":"traceutil/trace.go:171","msg":"trace[210818926] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"125.401866ms","start":"2026-04-07T05:53:00.888452Z","end":"2026-04-07T05:53:01.013854Z","steps":["trace[210818926] 'process raft request' (duration: 125.093027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:53:51.583584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.689142ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:53:51.583705Z","caller":"traceutil/trace.go:171","msg":"trace[405795822] transaction","detail":"{read_only:false; response_revision:1654; number_of_response:1; }","duration":"267.378318ms","start":"2026-04-07T05:53:51.316307Z","end":"2026-04-07T05:53:51.583685Z","steps":["trace[405795822] 'process raft request' (duration: 113.513042ms)","trace[405795822] 'compare' (duration: 153.549868ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:53:51.783756Z","caller":"traceutil/trace.go:171","msg":"trace[1452359332] transaction","detail":"{read_only:false; response_revision:1658; number_of_response:1; }","duration":"124.577937ms","start":"2026-04-07T05:53:51.659156Z","end":"2026-04-07T05:53:51.783734Z","steps":["trace[1452359332] 'process raft request' (duration: 124.519245ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:51.783784Z","caller":"traceutil/trace.go:171","msg":"trace[246387684] transaction","detail":"{read_only:false; response_revision:1657; number_of_response:1; }","duration":"124.595267ms","start":"2026-04-07T05:53:51.659158Z","end":"2026-04-07T05:53:51.783753Z","steps":["trace[246387684] 'process raft request' (duration: 124.442813ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:51.783872Z","caller":"traceutil/trace.go:171","msg":"trace[114554269] transaction","detail":"{read_only:false; response_revision:1656; number_of_response:1; }","duration":"125.166713ms","start":"2026-04-07T05:53:51.658684Z","end":"2026-04-07T05:53:51.783851Z","steps":["trace[114554269] 'process raft request' (duration: 26.602899ms)","trace[114554269] 'compare' (duration: 98.088731ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:53:51.783977Z","caller":"traceutil/trace.go:171","msg":"trace[489334789] transaction","detail":"{read_only:false; response_revision:1659; number_of_response:1; }","duration":"124.767393ms","start":"2026-04-07T05:53:51.65919Z","end":"2026-04-07T05:53:51.783957Z","steps":["trace[489334789] 'process raft request' (duration: 124.511986ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:53:51.784248Z","caller":"traceutil/trace.go:171","msg":"trace[817450797] transaction","detail":"{read_only:false; response_revision:1660; number_of_response:1; }","duration":"124.856944ms","start":"2026-04-07T05:53:51.659364Z","end":"2026-04-07T05:53:51.784221Z","steps":["trace[817450797] 'process raft request' (duration: 124.511245ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:01.295242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.511795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-07T05:54:01.295338Z","caller":"traceutil/trace.go:171","msg":"trace[488135664] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1804; }","duration":"139.662599ms","start":"2026-04-07T05:54:01.155653Z","end":"2026-04-07T05:54:01.295316Z","steps":["trace[488135664] 'range keys from in-memory index tree' (duration: 139.3246ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:01.335578Z","caller":"traceutil/trace.go:171","msg":"trace[1881486558] linearizableReadLoop","detail":"{readStateIndex:1872; appliedIndex:1871; }","duration":"148.356309ms","start":"2026-04-07T05:54:01.187198Z","end":"2026-04-07T05:54:01.335555Z","steps":["trace[1881486558] 'read index received' (duration: 60.123491ms)","trace[1881486558] 'applied index is now lower than readState.Index' (duration: 88.230098ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:54:01.335915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.698788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6bc47c54-194c-4af2-b50f-05be57ac2ba4\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-07T05:54:01.336002Z","caller":"traceutil/trace.go:171","msg":"trace[1919206847] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6bc47c54-194c-4af2-b50f-05be57ac2ba4; range_end:; response_count:1; response_revision:1805; }","duration":"148.842473ms","start":"2026-04-07T05:54:01.187141Z","end":"2026-04-07T05:54:01.335983Z","steps":["trace[1919206847] 'agreement among raft nodes before linearized reading' (duration: 148.560016ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:18.058675Z","caller":"traceutil/trace.go:171","msg":"trace[1044030239] transaction","detail":"{read_only:false; response_revision:1935; number_of_response:1; }","duration":"118.946278ms","start":"2026-04-07T05:54:17.939692Z","end":"2026-04-07T05:54:18.058639Z","steps":["trace[1044030239] 'process raft request' (duration: 118.732342ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:18.062355Z","caller":"traceutil/trace.go:171","msg":"trace[1748061827] linearizableReadLoop","detail":"{readStateIndex:2008; appliedIndex:2006; }","duration":"114.951271ms","start":"2026-04-07T05:54:17.947377Z","end":"2026-04-07T05:54:18.062328Z","steps":["trace[1748061827] 'read index received' (duration: 111.086628ms)","trace[1748061827] 'applied index is now lower than readState.Index' (duration: 3.863043ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:54:18.062483Z","caller":"traceutil/trace.go:171","msg":"trace[1066297805] transaction","detail":"{read_only:false; response_revision:1936; number_of_response:1; }","duration":"121.122316ms","start":"2026-04-07T05:54:17.941326Z","end":"2026-04-07T05:54:18.062448Z","steps":["trace[1066297805] 'process raft request' (duration: 120.821578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:18.06263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.929874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T05:54:18.062692Z","caller":"traceutil/trace.go:171","msg":"trace[647915250] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1936; }","duration":"105.028197ms","start":"2026-04-07T05:54:17.957645Z","end":"2026-04-07T05:54:18.062674Z","steps":["trace[647915250] 'agreement among raft nodes before linearized reading' (duration: 104.854062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:18.06266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.26457ms","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-04-07T05:54:18.062761Z","caller":"traceutil/trace.go:171","msg":"trace[736448158] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1936; }","duration":"115.424174ms","start":"2026-04-07T05:54:17.947318Z","end":"2026-04-07T05:54:18.062743Z","steps":["trace[736448158] 'agreement among raft nodes before linearized reading' (duration: 115.155997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:18.062786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.123983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-07T05:54:18.062903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.414145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T05:54:18.063026Z","caller":"traceutil/trace.go:171","msg":"trace[663079013] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1936; }","duration":"103.588819ms","start":"2026-04-07T05:54:17.959408Z","end":"2026-04-07T05:54:18.062997Z","steps":["trace[663079013] 'agreement among raft nodes before linearized reading' (duration: 103.170027ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:54:18.063119Z","caller":"traceutil/trace.go:171","msg":"trace[1873675974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1936; }","duration":"104.340519ms","start":"2026-04-07T05:54:17.958622Z","end":"2026-04-07T05:54:18.062962Z","steps":["trace[1873675974] 'agreement among raft nodes before linearized reading' (duration: 104.022631ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:46.32715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.461764ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:54:46.32726Z","caller":"traceutil/trace.go:171","msg":"trace[1846349263] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"368.461318ms","start":"2026-04-07T05:54:45.95878Z","end":"2026-04-07T05:54:46.327241Z","steps":["trace[1846349263] 'process raft request' (duration: 196.822959ms)","trace[1846349263] 'compare' (duration: 171.350411ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:54:46.327318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:54:45.958739Z","time spent":"368.55247ms","remote":"127.0.0.1:58544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:54:46.337756Z","caller":"traceutil/trace.go:171","msg":"trace[1547426507] linearizableReadLoop","detail":"{readStateIndex:2173; appliedIndex:2172; }","duration":"138.164368ms","start":"2026-04-07T05:54:46.19957Z","end":"2026-04-07T05:54:46.337734Z","steps":["trace[1547426507] 'read index received' (duration: 137.964963ms)","trace[1547426507] 'applied index is now lower than readState.Index' (duration: 198.185µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:54:46.337802Z","caller":"traceutil/trace.go:171","msg":"trace[1412901480] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"155.574172ms","start":"2026-04-07T05:54:46.182205Z","end":"2026-04-07T05:54:46.33778Z","steps":["trace[1412901480] 'process raft request' (duration: 155.391947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:54:46.337969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.386234ms","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-04-07T05:54:46.338009Z","caller":"traceutil/trace.go:171","msg":"trace[1465111149] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2095; }","duration":"138.474737ms","start":"2026-04-07T05:54:46.199522Z","end":"2026-04-07T05:54:46.337997Z","steps":["trace[1465111149] 'agreement among raft nodes before linearized reading' (duration: 138.345263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:55:42.763934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.518676ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:55:42.764117Z","caller":"traceutil/trace.go:171","msg":"trace[724908901] linearizableReadLoop","detail":"{readStateIndex:2672; appliedIndex:2670; }","duration":"130.354093ms","start":"2026-04-07T05:55:42.633746Z","end":"2026-04-07T05:55:42.7641Z","steps":["trace[724908901] 'read index received' (duration: 5.503247ms)","trace[724908901] 'applied index is now lower than readState.Index' (duration: 124.849846ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:55:42.764194Z","caller":"traceutil/trace.go:171","msg":"trace[581299195] transaction","detail":"{read_only:false; response_revision:2575; number_of_response:1; }","duration":"133.372042ms","start":"2026-04-07T05:55:42.630812Z","end":"2026-04-07T05:55:42.764184Z","steps":["trace[581299195] 'process raft request' (duration: 133.232959ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:42.764206Z","caller":"traceutil/trace.go:171","msg":"trace[252977717] transaction","detail":"{read_only:false; response_revision:2574; number_of_response:1; }","duration":"138.071058ms","start":"2026-04-07T05:55:42.626089Z","end":"2026-04-07T05:55:42.76416Z","steps":["trace[252977717] 'process raft request' (duration: 13.158581ms)","trace[252977717] 'compare' (duration: 124.406613ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:55:42.764499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.552977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-07T05:55:42.764543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.800504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T05:55:42.764575Z","caller":"traceutil/trace.go:171","msg":"trace[256305111] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2575; }","duration":"130.66087ms","start":"2026-04-07T05:55:42.633896Z","end":"2026-04-07T05:55:42.764557Z","steps":["trace[256305111] 'agreement among raft nodes before linearized reading' (duration: 130.473045ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:42.764585Z","caller":"traceutil/trace.go:171","msg":"trace[222667389] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2575; }","duration":"130.873586ms","start":"2026-04-07T05:55:42.6337Z","end":"2026-04-07T05:55:42.764574Z","steps":["trace[222667389] 'agreement among raft nodes before linearized reading' (duration: 130.740973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:55:42.764687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.258389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:55:42.764711Z","caller":"traceutil/trace.go:171","msg":"trace[502719769] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:2575; }","duration":"124.3032ms","start":"2026-04-07T05:55:42.6404Z","end":"2026-04-07T05:55:42.764703Z","steps":["trace[502719769] 'agreement among raft nodes before linearized reading' (duration: 124.2551ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:55:43.474831Z","caller":"traceutil/trace.go:171","msg":"trace[897829323] transaction","detail":"{read_only:false; response_revision:2579; number_of_response:1; }","duration":"106.419983ms","start":"2026-04-07T05:55:43.368388Z","end":"2026-04-07T05:55:43.474808Z","steps":["trace[897829323] 'process raft request' (duration: 106.277809ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:56:15.318001Z","caller":"traceutil/trace.go:171","msg":"trace[1864373829] transaction","detail":"{read_only:false; response_revision:2773; number_of_response:1; }","duration":"159.869661ms","start":"2026-04-07T05:56:15.158099Z","end":"2026-04-07T05:56:15.317969Z","steps":["trace[1864373829] 'process raft request' (duration: 150.351186ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:56:21.015728Z","caller":"traceutil/trace.go:171","msg":"trace[1344928793] linearizableReadLoop","detail":"{readStateIndex:2908; appliedIndex:2907; }","duration":"178.801856ms","start":"2026-04-07T05:56:20.836896Z","end":"2026-04-07T05:56:21.015698Z","steps":["trace[1344928793] 'read index received' (duration: 111.838497ms)","trace[1344928793] 'applied index is now lower than readState.Index' (duration: 66.961799ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:56:21.016002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.081863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-07T05:56:21.016044Z","caller":"traceutil/trace.go:171","msg":"trace[107928149] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2802; }","duration":"179.147945ms","start":"2026-04-07T05:56:20.836886Z","end":"2026-04-07T05:56:21.016034Z","steps":["trace[107928149] 'agreement among raft nodes before linearized reading' (duration: 178.96708ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:56:21.016149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.338601ms","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-04-07T05:56:21.016285Z","caller":"traceutil/trace.go:171","msg":"trace[1954225419] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2802; }","duration":"158.526115ms","start":"2026-04-07T05:56:20.85773Z","end":"2026-04-07T05:56:21.016256Z","steps":["trace[1954225419] 'agreement among raft nodes before linearized reading' (duration: 158.176656ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:58:41.543887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.495875ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-07T05:58:41.544065Z","caller":"traceutil/trace.go:171","msg":"trace[1421512699] linearizableReadLoop","detail":"{readStateIndex:3881; appliedIndex:3880; }","duration":"464.521156ms","start":"2026-04-07T05:58:41.079527Z","end":"2026-04-07T05:58:41.544048Z","steps":["trace[1421512699] 'read index received' (duration: 147.726613ms)","trace[1421512699] 'applied index is now lower than readState.Index' (duration: 316.793733ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:58:41.544176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.67022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-client-secret\" ","response":"range_response_count:1 size:1229"} {"level":"info","ts":"2026-04-07T05:58:41.544203Z","caller":"traceutil/trace.go:171","msg":"trace[1153152052] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-client-secret; range_end:; response_count:1; response_revision:3741; }","duration":"464.732821ms","start":"2026-04-07T05:58:41.079463Z","end":"2026-04-07T05:58:41.544196Z","steps":["trace[1153152052] 'agreement among raft nodes before linearized reading' (duration: 464.622608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:58:41.544228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:58:41.079444Z","time spent":"464.777873ms","remote":"127.0.0.1:55150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":1251,"request content":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-alertmanager-client-secret\" "} {"level":"info","ts":"2026-04-07T05:58:41.544271Z","caller":"traceutil/trace.go:171","msg":"trace[1128230120] transaction","detail":"{read_only:false; response_revision:3742; number_of_response:1; }","duration":"248.858741ms","start":"2026-04-07T05:58:41.295376Z","end":"2026-04-07T05:58:41.544235Z","steps":["trace[1128230120] 'process raft request' (duration: 248.601704ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:57.054961Z","caller":"traceutil/trace.go:171","msg":"trace[2030430988] transaction","detail":"{read_only:false; response_revision:4611; number_of_response:1; }","duration":"102.594216ms","start":"2026-04-07T05:59:56.952346Z","end":"2026-04-07T05:59:57.05494Z","steps":["trace[2030430988] 'process raft request' (duration: 102.195625ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:59:57.107516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.184357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T05:59:57.10759Z","caller":"traceutil/trace.go:171","msg":"trace[1731255012] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4612; }","duration":"135.319332ms","start":"2026-04-07T05:59:56.972253Z","end":"2026-04-07T05:59:57.107573Z","steps":["trace[1731255012] 'agreement among raft nodes before linearized reading' (duration: 135.174748ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:59:57.107557Z","caller":"traceutil/trace.go:171","msg":"trace[1113668140] transaction","detail":"{read_only:false; response_revision:4612; number_of_response:1; }","duration":"113.726164ms","start":"2026-04-07T05:59:56.99377Z","end":"2026-04-07T05:59:57.107496Z","steps":["trace[1113668140] 'process raft request' (duration: 113.462977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:59:57.107777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.942546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-04-07T05:59:57.10791Z","caller":"traceutil/trace.go:171","msg":"trace[871012996] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4612; }","duration":"115.131811ms","start":"2026-04-07T05:59:56.992751Z","end":"2026-04-07T05:59:57.107883Z","steps":["trace[871012996] 'agreement among raft nodes before linearized reading' (duration: 114.670978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:04.142446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.785488ms","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-04-07T06:00:04.142586Z","caller":"traceutil/trace.go:171","msg":"trace[870658986] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4785; }","duration":"116.000914ms","start":"2026-04-07T06:00:04.026559Z","end":"2026-04-07T06:00:04.14256Z","steps":["trace[870658986] 'range keys from in-memory index tree' (duration: 115.591474ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:09.432541Z","caller":"traceutil/trace.go:171","msg":"trace[2116404620] transaction","detail":"{read_only:false; number_of_response:0; response_revision:4944; }","duration":"164.73726ms","start":"2026-04-07T06:00:09.267773Z","end":"2026-04-07T06:00:09.43251Z","steps":["trace[2116404620] 'process raft request' (duration: 164.611806ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:14.07139Z","caller":"traceutil/trace.go:171","msg":"trace[188569480] transaction","detail":"{read_only:false; response_revision:5035; number_of_response:1; }","duration":"117.486025ms","start":"2026-04-07T06:00:13.953869Z","end":"2026-04-07T06:00:14.071355Z","steps":["trace[188569480] 'process raft request' (duration: 117.257889ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:14.074688Z","caller":"traceutil/trace.go:171","msg":"trace[380194482] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"112.363017ms","start":"2026-04-07T06:00:13.962312Z","end":"2026-04-07T06:00:14.074675Z","steps":["trace[380194482] 'process raft request' (duration: 112.261634ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:14.074772Z","caller":"traceutil/trace.go:171","msg":"trace[446516537] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"116.102337ms","start":"2026-04-07T06:00:13.958621Z","end":"2026-04-07T06:00:14.074723Z","steps":["trace[446516537] 'process raft request' (duration: 115.85733ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:15.113472Z","caller":"traceutil/trace.go:171","msg":"trace[124164792] linearizableReadLoop","detail":"{readStateIndex:5251; appliedIndex:5250; }","duration":"152.899811ms","start":"2026-04-07T06:00:14.960547Z","end":"2026-04-07T06:00:15.113447Z","steps":["trace[124164792] 'read index received' (duration: 152.708826ms)","trace[124164792] 'applied index is now lower than readState.Index' (duration: 189.955µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:00:15.113515Z","caller":"traceutil/trace.go:171","msg":"trace[1988913991] transaction","detail":"{read_only:false; response_revision:5061; number_of_response:1; }","duration":"181.708403ms","start":"2026-04-07T06:00:14.931769Z","end":"2026-04-07T06:00:15.113477Z","steps":["trace[1988913991] 'process raft request' (duration: 181.509848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:15.1138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.430525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16233"} {"level":"info","ts":"2026-04-07T06:00:15.11391Z","caller":"traceutil/trace.go:171","msg":"trace[1779676698] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5061; }","duration":"153.585721ms","start":"2026-04-07T06:00:14.960301Z","end":"2026-04-07T06:00:15.113886Z","steps":["trace[1779676698] 'agreement among raft nodes before linearized reading' (duration: 153.270633ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:15.226877Z","caller":"traceutil/trace.go:171","msg":"trace[660826654] transaction","detail":"{read_only:false; response_revision:5063; number_of_response:1; }","duration":"101.594789ms","start":"2026-04-07T06:00:15.125255Z","end":"2026-04-07T06:00:15.22685Z","steps":["trace[660826654] 'process raft request' (duration: 101.393744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:15.638203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.32373ms","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-04-07T06:00:15.638302Z","caller":"traceutil/trace.go:171","msg":"trace[385491994] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5073; }","duration":"151.487045ms","start":"2026-04-07T06:00:15.486789Z","end":"2026-04-07T06:00:15.638276Z","steps":["trace[385491994] 'range keys from in-memory index tree' (duration: 151.091754ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:18.093899Z","caller":"traceutil/trace.go:171","msg":"trace[509430730] transaction","detail":"{read_only:false; response_revision:5125; number_of_response:1; }","duration":"143.059109ms","start":"2026-04-07T06:00:17.950799Z","end":"2026-04-07T06:00:18.093858Z","steps":["trace[509430730] 'process raft request' (duration: 91.035786ms)","trace[509430730] 'compare' (duration: 51.788247ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:00:18.094382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.633454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-jnj6t\" ","response":"range_response_count:1 size:7818"} {"level":"info","ts":"2026-04-07T06:00:18.094516Z","caller":"traceutil/trace.go:171","msg":"trace[1462519084] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-jnj6t; range_end:; response_count:1; response_revision:5126; }","duration":"100.836529ms","start":"2026-04-07T06:00:17.993654Z","end":"2026-04-07T06:00:18.094491Z","steps":["trace[1462519084] 'agreement among raft nodes before linearized reading' (duration: 100.4988ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:18.094557Z","caller":"traceutil/trace.go:171","msg":"trace[435754756] linearizableReadLoop","detail":"{readStateIndex:5317; appliedIndex:5315; }","duration":"100.277184ms","start":"2026-04-07T06:00:17.993713Z","end":"2026-04-07T06:00:18.093991Z","steps":["trace[435754756] 'read index received' (duration: 8.314553ms)","trace[435754756] 'applied index is now lower than readState.Index' (duration: 91.958291ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:00:27.380526Z","caller":"traceutil/trace.go:171","msg":"trace[298221932] transaction","detail":"{read_only:false; response_revision:5273; number_of_response:1; }","duration":"237.896157ms","start":"2026-04-07T06:00:27.14258Z","end":"2026-04-07T06:00:27.380477Z","steps":["trace[298221932] 'process raft request' (duration: 237.401213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:27.380716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.890775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:00:27.380866Z","caller":"traceutil/trace.go:171","msg":"trace[621854397] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:5273; }","duration":"118.099801ms","start":"2026-04-07T06:00:27.262708Z","end":"2026-04-07T06:00:27.380808Z","steps":["trace[621854397] 'agreement among raft nodes before linearized reading' (duration: 117.862575ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:27.38036Z","caller":"traceutil/trace.go:171","msg":"trace[2086610433] linearizableReadLoop","detail":"{readStateIndex:5467; appliedIndex:5466; }","duration":"117.542295ms","start":"2026-04-07T06:00:27.262755Z","end":"2026-04-07T06:00:27.380297Z","steps":["trace[2086610433] 'read index received' (duration: 117.107213ms)","trace[2086610433] 'applied index is now lower than readState.Index' (duration: 433.622µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:00:29.262266Z","caller":"traceutil/trace.go:171","msg":"trace[1214826102] transaction","detail":"{read_only:false; response_revision:5291; number_of_response:1; }","duration":"126.420264ms","start":"2026-04-07T06:00:29.135817Z","end":"2026-04-07T06:00:29.262237Z","steps":["trace[1214826102] 'process raft request' (duration: 125.328544ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:43.883696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.37451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:00:43.883833Z","caller":"traceutil/trace.go:171","msg":"trace[1913914191] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:5488; }","duration":"321.561966ms","start":"2026-04-07T06:00:43.562239Z","end":"2026-04-07T06:00:43.883801Z","steps":["trace[1913914191] 'count revisions from in-memory index tree' (duration: 321.290778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:43.884185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T06:00:43.562214Z","time spent":"321.664977ms","remote":"127.0.0.1:56244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-04-07T06:00:44.047857Z","caller":"traceutil/trace.go:171","msg":"trace[1589650870] transaction","detail":"{read_only:false; response_revision:5489; number_of_response:1; }","duration":"159.246322ms","start":"2026-04-07T06:00:43.888581Z","end":"2026-04-07T06:00:44.047828Z","steps":["trace[1589650870] 'process raft request' (duration: 159.106118ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:00:44.511964Z","caller":"traceutil/trace.go:171","msg":"trace[2085487342] linearizableReadLoop","detail":"{readStateIndex:5691; appliedIndex:5690; }","duration":"188.649887ms","start":"2026-04-07T06:00:44.323287Z","end":"2026-04-07T06:00:44.511936Z","steps":["trace[2085487342] 'read index received' (duration: 108.119822ms)","trace[2085487342] 'applied index is now lower than readState.Index' (duration: 80.528625ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:00:44.512023Z","caller":"traceutil/trace.go:171","msg":"trace[694338905] transaction","detail":"{read_only:false; response_revision:5491; number_of_response:1; }","duration":"203.458835ms","start":"2026-04-07T06:00:44.308531Z","end":"2026-04-07T06:00:44.51199Z","steps":["trace[694338905] 'process raft request' (duration: 122.844677ms)","trace[694338905] 'compare' (duration: 80.441223ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:00:44.512123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.828654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T06:00:44.512188Z","caller":"traceutil/trace.go:171","msg":"trace[952087620] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5491; }","duration":"188.972026ms","start":"2026-04-07T06:00:44.323203Z","end":"2026-04-07T06:00:44.512175Z","steps":["trace[952087620] 'agreement among raft nodes before linearized reading' (duration: 188.862084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:00:44.512356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.202198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-dgrbs\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-07T06:00:44.51245Z","caller":"traceutil/trace.go:171","msg":"trace[1603221062] range","detail":"{range_begin:/registry/pods/openstack/keepalived-dgrbs; range_end:; response_count:1; response_revision:5491; }","duration":"163.342212ms","start":"2026-04-07T06:00:44.349084Z","end":"2026-04-07T06:00:44.512426Z","steps":["trace[1603221062] 'agreement among raft nodes before linearized reading' (duration: 163.060034ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:01:29.061911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.51319ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T06:01:29.062171Z","caller":"traceutil/trace.go:171","msg":"trace[401920597] transaction","detail":"{read_only:false; response_revision:5892; number_of_response:1; }","duration":"132.571901ms","start":"2026-04-07T06:01:28.929581Z","end":"2026-04-07T06:01:29.062153Z","steps":["trace[401920597] 'process raft request' (duration: 132.465538ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:01:29.062353Z","caller":"traceutil/trace.go:171","msg":"trace[90499809] transaction","detail":"{read_only:false; response_revision:5891; number_of_response:1; }","duration":"169.828936ms","start":"2026-04-07T06:01:28.892432Z","end":"2026-04-07T06:01:29.062261Z","steps":["trace[90499809] 'process raft request' (duration: 27.842844ms)","trace[90499809] 'compare' (duration: 141.257293ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:01:38.89993Z","caller":"traceutil/trace.go:171","msg":"trace[631233271] transaction","detail":"{read_only:false; response_revision:5962; number_of_response:1; }","duration":"101.240984ms","start":"2026-04-07T06:01:38.798651Z","end":"2026-04-07T06:01:38.899892Z","steps":["trace[631233271] 'process raft request' (duration: 101.047788ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:01:52.84127Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2976} {"level":"info","ts":"2026-04-07T06:01:52.915554Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2976,"took":"72.536166ms","hash":1064939208,"current-db-size-bytes":57933824,"current-db-size":"58 MB","current-db-size-in-use-bytes":33521664,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-07T06:01:52.915625Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1064939208,"revision":2976,"compact-revision":-1} {"level":"warn","ts":"2026-04-07T06:06:29.965032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.259556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T06:06:29.96522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.030771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:06:29.965285Z","caller":"traceutil/trace.go:171","msg":"trace[575419285] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:8139; }","duration":"135.093442ms","start":"2026-04-07T06:06:29.830166Z","end":"2026-04-07T06:06:29.965259Z","steps":["trace[575419285] 'count revisions from in-memory index tree' (duration: 134.931137ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:06:29.965868Z","caller":"traceutil/trace.go:171","msg":"trace[1688272487] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8139; }","duration":"144.171322ms","start":"2026-04-07T06:06:29.821681Z","end":"2026-04-07T06:06:29.965852Z","steps":["trace[1688272487] 'range keys from in-memory index tree' (duration: 143.091382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:06:41.579029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.974ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-07T06:06:43.380958Z","caller":"traceutil/trace.go:171","msg":"trace[890609278] transaction","detail":"{read_only:false; response_revision:8213; number_of_response:1; }","duration":"113.439281ms","start":"2026-04-07T06:06:43.267491Z","end":"2026-04-07T06:06:43.38093Z","steps":["trace[890609278] 'process raft request' (duration: 113.102522ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:06:43.841074Z","caller":"traceutil/trace.go:171","msg":"trace[438984490] transaction","detail":"{read_only:false; response_revision:8215; number_of_response:1; }","duration":"103.737687ms","start":"2026-04-07T06:06:43.737291Z","end":"2026-04-07T06:06:43.841028Z","steps":["trace[438984490] 'process raft request' (duration: 102.430971ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:06:52.849405Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6066} {"level":"info","ts":"2026-04-07T06:06:52.947227Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6066,"took":"95.346676ms","hash":3944045905,"current-db-size-bytes":57933824,"current-db-size":"58 MB","current-db-size-in-use-bytes":23576576,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-07T06:06:52.947393Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3944045905,"revision":6066,"compact-revision":2976} {"level":"info","ts":"2026-04-07T06:07:11.447873Z","caller":"traceutil/trace.go:171","msg":"trace[1655600461] linearizableReadLoop","detail":"{readStateIndex:8716; appliedIndex:8715; }","duration":"266.548678ms","start":"2026-04-07T06:07:11.18129Z","end":"2026-04-07T06:07:11.447839Z","steps":["trace[1655600461] 'read index received' (duration: 193.895521ms)","trace[1655600461] 'applied index is now lower than readState.Index' (duration: 72.651227ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T06:07:11.448244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.931578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-04-07T06:07:11.448356Z","caller":"traceutil/trace.go:171","msg":"trace[442968198] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8419; }","duration":"267.129043ms","start":"2026-04-07T06:07:11.181203Z","end":"2026-04-07T06:07:11.448333Z","steps":["trace[442968198] 'agreement among raft nodes before linearized reading' (duration: 266.833616ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:07:12.677737Z","caller":"traceutil/trace.go:171","msg":"trace[912264261] transaction","detail":"{read_only:false; response_revision:8423; number_of_response:1; }","duration":"147.400581ms","start":"2026-04-07T06:07:12.530296Z","end":"2026-04-07T06:07:12.677696Z","steps":["trace[912264261] 'process raft request' (duration: 147.196335ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:07:13.457206Z","caller":"traceutil/trace.go:171","msg":"trace[1503947207] linearizableReadLoop","detail":"{readStateIndex:8726; appliedIndex:8725; }","duration":"170.224964ms","start":"2026-04-07T06:07:13.286941Z","end":"2026-04-07T06:07:13.457165Z","steps":["trace[1503947207] 'read index received' (duration: 169.990678ms)","trace[1503947207] 'applied index is now lower than readState.Index' (duration: 233.436µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T06:07:13.457249Z","caller":"traceutil/trace.go:171","msg":"trace[1801922427] transaction","detail":"{read_only:false; response_revision:8429; number_of_response:1; }","duration":"190.243853ms","start":"2026-04-07T06:07:13.266965Z","end":"2026-04-07T06:07:13.457209Z","steps":["trace[1801922427] 'process raft request' (duration: 190.026457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:07:13.457382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.410609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T06:07:13.45743Z","caller":"traceutil/trace.go:171","msg":"trace[1257516798] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8429; }","duration":"170.492621ms","start":"2026-04-07T06:07:13.286923Z","end":"2026-04-07T06:07:13.457416Z","steps":["trace[1257516798] 'agreement among raft nodes before linearized reading' (duration: 170.371608ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:07:23.932091Z","caller":"traceutil/trace.go:171","msg":"trace[1738068263] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8525; }","duration":"183.431845ms","start":"2026-04-07T06:07:23.748628Z","end":"2026-04-07T06:07:23.93206Z","steps":["trace[1738068263] 'process raft request' (duration: 183.347812ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:07:23.932131Z","caller":"traceutil/trace.go:171","msg":"trace[520398234] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8525; }","duration":"183.99103ms","start":"2026-04-07T06:07:23.748098Z","end":"2026-04-07T06:07:23.932089Z","steps":["trace[520398234] 'process raft request' (duration: 179.709613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:07:24.742015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.510942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:5146"} {"level":"info","ts":"2026-04-07T06:07:24.742116Z","caller":"traceutil/trace.go:171","msg":"trace[1204224448] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:8528; }","duration":"110.681556ms","start":"2026-04-07T06:07:24.631411Z","end":"2026-04-07T06:07:24.742093Z","steps":["trace[1204224448] 'range keys from in-memory index tree' (duration: 110.261406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T06:07:24.742186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.317754ms","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-04-07T06:07:24.742325Z","caller":"traceutil/trace.go:171","msg":"trace[938182945] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8528; }","duration":"220.511489ms","start":"2026-04-07T06:07:24.521783Z","end":"2026-04-07T06:07:24.742295Z","steps":["trace[938182945] 'range keys from in-memory index tree' (duration: 220.071148ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:07:24.769001Z","caller":"traceutil/trace.go:171","msg":"trace[2058499879] transaction","detail":"{read_only:false; response_revision:8529; number_of_response:1; }","duration":"136.798ms","start":"2026-04-07T06:07:24.632177Z","end":"2026-04-07T06:07:24.768975Z","steps":["trace[2058499879] 'process raft request' (duration: 136.588584ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:07:24.796214Z","caller":"traceutil/trace.go:171","msg":"trace[1049131953] transaction","detail":"{read_only:false; response_revision:8530; number_of_response:1; }","duration":"117.352649ms","start":"2026-04-07T06:07:24.678828Z","end":"2026-04-07T06:07:24.796181Z","steps":["trace[1049131953] 'process raft request' (duration: 117.110971ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:07:26.169887Z","caller":"traceutil/trace.go:171","msg":"trace[1793525326] transaction","detail":"{read_only:false; response_revision:8544; number_of_response:1; }","duration":"119.112927ms","start":"2026-04-07T06:07:26.050743Z","end":"2026-04-07T06:07:26.169856Z","steps":["trace[1793525326] 'process raft request' (duration: 112.288731ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:08:10.953572Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000242a.wal"} {"level":"info","ts":"2026-04-07T06:09:32.861463Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"6e7960f761c1028e","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-07T06:09:32.868079Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-07T06:09:32.868234Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"warn","ts":"2026-04-07T06:10:58.543027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.847038ms","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-04-07T06:10:58.54315Z","caller":"traceutil/trace.go:171","msg":"trace[680412330] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:10322; }","duration":"180.055914ms","start":"2026-04-07T06:10:58.36307Z","end":"2026-04-07T06:10:58.543126Z","steps":["trace[680412330] 'count revisions from in-memory index tree' (duration: 179.691905ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:11:01.267813Z","caller":"traceutil/trace.go:171","msg":"trace[1297654982] transaction","detail":"{read_only:false; response_revision:10338; number_of_response:1; }","duration":"108.355531ms","start":"2026-04-07T06:11:01.159433Z","end":"2026-04-07T06:11:01.267789Z","steps":["trace[1297654982] 'process raft request' (duration: 108.181937ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T06:11:52.856236Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8272} {"level":"info","ts":"2026-04-07T06:11:52.94024Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8272,"took":"80.78331ms","hash":3686418718,"current-db-size-bytes":57933824,"current-db-size":"58 MB","current-db-size-in-use-bytes":24752128,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-07T06:11:52.940335Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3686418718,"revision":8272,"compact-revision":6066} {"level":"info","ts":"2026-04-07T06:16:52.862486Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10663} {"level":"info","ts":"2026-04-07T06:16:52.942694Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10663,"took":"77.541982ms","hash":3886710112,"current-db-size-bytes":57933824,"current-db-size":"58 MB","current-db-size-in-use-bytes":20180992,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-07T06:16:52.942786Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3886710112,"revision":10663,"compact-revision":8272}