{"level":"warn","ts":"2026-04-07T01:19:04.829485Z","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-07T01:19:04.829589Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4: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.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-07T01:19:04.829657Z","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-07T01:19:04.829666Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-04-07T01:19:04.829688Z","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-07T01:19:04.830443Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-04-07T01:19:04.830517Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-07T01:19:04.833017Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.302267ms"} {"level":"info","ts":"2026-04-07T01:19:04.840634Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-04-07T01:19:04.840774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T01:19:04.840911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-04-07T01:19:04.840935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T01:19:04.840952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-04-07T01:19:04.841037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-04-07T01:19:04.849605Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T01:19:04.851346Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T01:19:04.852688Z","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-07T01:19:04.855645Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T01:19:04.85624Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T01:19:04.857037Z","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-07T01:19:04.857293Z","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-07T01:19:04.857409Z","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-07T01:19:04.865378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-04-07T01:19:04.865662Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-04-07T01:19:04.865722Z","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-07T01:19:04.865938Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-04-07T01:19:04.86601Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-04-07T01:19:04.866304Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T01:19:04.866343Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T01:19:05.843909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T01:19:05.843997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T01:19:05.844045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-04-07T01:19:05.844067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-04-07T01:19:05.844092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-04-07T01:19:05.844111Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-04-07T01:19:05.844127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-04-07T01:19:05.908008Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T01:19:05.908144Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:19:05.908249Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:19:05.908123Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:19:05.908359Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T01:19:05.908764Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T01:19:05.909939Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:19:05.910336Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:19:05.910385Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:19:05.911812Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T01:19:05.912815Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-04-07T01:19:36.661112Z","caller":"traceutil/trace.go:171","msg":"trace[55326719] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"154.915967ms","start":"2026-04-07T01:19:36.506145Z","end":"2026-04-07T01:19:36.661061Z","steps":["trace[55326719] 'process raft request' (duration: 154.732205ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:36.799685Z","caller":"traceutil/trace.go:171","msg":"trace[137786418] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"286.616804ms","start":"2026-04-07T01:19:36.513006Z","end":"2026-04-07T01:19:36.799623Z","steps":["trace[137786418] 'process raft request' (duration: 286.354262ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:36.799945Z","caller":"traceutil/trace.go:171","msg":"trace[959194563] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"208.47374ms","start":"2026-04-07T01:19:36.591443Z","end":"2026-04-07T01:19:36.799917Z","steps":["trace[959194563] 'process raft request' (duration: 208.41002ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:36.79997Z","caller":"traceutil/trace.go:171","msg":"trace[1073064833] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"272.438095ms","start":"2026-04-07T01:19:36.527512Z","end":"2026-04-07T01:19:36.79995Z","steps":["trace[1073064833] 'process raft request' (duration: 272.036052ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:36.799956Z","caller":"traceutil/trace.go:171","msg":"trace[238834449] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"271.216075ms","start":"2026-04-07T01:19:36.52869Z","end":"2026-04-07T01:19:36.799906Z","steps":["trace[238834449] 'process raft request' (duration: 270.904883ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:36.800109Z","caller":"traceutil/trace.go:171","msg":"trace[544448533] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"238.309261ms","start":"2026-04-07T01:19:36.561788Z","end":"2026-04-07T01:19:36.800097Z","steps":["trace[544448533] 'process raft request' (duration: 237.852277ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:36.800178Z","caller":"traceutil/trace.go:171","msg":"trace[1218364538] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"238.277211ms","start":"2026-04-07T01:19:36.561889Z","end":"2026-04-07T01:19:36.800166Z","steps":["trace[1218364538] 'process raft request' (duration: 237.823718ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:36.800203Z","caller":"traceutil/trace.go:171","msg":"trace[55142112] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"277.326663ms","start":"2026-04-07T01:19:36.522867Z","end":"2026-04-07T01:19:36.800194Z","steps":["trace[55142112] 'process raft request' (duration: 276.542907ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:36.800247Z","caller":"traceutil/trace.go:171","msg":"trace[1696660694] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"277.334163ms","start":"2026-04-07T01:19:36.522867Z","end":"2026-04-07T01:19:36.800201Z","steps":["trace[1696660694] 'process raft request' (duration: 276.587907ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:36.800337Z","caller":"traceutil/trace.go:171","msg":"trace[565659203] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"273.584254ms","start":"2026-04-07T01:19:36.52628Z","end":"2026-04-07T01:19:36.799865Z","steps":["trace[565659203] 'process raft request' (duration: 273.227921ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:36.799837Z","caller":"traceutil/trace.go:171","msg":"trace[1011428273] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"288.322157ms","start":"2026-04-07T01:19:36.511459Z","end":"2026-04-07T01:19:36.799781Z","steps":["trace[1011428273] 'process raft request' (duration: 287.760823ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:36.812904Z","caller":"traceutil/trace.go:171","msg":"trace[1545378135] transaction","detail":"{read_only:false; number_of_response:1; response_revision:525; }","duration":"143.57883ms","start":"2026-04-07T01:19:36.6693Z","end":"2026-04-07T01:19:36.812879Z","steps":["trace[1545378135] 'process raft request' (duration: 143.219787ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:36.813176Z","caller":"traceutil/trace.go:171","msg":"trace[1455122170] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"144.222965ms","start":"2026-04-07T01:19:36.668945Z","end":"2026-04-07T01:19:36.813168Z","steps":["trace[1455122170] 'process raft request' (duration: 143.544149ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:36.813332Z","caller":"traceutil/trace.go:171","msg":"trace[599599756] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"101.605397ms","start":"2026-04-07T01:19:36.711713Z","end":"2026-04-07T01:19:36.813318Z","steps":["trace[599599756] 'process raft request' (duration: 100.90335ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:36.813141Z","caller":"traceutil/trace.go:171","msg":"trace[74858224] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"144.376546ms","start":"2026-04-07T01:19:36.66874Z","end":"2026-04-07T01:19:36.813117Z","steps":["trace[74858224] 'process raft request' (duration: 143.588449ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:37.399117Z","caller":"traceutil/trace.go:171","msg":"trace[794687113] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"107.323551ms","start":"2026-04-07T01:19:37.291747Z","end":"2026-04-07T01:19:37.39907Z","steps":["trace[794687113] 'process raft request' (duration: 103.429521ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:37.553164Z","caller":"traceutil/trace.go:171","msg":"trace[32816833] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"123.495846ms","start":"2026-04-07T01:19:37.429638Z","end":"2026-04-07T01:19:37.553134Z","steps":["trace[32816833] 'process raft request' (duration: 55.667417ms)","trace[32816833] 'compare' (duration: 67.686868ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:19:37.59422Z","caller":"traceutil/trace.go:171","msg":"trace[253822990] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"100.311917ms","start":"2026-04-07T01:19:37.49388Z","end":"2026-04-07T01:19:37.594192Z","steps":["trace[253822990] 'process raft request' (duration: 99.859804ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:37.952025Z","caller":"traceutil/trace.go:171","msg":"trace[756145144] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"219.923963ms","start":"2026-04-07T01:19:37.732081Z","end":"2026-04-07T01:19:37.952005Z","steps":["trace[756145144] 'process raft request' (duration: 205.585583ms)","trace[756145144] 'compare' (duration: 14.172819ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:19:37.952432Z","caller":"traceutil/trace.go:171","msg":"trace[69718148] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"218.297161ms","start":"2026-04-07T01:19:37.734128Z","end":"2026-04-07T01:19:37.952425Z","steps":["trace[69718148] 'process raft request' (duration: 217.843828ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:37.953051Z","caller":"traceutil/trace.go:171","msg":"trace[1317513529] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"109.929542ms","start":"2026-04-07T01:19:37.843091Z","end":"2026-04-07T01:19:37.953021Z","steps":["trace[1317513529] 'process raft request' (duration: 109.375637ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:38.171562Z","caller":"traceutil/trace.go:171","msg":"trace[1583669850] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"145.886748ms","start":"2026-04-07T01:19:38.025636Z","end":"2026-04-07T01:19:38.171523Z","steps":["trace[1583669850] 'process raft request' (duration: 83.422694ms)","trace[1583669850] 'compare' (duration: 62.199911ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:19:38.171879Z","caller":"traceutil/trace.go:171","msg":"trace[487927361] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"145.950188ms","start":"2026-04-07T01:19:38.025906Z","end":"2026-04-07T01:19:38.171856Z","steps":["trace[487927361] 'process raft request' (duration: 145.850897ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:38.258971Z","caller":"traceutil/trace.go:171","msg":"trace[1823823004] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"116.352483ms","start":"2026-04-07T01:19:38.14258Z","end":"2026-04-07T01:19:38.258933Z","steps":["trace[1823823004] 'process raft request' (duration: 116.039721ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:42.24483Z","caller":"traceutil/trace.go:171","msg":"trace[13158757] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"265.782ms","start":"2026-04-07T01:19:41.979024Z","end":"2026-04-07T01:19:42.244806Z","steps":["trace[13158757] 'process raft request' (duration: 265.146255ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:43.804141Z","caller":"traceutil/trace.go:171","msg":"trace[921428962] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"173.594302ms","start":"2026-04-07T01:19:43.630503Z","end":"2026-04-07T01:19:43.804098Z","steps":["trace[921428962] 'process raft request' (duration: 173.375681ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:19:44.221758Z","caller":"traceutil/trace.go:171","msg":"trace[981871682] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"590.616714ms","start":"2026-04-07T01:19:43.631108Z","end":"2026-04-07T01:19:44.221725Z","steps":["trace[981871682] 'process raft request' (duration: 590.155461ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:19:44.222298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:19:43.631089Z","time spent":"590.746104ms","remote":"127.0.0.1:49936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:19:44.222367Z","caller":"traceutil/trace.go:171","msg":"trace[415690310] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:641; }","duration":"509.717155ms","start":"2026-04-07T01:19:43.712635Z","end":"2026-04-07T01:19:44.222353Z","steps":["trace[415690310] 'read index received' (duration: 91.294713ms)","trace[415690310] 'applied index is now lower than readState.Index' (duration: 418.421422ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:19:44.22266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.028777ms","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-07T01:19:44.22271Z","caller":"traceutil/trace.go:171","msg":"trace[1160411036] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:623; }","duration":"510.117357ms","start":"2026-04-07T01:19:43.712583Z","end":"2026-04-07T01:19:44.222701Z","steps":["trace[1160411036] 'agreement among raft nodes before linearized reading' (duration: 509.987326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:19:44.222734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:19:43.712561Z","time spent":"510.167719ms","remote":"127.0.0.1:49936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-07T01:19:44.222781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.008707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tz77r\" ","response":"range_response_count:1 size:16957"} {"level":"info","ts":"2026-04-07T01:19:44.222807Z","caller":"traceutil/trace.go:171","msg":"trace[937223818] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tz77r; range_end:; response_count:1; response_revision:623; }","duration":"382.100298ms","start":"2026-04-07T01:19:43.840698Z","end":"2026-04-07T01:19:44.222798Z","steps":["trace[937223818] 'agreement among raft nodes before linearized reading' (duration: 382.018297ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:19:44.222825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:19:43.840675Z","time spent":"382.145808ms","remote":"127.0.0.1:49844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16980,"request content":"key:\"/registry/pods/kube-system/cilium-tz77r\" "} {"level":"info","ts":"2026-04-07T01:19:44.222854Z","caller":"traceutil/trace.go:171","msg":"trace[1698035422] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"449.730579ms","start":"2026-04-07T01:19:43.773116Z","end":"2026-04-07T01:19:44.222847Z","steps":["trace[1698035422] 'process raft request' (duration: 448.624221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:19:44.222896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:19:43.77304Z","time spent":"449.830529ms","remote":"127.0.0.1:49762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:19:44.22296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.016091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:19:44.222977Z","caller":"traceutil/trace.go:171","msg":"trace[1304614332] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"274.074211ms","start":"2026-04-07T01:19:43.948897Z","end":"2026-04-07T01:19:44.222971Z","steps":["trace[1304614332] 'agreement among raft nodes before linearized reading' (duration: 274.045361ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:00.172105Z","caller":"traceutil/trace.go:171","msg":"trace[771495575] linearizableReadLoop","detail":"{readStateIndex:814; appliedIndex:813; }","duration":"224.236973ms","start":"2026-04-07T01:19:59.947837Z","end":"2026-04-07T01:20:00.172074Z","steps":["trace[771495575] 'read index received' (duration: 223.981871ms)","trace[771495575] 'applied index is now lower than readState.Index' (duration: 254.102µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:20:00.172216Z","caller":"traceutil/trace.go:171","msg":"trace[1441475132] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"253.216913ms","start":"2026-04-07T01:19:59.918965Z","end":"2026-04-07T01:20:00.172182Z","steps":["trace[1441475132] 'process raft request' (duration: 252.896091ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:20:00.172326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.443684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:20:00.172421Z","caller":"traceutil/trace.go:171","msg":"trace[2089751557] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:788; }","duration":"224.625525ms","start":"2026-04-07T01:19:59.947774Z","end":"2026-04-07T01:20:00.172399Z","steps":["trace[2089751557] 'agreement among raft nodes before linearized reading' (duration: 224.446214ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:20:00.172431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.34288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lchqb\" ","response":"range_response_count:1 size:3963"} {"level":"info","ts":"2026-04-07T01:20:00.172479Z","caller":"traceutil/trace.go:171","msg":"trace[922735565] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-lchqb; range_end:; response_count:1; response_revision:788; }","duration":"222.44303ms","start":"2026-04-07T01:19:59.950021Z","end":"2026-04-07T01:20:00.172464Z","steps":["trace[922735565] 'agreement among raft nodes before linearized reading' (duration: 222.240829ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:00.338412Z","caller":"traceutil/trace.go:171","msg":"trace[1281328365] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"158.499253ms","start":"2026-04-07T01:20:00.179866Z","end":"2026-04-07T01:20:00.338365Z","steps":["trace[1281328365] 'process raft request' (duration: 158.268431ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:52.706955Z","caller":"traceutil/trace.go:171","msg":"trace[225044595] transaction","detail":"{read_only:false; response_revision:1445; number_of_response:1; }","duration":"138.192595ms","start":"2026-04-07T01:20:52.568719Z","end":"2026-04-07T01:20:52.706912Z","steps":["trace[225044595] 'process raft request' (duration: 137.923904ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:52.932782Z","caller":"traceutil/trace.go:171","msg":"trace[1503594831] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"220.660989ms","start":"2026-04-07T01:20:52.712079Z","end":"2026-04-07T01:20:52.93274Z","steps":["trace[1503594831] 'process raft request' (duration: 220.280814ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:52.932895Z","caller":"traceutil/trace.go:171","msg":"trace[1076927026] transaction","detail":"{read_only:false; response_revision:1448; number_of_response:1; }","duration":"220.379078ms","start":"2026-04-07T01:20:52.712489Z","end":"2026-04-07T01:20:52.932868Z","steps":["trace[1076927026] 'process raft request' (duration: 219.990704ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:52.932895Z","caller":"traceutil/trace.go:171","msg":"trace[1005221734] transaction","detail":"{read_only:false; response_revision:1446; number_of_response:1; }","duration":"220.777383ms","start":"2026-04-07T01:20:52.712079Z","end":"2026-04-07T01:20:52.932856Z","steps":["trace[1005221734] 'process raft request' (duration: 139.239404ms)","trace[1005221734] 'compare' (duration: 80.709067ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:21:08.768857Z","caller":"traceutil/trace.go:171","msg":"trace[1391320894] transaction","detail":"{read_only:false; response_revision:1720; number_of_response:1; }","duration":"103.966579ms","start":"2026-04-07T01:21:08.664847Z","end":"2026-04-07T01:21:08.768814Z","steps":["trace[1391320894] 'process raft request' (duration: 103.68935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:21:08.768914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.498609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:21:08.769038Z","caller":"traceutil/trace.go:171","msg":"trace[1142170505] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1720; }","duration":"106.698526ms","start":"2026-04-07T01:21:08.662315Z","end":"2026-04-07T01:21:08.769014Z","steps":["trace[1142170505] 'agreement among raft nodes before linearized reading' (duration: 106.470139ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:21:08.769119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.923125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/pxc-operator-7cff949c8b-jh5m7\" ","response":"range_response_count:1 size:3255"} {"level":"info","ts":"2026-04-07T01:21:08.769222Z","caller":"traceutil/trace.go:171","msg":"trace[1954121803] range","detail":"{range_begin:/registry/pods/openstack/pxc-operator-7cff949c8b-jh5m7; range_end:; response_count:1; response_revision:1720; }","duration":"103.088531ms","start":"2026-04-07T01:21:08.666104Z","end":"2026-04-07T01:21:08.769192Z","steps":["trace[1954121803] 'agreement among raft nodes before linearized reading' (duration: 102.730649ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:21:11.787735Z","caller":"traceutil/trace.go:171","msg":"trace[910921324] transaction","detail":"{read_only:false; response_revision:1752; number_of_response:1; }","duration":"150.685412ms","start":"2026-04-07T01:21:11.637005Z","end":"2026-04-07T01:21:11.787691Z","steps":["trace[910921324] 'process raft request' (duration: 149.331101ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:21:19.404844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.065418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-07T01:21:19.404957Z","caller":"traceutil/trace.go:171","msg":"trace[594705054] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1855; }","duration":"309.261223ms","start":"2026-04-07T01:21:19.095671Z","end":"2026-04-07T01:21:19.404932Z","steps":["trace[594705054] 'range keys from in-memory index tree' (duration: 308.848962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:21:19.405017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:21:19.095647Z","time spent":"309.349576ms","remote":"127.0.0.1:49936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-07T01:21:19.405355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.906056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:21:19.4054Z","caller":"traceutil/trace.go:171","msg":"trace[550368233] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1855; }","duration":"456.999699ms","start":"2026-04-07T01:21:18.948391Z","end":"2026-04-07T01:21:19.405391Z","steps":["trace[550368233] 'range keys from in-memory index tree' (duration: 456.790543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:21:19.405426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:21:18.948366Z","time spent":"457.053331ms","remote":"127.0.0.1:48138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T01:21:19.405992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.26351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-04-07T01:21:19.406096Z","caller":"traceutil/trace.go:171","msg":"trace[1903445557] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:1; response_revision:1855; }","duration":"361.445855ms","start":"2026-04-07T01:21:19.044629Z","end":"2026-04-07T01:21:19.406074Z","steps":["trace[1903445557] 'range keys from in-memory index tree' (duration: 361.006673ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:21:19.406159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:21:19.044599Z","time spent":"361.549948ms","remote":"127.0.0.1:49712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":154,"request content":"key:\"/registry/masterleases/199.204.45.4\" "} {"level":"warn","ts":"2026-04-07T01:21:19.405227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.515561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-07T01:21:19.406749Z","caller":"traceutil/trace.go:171","msg":"trace[1557630536] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1855; }","duration":"295.099747ms","start":"2026-04-07T01:21:19.111631Z","end":"2026-04-07T01:21:19.406731Z","steps":["trace[1557630536] 'range keys from in-memory index tree' (duration: 293.231163ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:21:19.411773Z","caller":"traceutil/trace.go:171","msg":"trace[979995920] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"112.046603ms","start":"2026-04-07T01:21:19.299709Z","end":"2026-04-07T01:21:19.411756Z","steps":["trace[979995920] 'process raft request' (duration: 111.777495ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:21:19.53334Z","caller":"traceutil/trace.go:171","msg":"trace[1505283277] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"122.778591ms","start":"2026-04-07T01:21:19.410532Z","end":"2026-04-07T01:21:19.53331Z","steps":["trace[1505283277] 'process raft request' (duration: 122.533164ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:21:19.613204Z","caller":"traceutil/trace.go:171","msg":"trace[1566638580] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"200.756694ms","start":"2026-04-07T01:21:19.4124Z","end":"2026-04-07T01:21:19.613156Z","steps":["trace[1566638580] 'process raft request' (duration: 200.460245ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:21:19.61349Z","caller":"traceutil/trace.go:171","msg":"trace[360815022] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"129.973678ms","start":"2026-04-07T01:21:19.483485Z","end":"2026-04-07T01:21:19.613459Z","steps":["trace[360815022] 'process raft request' (duration: 129.640079ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:21:19.61362Z","caller":"traceutil/trace.go:171","msg":"trace[1653239670] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"195.07635ms","start":"2026-04-07T01:21:19.418523Z","end":"2026-04-07T01:21:19.613599Z","steps":["trace[1653239670] 'process raft request' (duration: 194.510914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:21:19.937224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.96601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-07T01:21:19.937309Z","caller":"traceutil/trace.go:171","msg":"trace[1895868056] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1862; }","duration":"144.113114ms","start":"2026-04-07T01:21:19.793176Z","end":"2026-04-07T01:21:19.937289Z","steps":["trace[1895868056] 'range keys from in-memory index tree' (duration: 143.746824ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:21:33.279854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.670398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-messaging-topology-operator-7f8596f788-sr2fv\" ","response":"range_response_count:1 size:6112"} {"level":"info","ts":"2026-04-07T01:21:33.27995Z","caller":"traceutil/trace.go:171","msg":"trace[336912571] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-messaging-topology-operator-7f8596f788-sr2fv; range_end:; response_count:1; response_revision:1977; }","duration":"118.849973ms","start":"2026-04-07T01:21:33.161073Z","end":"2026-04-07T01:21:33.279923Z","steps":["trace[336912571] 'range keys from in-memory index tree' (duration: 118.507845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:21:43.375214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.557525ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:21:43.375353Z","caller":"traceutil/trace.go:171","msg":"trace[1581861588] linearizableReadLoop","detail":"{readStateIndex:2124; appliedIndex:2123; }","duration":"304.163489ms","start":"2026-04-07T01:21:43.071169Z","end":"2026-04-07T01:21:43.375332Z","steps":["trace[1581861588] 'read index received' (duration: 24.111333ms)","trace[1581861588] 'applied index is now lower than readState.Index' (duration: 280.050566ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:21:43.375464Z","caller":"traceutil/trace.go:171","msg":"trace[1660314060] transaction","detail":"{read_only:false; response_revision:2047; number_of_response:1; }","duration":"313.685631ms","start":"2026-04-07T01:21:43.061765Z","end":"2026-04-07T01:21:43.375451Z","steps":["trace[1660314060] 'process raft request' (duration: 33.565453ms)","trace[1660314060] 'compare' (duration: 279.372111ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:21:43.375689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.843012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"warn","ts":"2026-04-07T01:21:43.375778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:21:43.061756Z","time spent":"313.979239ms","remote":"127.0.0.1:49936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:21:43.37575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.571919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:21:43.376029Z","caller":"traceutil/trace.go:171","msg":"trace[30733313] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2047; }","duration":"304.900356ms","start":"2026-04-07T01:21:43.071118Z","end":"2026-04-07T01:21:43.376019Z","steps":["trace[30733313] 'agreement among raft nodes before linearized reading' (duration: 304.549868ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:21:43.375875Z","caller":"traceutil/trace.go:171","msg":"trace[2014383504] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2047; }","duration":"238.051816ms","start":"2026-04-07T01:21:43.137763Z","end":"2026-04-07T01:21:43.375815Z","steps":["trace[2014383504] 'agreement among raft nodes before linearized reading' (duration: 237.711769ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:21:43.376097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:21:43.071093Z","time spent":"304.989429ms","remote":"127.0.0.1:49858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-04-07T01:21:49.411543Z","caller":"traceutil/trace.go:171","msg":"trace[1025801381] linearizableReadLoop","detail":"{readStateIndex:2154; appliedIndex:2153; }","duration":"365.456631ms","start":"2026-04-07T01:21:49.046058Z","end":"2026-04-07T01:21:49.411514Z","steps":["trace[1025801381] 'read index received' (duration: 365.287077ms)","trace[1025801381] 'applied index is now lower than readState.Index' (duration: 168.314µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:21:49.411597Z","caller":"traceutil/trace.go:171","msg":"trace[1854222937] transaction","detail":"{read_only:false; response_revision:2076; number_of_response:1; }","duration":"377.804576ms","start":"2026-04-07T01:21:49.033767Z","end":"2026-04-07T01:21:49.411572Z","steps":["trace[1854222937] 'process raft request' (duration: 377.51325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:21:49.411759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:21:49.033724Z","time spent":"377.940609ms","remote":"127.0.0.1:49936","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:21:49.411821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.750568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-04-07T01:21:49.411892Z","caller":"traceutil/trace.go:171","msg":"trace[254280719] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:1; response_revision:2076; }","duration":"365.87654ms","start":"2026-04-07T01:21:49.046Z","end":"2026-04-07T01:21:49.411877Z","steps":["trace[254280719] 'agreement among raft nodes before linearized reading' (duration: 365.651295ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:21:49.411932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:21:49.045976Z","time spent":"365.947042ms","remote":"127.0.0.1:49712","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":154,"request content":"key:\"/registry/masterleases/199.204.45.4\" "} {"level":"warn","ts":"2026-04-07T01:21:49.661528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.489389ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-04-07T01:21:49.662066Z","caller":"traceutil/trace.go:171","msg":"trace[563878711] linearizableReadLoop","detail":"{readStateIndex:2157; appliedIndex:2154; }","duration":"180.997592ms","start":"2026-04-07T01:21:49.481052Z","end":"2026-04-07T01:21:49.662049Z","steps":["trace[563878711] 'read index received' (duration: 48.986581ms)","trace[563878711] 'applied index is now lower than readState.Index' (duration: 132.010091ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:21:49.662089Z","caller":"traceutil/trace.go:171","msg":"trace[368136478] transaction","detail":"{read_only:false; response_revision:2077; number_of_response:1; }","duration":"244.960976ms","start":"2026-04-07T01:21:49.417108Z","end":"2026-04-07T01:21:49.662069Z","steps":["trace[368136478] 'process raft request' (duration: 244.521237ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:21:49.662371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.331659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-07T01:21:49.662973Z","caller":"traceutil/trace.go:171","msg":"trace[5951737] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2078; }","duration":"182.001784ms","start":"2026-04-07T01:21:49.480944Z","end":"2026-04-07T01:21:49.662946Z","steps":["trace[5951737] 'agreement among raft nodes before linearized reading' (duration: 181.164405ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:21:49.662359Z","caller":"traceutil/trace.go:171","msg":"trace[581046997] transaction","detail":"{read_only:false; response_revision:2078; number_of_response:1; }","duration":"215.092742ms","start":"2026-04-07T01:21:49.447228Z","end":"2026-04-07T01:21:49.66232Z","steps":["trace[581046997] 'process raft request' (duration: 214.770335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:23:37.166083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.144014ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:23:37.166708Z","caller":"traceutil/trace.go:171","msg":"trace[429957483] linearizableReadLoop","detail":"{readStateIndex:2866; appliedIndex:2865; }","duration":"180.71068ms","start":"2026-04-07T01:23:36.985981Z","end":"2026-04-07T01:23:37.166691Z","steps":["trace[429957483] 'read index received' (duration: 10.798316ms)","trace[429957483] 'applied index is now lower than readState.Index' (duration: 169.911284ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:23:37.166792Z","caller":"traceutil/trace.go:171","msg":"trace[2122781413] transaction","detail":"{read_only:false; response_revision:2763; number_of_response:1; }","duration":"230.698046ms","start":"2026-04-07T01:23:36.936076Z","end":"2026-04-07T01:23:37.166774Z","steps":["trace[2122781413] 'process raft request' (duration: 60.767872ms)","trace[2122781413] 'compare' (duration: 168.725338ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:23:37.16703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.047304ms","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-07T01:23:37.167054Z","caller":"traceutil/trace.go:171","msg":"trace[581859893] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2763; }","duration":"181.109505ms","start":"2026-04-07T01:23:36.985937Z","end":"2026-04-07T01:23:37.167047Z","steps":["trace[581859893] 'agreement among raft nodes before linearized reading' (duration: 181.008473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:23:37.167349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.888402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-04-07T01:23:37.167451Z","caller":"traceutil/trace.go:171","msg":"trace[1670371647] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2763; }","duration":"144.016104ms","start":"2026-04-07T01:23:37.023412Z","end":"2026-04-07T01:23:37.167428Z","steps":["trace[1670371647] 'agreement among raft nodes before linearized reading' (duration: 143.684189ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:26.648014Z","caller":"traceutil/trace.go:171","msg":"trace[2083336050] transaction","detail":"{read_only:false; response_revision:4418; number_of_response:1; }","duration":"108.976055ms","start":"2026-04-07T01:27:26.538997Z","end":"2026-04-07T01:27:26.647973Z","steps":["trace[2083336050] 'process raft request' (duration: 14.000846ms)","trace[2083336050] 'compare' (duration: 94.779936ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:27:27.246973Z","caller":"traceutil/trace.go:171","msg":"trace[1939166845] transaction","detail":"{read_only:false; response_revision:4466; number_of_response:1; }","duration":"109.067105ms","start":"2026-04-07T01:27:27.137862Z","end":"2026-04-07T01:27:27.246929Z","steps":["trace[1939166845] 'process raft request' (duration: 108.869192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:29.279672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.673117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T01:27:29.279741Z","caller":"traceutil/trace.go:171","msg":"trace[1188453420] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:4544; }","duration":"131.035623ms","start":"2026-04-07T01:27:29.148693Z","end":"2026-04-07T01:27:29.279728Z","steps":["trace[1188453420] 'range keys from in-memory index tree' (duration: 130.530655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:29.28004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.845591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-04-07T01:27:29.28006Z","caller":"traceutil/trace.go:171","msg":"trace[29594702] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4544; }","duration":"127.914013ms","start":"2026-04-07T01:27:29.152141Z","end":"2026-04-07T01:27:29.280055Z","steps":["trace[29594702] 'range keys from in-memory index tree' (duration: 127.71889ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:29.30328Z","caller":"traceutil/trace.go:171","msg":"trace[1963492435] transaction","detail":"{read_only:false; response_revision:4545; number_of_response:1; }","duration":"149.581154ms","start":"2026-04-07T01:27:29.153672Z","end":"2026-04-07T01:27:29.303253Z","steps":["trace[1963492435] 'process raft request' (duration: 149.403221ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:29.318101Z","caller":"traceutil/trace.go:171","msg":"trace[579048434] transaction","detail":"{read_only:false; response_revision:4546; number_of_response:1; }","duration":"163.266813ms","start":"2026-04-07T01:27:29.154806Z","end":"2026-04-07T01:27:29.318073Z","steps":["trace[579048434] 'process raft request' (duration: 162.970219ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:36.101448Z","caller":"traceutil/trace.go:171","msg":"trace[1965909495] linearizableReadLoop","detail":"{readStateIndex:4886; appliedIndex:4884; }","duration":"169.152102ms","start":"2026-04-07T01:27:35.93227Z","end":"2026-04-07T01:27:36.101422Z","steps":["trace[1965909495] 'read index received' (duration: 75.578848ms)","trace[1965909495] 'applied index is now lower than readState.Index' (duration: 93.571744ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:27:36.101605Z","caller":"traceutil/trace.go:171","msg":"trace[233969117] transaction","detail":"{read_only:false; response_revision:4706; number_of_response:1; }","duration":"183.517992ms","start":"2026-04-07T01:27:35.918056Z","end":"2026-04-07T01:27:36.101574Z","steps":["trace[233969117] 'process raft request' (duration: 144.741633ms)","trace[233969117] 'compare' (duration: 38.479923ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:27:36.101698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.406626ms","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-07T01:27:36.101736Z","caller":"traceutil/trace.go:171","msg":"trace[557000356] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4706; }","duration":"169.498177ms","start":"2026-04-07T01:27:35.932226Z","end":"2026-04-07T01:27:36.101724Z","steps":["trace[557000356] 'agreement among raft nodes before linearized reading' (duration: 169.343285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:36.101726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.258173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:27:36.102589Z","caller":"traceutil/trace.go:171","msg":"trace[1967924424] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4706; }","duration":"155.131307ms","start":"2026-04-07T01:27:35.947425Z","end":"2026-04-07T01:27:36.102556Z","steps":["trace[1967924424] 'agreement among raft nodes before linearized reading' (duration: 154.260714ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:41.840594Z","caller":"traceutil/trace.go:171","msg":"trace[1030463186] transaction","detail":"{read_only:false; response_revision:4756; number_of_response:1; }","duration":"118.541909ms","start":"2026-04-07T01:27:41.72203Z","end":"2026-04-07T01:27:41.840572Z","steps":["trace[1030463186] 'process raft request' (duration: 118.177123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:42.148343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.930962ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:27:42.148418Z","caller":"traceutil/trace.go:171","msg":"trace[473199017] linearizableReadLoop","detail":"{readStateIndex:4939; appliedIndex:4938; }","duration":"254.404231ms","start":"2026-04-07T01:27:41.894001Z","end":"2026-04-07T01:27:42.148406Z","steps":["trace[473199017] 'read index received' (duration: 77.356777ms)","trace[473199017] 'applied index is now lower than readState.Index' (duration: 177.046534ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:27:42.14849Z","caller":"traceutil/trace.go:171","msg":"trace[1718980663] transaction","detail":"{read_only:false; response_revision:4757; number_of_response:1; }","duration":"301.448986ms","start":"2026-04-07T01:27:41.84703Z","end":"2026-04-07T01:27:42.148479Z","steps":["trace[1718980663] 'process raft request' (duration: 124.329121ms)","trace[1718980663] 'compare' (duration: 176.845751ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:27:42.148558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:41.847011Z","time spent":"301.505898ms","remote":"127.0.0.1:49754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T01:27:42.148689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.547505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:27:42.148755Z","caller":"traceutil/trace.go:171","msg":"trace[909365597] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:4757; }","duration":"222.658957ms","start":"2026-04-07T01:27:41.926083Z","end":"2026-04-07T01:27:42.148742Z","steps":["trace[909365597] 'agreement among raft nodes before linearized reading' (duration: 222.525585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:42.148908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.026392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-07T01:27:42.148946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.639707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:27:42.148978Z","caller":"traceutil/trace.go:171","msg":"trace[1362650530] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4757; }","duration":"200.712169ms","start":"2026-04-07T01:27:41.948257Z","end":"2026-04-07T01:27:42.148969Z","steps":["trace[1362650530] 'agreement among raft nodes before linearized reading' (duration: 200.664058ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:42.148986Z","caller":"traceutil/trace.go:171","msg":"trace[385168594] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4757; }","duration":"110.170425ms","start":"2026-04-07T01:27:42.038795Z","end":"2026-04-07T01:27:42.148966Z","steps":["trace[385168594] 'agreement among raft nodes before linearized reading' (duration: 109.90735ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:42.14902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.01271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/ingress-nginx/\" range_end:\"/registry/secrets/ingress-nginx0\" ","response":"range_response_count:2 size:107259"} {"level":"info","ts":"2026-04-07T01:27:42.149065Z","caller":"traceutil/trace.go:171","msg":"trace[867917706] range","detail":"{range_begin:/registry/secrets/ingress-nginx/; range_end:/registry/secrets/ingress-nginx0; response_count:2; response_revision:4757; }","duration":"255.081671ms","start":"2026-04-07T01:27:41.893969Z","end":"2026-04-07T01:27:42.149051Z","steps":["trace[867917706] 'agreement among raft nodes before linearized reading' (duration: 254.906348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:42.532926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.147193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-node-lease/\" range_end:\"/registry/secrets/kube-node-lease0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:27:42.533009Z","caller":"traceutil/trace.go:171","msg":"trace[1941811769] range","detail":"{range_begin:/registry/secrets/kube-node-lease/; range_end:/registry/secrets/kube-node-lease0; response_count:0; response_revision:4761; }","duration":"120.288795ms","start":"2026-04-07T01:27:42.412699Z","end":"2026-04-07T01:27:42.532987Z","steps":["trace[1941811769] 'range keys from in-memory index tree' (duration: 120.034181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:42.533002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.487312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12971"} {"level":"info","ts":"2026-04-07T01:27:42.533162Z","caller":"traceutil/trace.go:171","msg":"trace[1145962195] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4761; }","duration":"102.702416ms","start":"2026-04-07T01:27:42.430427Z","end":"2026-04-07T01:27:42.53313Z","steps":["trace[1145962195] 'range keys from in-memory index tree' (duration: 102.266149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:42.533469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.225737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-67c8f8f646-gwk9r.18a3eed170a0146d\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-04-07T01:27:42.533833Z","caller":"traceutil/trace.go:171","msg":"trace[799790332] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-67c8f8f646-gwk9r.18a3eed170a0146d; range_end:; response_count:1; response_revision:4761; }","duration":"100.665094ms","start":"2026-04-07T01:27:42.433147Z","end":"2026-04-07T01:27:42.533812Z","steps":["trace[799790332] 'range keys from in-memory index tree' (duration: 99.971412ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:42.660029Z","caller":"traceutil/trace.go:171","msg":"trace[357189490] linearizableReadLoop","detail":"{readStateIndex:4944; appliedIndex:4943; }","duration":"123.243951ms","start":"2026-04-07T01:27:42.536757Z","end":"2026-04-07T01:27:42.660001Z","steps":["trace[357189490] 'read index received' (duration: 123.060979ms)","trace[357189490] 'applied index is now lower than readState.Index' (duration: 181.272µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:27:42.660124Z","caller":"traceutil/trace.go:171","msg":"trace[1493471906] transaction","detail":"{read_only:false; response_revision:4762; number_of_response:1; }","duration":"123.684589ms","start":"2026-04-07T01:27:42.536394Z","end":"2026-04-07T01:27:42.660078Z","steps":["trace[1493471906] 'process raft request' (duration: 123.442165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:42.66033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.551846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-1de33580-7ba4-4125-bc54-acf6021652a5\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-04-07T01:27:42.660542Z","caller":"traceutil/trace.go:171","msg":"trace[1363146060] range","detail":"{range_begin:/registry/persistentvolumes/pvc-1de33580-7ba4-4125-bc54-acf6021652a5; range_end:; response_count:1; response_revision:4762; }","duration":"123.803381ms","start":"2026-04-07T01:27:42.536723Z","end":"2026-04-07T01:27:42.660526Z","steps":["trace[1363146060] 'agreement among raft nodes before linearized reading' (duration: 123.407494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:42.708726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.177965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-public/\" range_end:\"/registry/secrets/kube-public0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:27:42.708797Z","caller":"traceutil/trace.go:171","msg":"trace[27110063] range","detail":"{range_begin:/registry/secrets/kube-public/; range_end:/registry/secrets/kube-public0; response_count:0; response_revision:4764; }","duration":"122.313178ms","start":"2026-04-07T01:27:42.586468Z","end":"2026-04-07T01:27:42.708781Z","steps":["trace[27110063] 'agreement among raft nodes before linearized reading' (duration: 122.164415ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:42.709165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.463994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-07T01:27:42.709239Z","caller":"traceutil/trace.go:171","msg":"trace[1014592942] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4764; }","duration":"152.582035ms","start":"2026-04-07T01:27:42.556638Z","end":"2026-04-07T01:27:42.70922Z","steps":["trace[1014592942] 'agreement among raft nodes before linearized reading' (duration: 152.380562ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:42.708528Z","caller":"traceutil/trace.go:171","msg":"trace[46989649] transaction","detail":"{read_only:false; response_revision:4763; number_of_response:1; }","duration":"161.847193ms","start":"2026-04-07T01:27:42.546653Z","end":"2026-04-07T01:27:42.7085Z","steps":["trace[46989649] 'process raft request' (duration: 161.548929ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:42.844474Z","caller":"traceutil/trace.go:171","msg":"trace[1230887557] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"129.821526ms","start":"2026-04-07T01:27:42.714591Z","end":"2026-04-07T01:27:42.844413Z","steps":["trace[1230887557] 'process raft request' (duration: 78.087566ms)","trace[1230887557] 'compare' (duration: 51.492605ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:27:42.84478Z","caller":"traceutil/trace.go:171","msg":"trace[1000870657] transaction","detail":"{read_only:false; response_revision:4767; number_of_response:1; }","duration":"127.895495ms","start":"2026-04-07T01:27:42.716853Z","end":"2026-04-07T01:27:42.844748Z","steps":["trace[1000870657] 'process raft request' (duration: 127.494739ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:42.845168Z","caller":"traceutil/trace.go:171","msg":"trace[949250689] transaction","detail":"{read_only:false; response_revision:4768; number_of_response:1; }","duration":"126.762828ms","start":"2026-04-07T01:27:42.718386Z","end":"2026-04-07T01:27:42.845149Z","steps":["trace[949250689] 'process raft request' (duration: 126.25219ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:42.845216Z","caller":"traceutil/trace.go:171","msg":"trace[2050394479] linearizableReadLoop","detail":"{readStateIndex:4948; appliedIndex:4946; }","duration":"130.397375ms","start":"2026-04-07T01:27:42.714793Z","end":"2026-04-07T01:27:42.84519Z","steps":["trace[2050394479] 'read index received' (duration: 17.62633ms)","trace[2050394479] 'applied index is now lower than readState.Index' (duration: 112.770245ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:27:42.84539Z","caller":"traceutil/trace.go:171","msg":"trace[356616957] transaction","detail":"{read_only:false; response_revision:4769; number_of_response:1; }","duration":"126.9432ms","start":"2026-04-07T01:27:42.718437Z","end":"2026-04-07T01:27:42.84538Z","steps":["trace[356616957] 'process raft request' (duration: 126.549424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:42.845701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.828293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16228"} {"level":"info","ts":"2026-04-07T01:27:42.847071Z","caller":"traceutil/trace.go:171","msg":"trace[628040211] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4769; }","duration":"132.235514ms","start":"2026-04-07T01:27:42.714812Z","end":"2026-04-07T01:27:42.847047Z","steps":["trace[628040211] 'agreement among raft nodes before linearized reading' (duration: 130.67964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:42.84574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.915603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-d087c30e-f4a5-4198-add8-5faa87cfde01\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-04-07T01:27:42.847306Z","caller":"traceutil/trace.go:171","msg":"trace[265135541] range","detail":"{range_begin:/registry/persistentvolumes/pvc-d087c30e-f4a5-4198-add8-5faa87cfde01; range_end:; response_count:1; response_revision:4769; }","duration":"132.487778ms","start":"2026-04-07T01:27:42.714786Z","end":"2026-04-07T01:27:42.847273Z","steps":["trace[265135541] 'agreement among raft nodes before linearized reading' (duration: 130.74983ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:19.161759Z","caller":"traceutil/trace.go:171","msg":"trace[83574998] linearizableReadLoop","detail":"{readStateIndex:5244; appliedIndex:5243; }","duration":"111.075293ms","start":"2026-04-07T01:28:19.050662Z","end":"2026-04-07T01:28:19.161737Z","steps":["trace[83574998] 'read index received' (duration: 110.87116ms)","trace[83574998] 'applied index is now lower than readState.Index' (duration: 203.133µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:28:19.161896Z","caller":"traceutil/trace.go:171","msg":"trace[258820626] transaction","detail":"{read_only:false; response_revision:5052; number_of_response:1; }","duration":"114.513485ms","start":"2026-04-07T01:28:19.047371Z","end":"2026-04-07T01:28:19.161884Z","steps":["trace[258820626] 'process raft request' (duration: 114.19424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:19.16255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.804903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/cilium-config-agent\" ","response":"range_response_count:1 size:790"} {"level":"info","ts":"2026-04-07T01:28:19.162671Z","caller":"traceutil/trace.go:171","msg":"trace[318528039] range","detail":"{range_begin:/registry/rolebindings/kube-system/cilium-config-agent; range_end:; response_count:1; response_revision:5052; }","duration":"112.049167ms","start":"2026-04-07T01:28:19.050596Z","end":"2026-04-07T01:28:19.162646Z","steps":["trace[318528039] 'agreement among raft nodes before linearized reading' (duration: 111.5556ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:19.369697Z","caller":"traceutil/trace.go:171","msg":"trace[122834714] linearizableReadLoop","detail":"{readStateIndex:5245; appliedIndex:5244; }","duration":"188.542445ms","start":"2026-04-07T01:28:19.181108Z","end":"2026-04-07T01:28:19.369651Z","steps":["trace[122834714] 'read index received' (duration: 185.659991ms)","trace[122834714] 'applied index is now lower than readState.Index' (duration: 2.880914ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:28:19.369906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.777638ms","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-07T01:28:19.36999Z","caller":"traceutil/trace.go:171","msg":"trace[572985260] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5052; }","duration":"188.934811ms","start":"2026-04-07T01:28:19.181036Z","end":"2026-04-07T01:28:19.36997Z","steps":["trace[572985260] 'agreement among raft nodes before linearized reading' (duration: 188.720277ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:19.370626Z","caller":"traceutil/trace.go:171","msg":"trace[275480473] transaction","detail":"{read_only:false; response_revision:5053; number_of_response:1; }","duration":"117.761034ms","start":"2026-04-07T01:28:19.25284Z","end":"2026-04-07T01:28:19.370601Z","steps":["trace[275480473] 'process raft request' (duration: 117.384038ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:19.370719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.431233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kubeadm:kubeadm-certs\" ","response":"range_response_count:1 size:483"} {"level":"info","ts":"2026-04-07T01:28:19.370793Z","caller":"traceutil/trace.go:171","msg":"trace[584822445] range","detail":"{range_begin:/registry/rolebindings/kube-system/kubeadm:kubeadm-certs; range_end:; response_count:1; response_revision:5053; }","duration":"116.565525ms","start":"2026-04-07T01:28:19.254211Z","end":"2026-04-07T01:28:19.370777Z","steps":["trace[584822445] 'agreement among raft nodes before linearized reading' (duration: 116.401742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:19.370802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.065129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kube-proxy\" ","response":"range_response_count:1 size:450"} {"level":"info","ts":"2026-04-07T01:28:19.371065Z","caller":"traceutil/trace.go:171","msg":"trace[1945958930] range","detail":"{range_begin:/registry/rolebindings/kube-system/kube-proxy; range_end:; response_count:1; response_revision:5053; }","duration":"126.402054ms","start":"2026-04-07T01:28:19.244638Z","end":"2026-04-07T01:28:19.37104Z","steps":["trace[1945958930] 'agreement among raft nodes before linearized reading' (duration: 125.770415ms)"],"step_count":1}