{"level":"warn","ts":"2026-04-07T01:26:42.071345Z","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:26:42.071427Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53: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.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53: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:26:42.071495Z","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:26:42.071508Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-04-07T01:26:42.071528Z","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:26:42.07214Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]} {"level":"info","ts":"2026-04-07T01:26:42.072224Z","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.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53: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:26:42.079772Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.352475ms"} {"level":"info","ts":"2026-04-07T01:26:42.092206Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"} {"level":"info","ts":"2026-04-07T01:26:42.092347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T01:26:42.092406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"} {"level":"info","ts":"2026-04-07T01:26:42.092533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T01:26:42.092573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"} {"level":"info","ts":"2026-04-07T01:26:42.092631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"warn","ts":"2026-04-07T01:26:42.105284Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T01:26:42.108552Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T01:26:42.110593Z","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:26:42.113124Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T01:26:42.113295Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T01:26:42.113423Z","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:26:42.113458Z","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:26:42.113469Z","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:26:42.115741Z","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:26:42.115841Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-04-07T01:26:42.115895Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-04-07T01:26:42.116016Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T01:26:42.116075Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T01:26:42.118425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"info","ts":"2026-04-07T01:26:42.118705Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-04-07T01:26:42.194474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T01:26:42.19463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T01:26:42.194672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"} {"level":"info","ts":"2026-04-07T01:26:42.1947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"} {"level":"info","ts":"2026-04-07T01:26:42.194713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-04-07T01:26:42.194732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"} {"level":"info","ts":"2026-04-07T01:26:42.194754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-04-07T01:26:42.196112Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:26:42.197082Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T01:26:42.197274Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:26:42.197314Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:26:42.202676Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:26:42.20302Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T01:26:42.203068Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T01:26:42.203297Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:26:42.203578Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:26:42.203692Z","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:26:42.204354Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"} {"level":"info","ts":"2026-04-07T01:26:44.976795Z","caller":"traceutil/trace.go:171","msg":"trace[103156836] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"261.744953ms","start":"2026-04-07T01:26:44.715025Z","end":"2026-04-07T01:26:44.97677Z","steps":["trace[103156836] 'read index received' (duration: 261.641961ms)","trace[103156836] 'applied index is now lower than readState.Index' (duration: 102.142µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:44.976922Z","caller":"traceutil/trace.go:171","msg":"trace[835311842] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"263.321421ms","start":"2026-04-07T01:26:44.71356Z","end":"2026-04-07T01:26:44.976881Z","steps":["trace[835311842] 'process raft request' (duration: 263.073325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:44.977006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.652112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T01:26:44.977005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.957288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T01:26:44.977081Z","caller":"traceutil/trace.go:171","msg":"trace[1170593815] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:72; }","duration":"160.782414ms","start":"2026-04-07T01:26:44.816286Z","end":"2026-04-07T01:26:44.977068Z","steps":["trace[1170593815] 'agreement among raft nodes before linearized reading' (duration: 160.638031ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:44.977095Z","caller":"traceutil/trace.go:171","msg":"trace[1407739980] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:72; }","duration":"262.069981ms","start":"2026-04-07T01:26:44.715009Z","end":"2026-04-07T01:26:44.977079Z","steps":["trace[1407739980] 'agreement among raft nodes before linearized reading' (duration: 261.897487ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:00.314079Z","caller":"traceutil/trace.go:171","msg":"trace[647219911] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"175.787723ms","start":"2026-04-07T01:27:00.138251Z","end":"2026-04-07T01:27:00.314039Z","steps":["trace[647219911] 'process raft request' (duration: 153.060881ms)","trace[647219911] 'compare' (duration: 22.452216ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:27:00.600552Z","caller":"traceutil/trace.go:171","msg":"trace[111136004] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"282.013096ms","start":"2026-04-07T01:27:00.318511Z","end":"2026-04-07T01:27:00.600524Z","steps":["trace[111136004] 'process raft request' (duration: 221.213586ms)","trace[111136004] 'compare' (duration: 60.685957ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:27:00.95176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.007601ms","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:00.951924Z","caller":"traceutil/trace.go:171","msg":"trace[1083940305] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:410; }","duration":"117.218447ms","start":"2026-04-07T01:27:00.834685Z","end":"2026-04-07T01:27:00.951903Z","steps":["trace[1083940305] 'range keys from in-memory index tree' (duration: 116.941039ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:10.558728Z","caller":"traceutil/trace.go:171","msg":"trace[1218931478] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"165.614901ms","start":"2026-04-07T01:27:10.393087Z","end":"2026-04-07T01:27:10.558702Z","steps":["trace[1218931478] 'process raft request' (duration: 165.487548ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:13.30515Z","caller":"traceutil/trace.go:171","msg":"trace[2019332488] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"106.208979ms","start":"2026-04-07T01:27:13.198915Z","end":"2026-04-07T01:27:13.305124Z","steps":["trace[2019332488] 'process raft request' (duration: 105.894302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:13.593522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.232681ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:27:13.593636Z","caller":"traceutil/trace.go:171","msg":"trace[976355589] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"262.465031ms","start":"2026-04-07T01:27:13.331155Z","end":"2026-04-07T01:27:13.59362Z","steps":["trace[976355589] 'process raft request' (duration: 50.561975ms)","trace[976355589] 'compare' (duration: 211.054547ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:27:13.607455Z","caller":"traceutil/trace.go:171","msg":"trace[1709393769] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"231.634069ms","start":"2026-04-07T01:27:13.375792Z","end":"2026-04-07T01:27:13.607426Z","steps":["trace[1709393769] 'process raft request' (duration: 231.375593ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:13.832181Z","caller":"traceutil/trace.go:171","msg":"trace[646783535] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"184.360871ms","start":"2026-04-07T01:27:13.647794Z","end":"2026-04-07T01:27:13.832154Z","steps":["trace[646783535] 'process raft request' (duration: 184.316649ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:13.832465Z","caller":"traceutil/trace.go:171","msg":"trace[406186767] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"209.360017ms","start":"2026-04-07T01:27:13.62307Z","end":"2026-04-07T01:27:13.83243Z","steps":["trace[406186767] 'process raft request' (duration: 208.929606ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:13.832915Z","caller":"traceutil/trace.go:171","msg":"trace[2021359483] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"229.302345ms","start":"2026-04-07T01:27:13.60359Z","end":"2026-04-07T01:27:13.832892Z","steps":["trace[2021359483] 'process raft request' (duration: 142.288446ms)","trace[2021359483] 'compare' (duration: 85.742529ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:27:19.004304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.430131ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:27:19.004434Z","caller":"traceutil/trace.go:171","msg":"trace[1203678020] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"280.422282ms","start":"2026-04-07T01:27:18.723987Z","end":"2026-04-07T01:27:19.004409Z","steps":["trace[1203678020] 'process raft request' (duration: 84.792337ms)","trace[1203678020] 'compare' (duration: 194.99329ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:27:19.30334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.468891ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:27:19.303446Z","caller":"traceutil/trace.go:171","msg":"trace[1063184932] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"283.804413ms","start":"2026-04-07T01:27:19.019625Z","end":"2026-04-07T01:27:19.30343Z","steps":["trace[1063184932] 'process raft request' (duration: 132.175028ms)","trace[1063184932] 'compare' (duration: 150.273823ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:27:20.059206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.960138ms","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:20.059304Z","caller":"traceutil/trace.go:171","msg":"trace[1769126480] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"244.115291ms","start":"2026-04-07T01:27:19.815167Z","end":"2026-04-07T01:27:20.059282Z","steps":["trace[1769126480] 'range keys from in-memory index tree' (duration: 243.888486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:20.059287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.659402ms","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:20.059364Z","caller":"traceutil/trace.go:171","msg":"trace[241682752] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"223.778084ms","start":"2026-04-07T01:27:19.835566Z","end":"2026-04-07T01:27:20.059344Z","steps":["trace[241682752] 'range keys from in-memory index tree' (duration: 223.586709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:20.059398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.977781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:27:20.059497Z","caller":"traceutil/trace.go:171","msg":"trace[1463683772] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:582; }","duration":"652.116583ms","start":"2026-04-07T01:27:19.407352Z","end":"2026-04-07T01:27:20.059469Z","steps":["trace[1463683772] 'range keys from in-memory index tree' (duration: 651.900969ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:20.05955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:19.407334Z","time spent":"652.203606ms","remote":"127.0.0.1:53482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-04-07T01:27:37.442204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.014955ms","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:27:37.442271Z","caller":"traceutil/trace.go:171","msg":"trace[347537037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:750; }","duration":"324.137698ms","start":"2026-04-07T01:27:37.118119Z","end":"2026-04-07T01:27:37.442257Z","steps":["trace[347537037] 'range keys from in-memory index tree' (duration: 323.86851ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:37.442302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:27:37.118099Z","time spent":"324.196509ms","remote":"127.0.0.1:53516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T01:27:39.66721Z","caller":"traceutil/trace.go:171","msg":"trace[1512288927] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"121.978299ms","start":"2026-04-07T01:27:39.545207Z","end":"2026-04-07T01:27:39.667186Z","steps":["trace[1512288927] 'process raft request' (duration: 121.803085ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:39.668293Z","caller":"traceutil/trace.go:171","msg":"trace[1202990386] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"122.920861ms","start":"2026-04-07T01:27:39.545343Z","end":"2026-04-07T01:27:39.668263Z","steps":["trace[1202990386] 'process raft request' (duration: 122.735337ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:05.960473Z","caller":"traceutil/trace.go:171","msg":"trace[79434492] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"133.94403ms","start":"2026-04-07T01:28:05.826501Z","end":"2026-04-07T01:28:05.960445Z","steps":["trace[79434492] 'process raft request' (duration: 133.694194ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:05.960531Z","caller":"traceutil/trace.go:171","msg":"trace[765326792] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"133.831397ms","start":"2026-04-07T01:28:05.826591Z","end":"2026-04-07T01:28:05.960422Z","steps":["trace[765326792] 'process raft request' (duration: 133.777966ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:28.185269Z","caller":"traceutil/trace.go:171","msg":"trace[783092583] linearizableReadLoop","detail":"{readStateIndex:1451; appliedIndex:1450; }","duration":"112.634769ms","start":"2026-04-07T01:28:28.072601Z","end":"2026-04-07T01:28:28.185236Z","steps":["trace[783092583] 'read index received' (duration: 112.444474ms)","trace[783092583] 'applied index is now lower than readState.Index' (duration: 189.455µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:28:28.18536Z","caller":"traceutil/trace.go:171","msg":"trace[646455495] transaction","detail":"{read_only:false; response_revision:1404; number_of_response:1; }","duration":"120.142462ms","start":"2026-04-07T01:28:28.065178Z","end":"2026-04-07T01:28:28.18532Z","steps":["trace[646455495] 'process raft request' (duration: 119.887776ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:28.185454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.826653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-07T01:28:28.18549Z","caller":"traceutil/trace.go:171","msg":"trace[1930016575] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1404; }","duration":"112.897034ms","start":"2026-04-07T01:28:28.072584Z","end":"2026-04-07T01:28:28.185481Z","steps":["trace[1930016575] 'agreement among raft nodes before linearized reading' (duration: 112.747451ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:52.931135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.240933ms","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:28:52.931229Z","caller":"traceutil/trace.go:171","msg":"trace[1147535750] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1815; }","duration":"152.394896ms","start":"2026-04-07T01:28:52.778817Z","end":"2026-04-07T01:28:52.931212Z","steps":["trace[1147535750] 'range keys from in-memory index tree' (duration: 152.040978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:52.931371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.763567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-07T01:28:52.931371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.359501ms","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":"warn","ts":"2026-04-07T01:28:52.931408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.822878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:28:52.931453Z","caller":"traceutil/trace.go:171","msg":"trace[1053033007] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1815; }","duration":"118.504714ms","start":"2026-04-07T01:28:52.812931Z","end":"2026-04-07T01:28:52.931436Z","steps":["trace[1053033007] 'count revisions from in-memory index tree' (duration: 118.30837ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:52.931454Z","caller":"traceutil/trace.go:171","msg":"trace[411359837] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1815; }","duration":"270.90981ms","start":"2026-04-07T01:28:52.660522Z","end":"2026-04-07T01:28:52.931431Z","steps":["trace[411359837] 'count revisions from in-memory index tree' (duration: 270.660044ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:52.931498Z","caller":"traceutil/trace.go:171","msg":"trace[1547427790] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1815; }","duration":"120.96884ms","start":"2026-04-07T01:28:52.810511Z","end":"2026-04-07T01:28:52.93148Z","steps":["trace[1547427790] 'count revisions from in-memory index tree' (duration: 120.736925ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:53.046985Z","caller":"traceutil/trace.go:171","msg":"trace[191100841] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"111.154594ms","start":"2026-04-07T01:28:52.935807Z","end":"2026-04-07T01:28:53.046962Z","steps":["trace[191100841] 'process raft request' (duration: 111.009941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:53.540225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.985313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:28:53.540329Z","caller":"traceutil/trace.go:171","msg":"trace[1465711649] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1820; }","duration":"128.147507ms","start":"2026-04-07T01:28:53.412149Z","end":"2026-04-07T01:28:53.540297Z","steps":["trace[1465711649] 'count revisions from in-memory index tree' (duration: 127.867061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:53.54039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.46557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-07T01:28:53.540473Z","caller":"traceutil/trace.go:171","msg":"trace[892792389] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1820; }","duration":"273.560762ms","start":"2026-04-07T01:28:53.26689Z","end":"2026-04-07T01:28:53.54045Z","steps":["trace[892792389] 'range keys from in-memory index tree' (duration: 273.309335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:53.540706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.720841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-07T01:28:53.54104Z","caller":"traceutil/trace.go:171","msg":"trace[1550224804] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1820; }","duration":"260.073219ms","start":"2026-04-07T01:28:53.280946Z","end":"2026-04-07T01:28:53.541019Z","steps":["trace[1550224804] 'range keys from in-memory index tree' (duration: 259.197429ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:00.268943Z","caller":"traceutil/trace.go:171","msg":"trace[810504635] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"110.834427ms","start":"2026-04-07T01:29:00.158079Z","end":"2026-04-07T01:29:00.268913Z","steps":["trace[810504635] 'process raft request' (duration: 29.152613ms)","trace[810504635] 'compare' (duration: 81.51764ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:29:00.288005Z","caller":"traceutil/trace.go:171","msg":"trace[574793130] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"129.282282ms","start":"2026-04-07T01:29:00.158692Z","end":"2026-04-07T01:29:00.287974Z","steps":["trace[574793130] 'process raft request' (duration: 129.038386ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:07.652011Z","caller":"traceutil/trace.go:171","msg":"trace[842192621] linearizableReadLoop","detail":"{readStateIndex:2016; appliedIndex:2015; }","duration":"313.342649ms","start":"2026-04-07T01:29:07.338647Z","end":"2026-04-07T01:29:07.65199Z","steps":["trace[842192621] 'read index received' (duration: 313.248266ms)","trace[842192621] 'applied index is now lower than readState.Index' (duration: 93.543µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:29:07.652077Z","caller":"traceutil/trace.go:171","msg":"trace[1688513427] transaction","detail":"{read_only:false; response_revision:1938; number_of_response:1; }","duration":"368.553843ms","start":"2026-04-07T01:29:07.283491Z","end":"2026-04-07T01:29:07.652044Z","steps":["trace[1688513427] 'process raft request' (duration: 368.346807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:29:07.652187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.523943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-messaging-topology-operator-6f465c979f-plc2p\" ","response":"range_response_count:1 size:6143"} {"level":"info","ts":"2026-04-07T01:29:07.652216Z","caller":"traceutil/trace.go:171","msg":"trace[1251013430] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-messaging-topology-operator-6f465c979f-plc2p; range_end:; response_count:1; response_revision:1938; }","duration":"313.597135ms","start":"2026-04-07T01:29:07.338609Z","end":"2026-04-07T01:29:07.652206Z","steps":["trace[1251013430] 'agreement among raft nodes before linearized reading' (duration: 313.485573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:29:07.652239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:29:07.338591Z","time spent":"313.643056ms","remote":"127.0.0.1:53424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":6167,"request content":"key:\"/registry/pods/openstack/rabbitmq-messaging-topology-operator-6f465c979f-plc2p\" "} {"level":"warn","ts":"2026-04-07T01:29:07.652239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:29:07.283473Z","time spent":"368.678766ms","remote":"127.0.0.1:53516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:29:07.65241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.676501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:29:07.652635Z","caller":"traceutil/trace.go:171","msg":"trace[1013419374] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1938; }","duration":"275.945407ms","start":"2026-04-07T01:29:07.376681Z","end":"2026-04-07T01:29:07.652627Z","steps":["trace[1013419374] 'agreement among raft nodes before linearized reading' (duration: 275.689271ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:38.471303Z","caller":"traceutil/trace.go:171","msg":"trace[1770721929] linearizableReadLoop","detail":"{readStateIndex:2205; appliedIndex:2204; }","duration":"138.071541ms","start":"2026-04-07T01:29:38.333203Z","end":"2026-04-07T01:29:38.471274Z","steps":["trace[1770721929] 'read index received' (duration: 137.954898ms)","trace[1770721929] 'applied index is now lower than readState.Index' (duration: 115.373µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:29:38.471508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.276445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:29:38.471551Z","caller":"traceutil/trace.go:171","msg":"trace[878221995] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2121; }","duration":"138.373798ms","start":"2026-04-07T01:29:38.333168Z","end":"2026-04-07T01:29:38.471541Z","steps":["trace[878221995] 'agreement among raft nodes before linearized reading' (duration: 138.210944ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:38.471568Z","caller":"traceutil/trace.go:171","msg":"trace[1635051764] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"140.611379ms","start":"2026-04-07T01:29:38.330849Z","end":"2026-04-07T01:29:38.47146Z","steps":["trace[1635051764] 'process raft request' (duration: 140.258181ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:38.697156Z","caller":"traceutil/trace.go:171","msg":"trace[1113220008] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"101.194171ms","start":"2026-04-07T01:29:38.595937Z","end":"2026-04-07T01:29:38.697131Z","steps":["trace[1113220008] 'process raft request' (duration: 58.575547ms)","trace[1113220008] 'compare' (duration: 42.45976ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:29:43.953328Z","caller":"traceutil/trace.go:171","msg":"trace[1689573473] linearizableReadLoop","detail":"{readStateIndex:2235; appliedIndex:2234; }","duration":"114.994355ms","start":"2026-04-07T01:29:43.83831Z","end":"2026-04-07T01:29:43.953305Z","steps":["trace[1689573473] 'read index received' (duration: 114.77222ms)","trace[1689573473] 'applied index is now lower than readState.Index' (duration: 221.135µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:29:43.953441Z","caller":"traceutil/trace.go:171","msg":"trace[1277390524] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"115.219699ms","start":"2026-04-07T01:29:43.838183Z","end":"2026-04-07T01:29:43.953403Z","steps":["trace[1277390524] 'process raft request' (duration: 114.971454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:29:43.953556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.22679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:29:43.953663Z","caller":"traceutil/trace.go:171","msg":"trace[355050940] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2150; }","duration":"115.373253ms","start":"2026-04-07T01:29:43.838268Z","end":"2026-04-07T01:29:43.953641Z","steps":["trace[355050940] 'agreement among raft nodes before linearized reading' (duration: 115.169558ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:29:43.953808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.152699ms","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-07T01:29:43.953891Z","caller":"traceutil/trace.go:171","msg":"trace[351114298] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2150; }","duration":"101.272201ms","start":"2026-04-07T01:29:43.852605Z","end":"2026-04-07T01:29:43.953877Z","steps":["trace[351114298] 'agreement among raft nodes before linearized reading' (duration: 100.981544ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:44.834902Z","caller":"traceutil/trace.go:171","msg":"trace[1449084278] linearizableReadLoop","detail":"{readStateIndex:2239; appliedIndex:2238; }","duration":"105.180851ms","start":"2026-04-07T01:29:44.729699Z","end":"2026-04-07T01:29:44.83488Z","steps":["trace[1449084278] 'read index received' (duration: 104.976536ms)","trace[1449084278] 'applied index is now lower than readState.Index' (duration: 203.465µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:29:44.834989Z","caller":"traceutil/trace.go:171","msg":"trace[1570174040] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"118.100317ms","start":"2026-04-07T01:29:44.716841Z","end":"2026-04-07T01:29:44.834941Z","steps":["trace[1570174040] 'process raft request' (duration: 117.913773ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:29:44.835069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.385157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:29:44.835111Z","caller":"traceutil/trace.go:171","msg":"trace[115680528] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:2154; }","duration":"102.492ms","start":"2026-04-07T01:29:44.732609Z","end":"2026-04-07T01:29:44.835101Z","steps":["trace[115680528] 'agreement among raft nodes before linearized reading' (duration: 102.405398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:29:44.83516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.390916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-07T01:29:44.835159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.438497ms","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:29:44.835222Z","caller":"traceutil/trace.go:171","msg":"trace[294022032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2154; }","duration":"101.479827ms","start":"2026-04-07T01:29:44.733728Z","end":"2026-04-07T01:29:44.835207Z","steps":["trace[294022032] 'agreement among raft nodes before linearized reading' (duration: 101.306093ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:44.835239Z","caller":"traceutil/trace.go:171","msg":"trace[866686797] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2154; }","duration":"105.57401ms","start":"2026-04-07T01:29:44.729646Z","end":"2026-04-07T01:29:44.83522Z","steps":["trace[866686797] 'agreement among raft nodes before linearized reading' (duration: 105.336075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:29:45.228289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.826417ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:29:45.228477Z","caller":"traceutil/trace.go:171","msg":"trace[1548322565] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"389.371467ms","start":"2026-04-07T01:29:44.83908Z","end":"2026-04-07T01:29:45.228452Z","steps":["trace[1548322565] 'process raft request' (duration: 389.313226ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:45.228485Z","caller":"traceutil/trace.go:171","msg":"trace[210789208] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"389.389447ms","start":"2026-04-07T01:29:44.839068Z","end":"2026-04-07T01:29:45.228457Z","steps":["trace[210789208] 'process raft request' (duration: 134.317515ms)","trace[210789208] 'compare' (duration: 254.703504ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:29:45.228547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:29:44.839061Z","time spent":"389.45753ms","remote":"127.0.0.1:53516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:29:45.228635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:29:44.839038Z","time spent":"389.514791ms","remote":"127.0.0.1:53516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:29:50.708557Z","caller":"traceutil/trace.go:171","msg":"trace[1479798487] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"174.456742ms","start":"2026-04-07T01:29:50.534062Z","end":"2026-04-07T01:29:50.708519Z","steps":["trace[1479798487] 'process raft request' (duration: 174.192436ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:31:12.753249Z","caller":"traceutil/trace.go:171","msg":"trace[1903716554] linearizableReadLoop","detail":"{readStateIndex:2933; appliedIndex:2932; }","duration":"274.383195ms","start":"2026-04-07T01:31:12.478838Z","end":"2026-04-07T01:31:12.753222Z","steps":["trace[1903716554] 'read index received' (duration: 274.276493ms)","trace[1903716554] 'applied index is now lower than readState.Index' (duration: 105.172µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:31:12.753417Z","caller":"traceutil/trace.go:171","msg":"trace[1406804076] transaction","detail":"{read_only:false; response_revision:2821; number_of_response:1; }","duration":"475.59597ms","start":"2026-04-07T01:31:12.27776Z","end":"2026-04-07T01:31:12.753356Z","steps":["trace[1406804076] 'process raft request' (duration: 475.311504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:31:12.753695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.808264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"warn","ts":"2026-04-07T01:31:12.753533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.466006ms","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-07T01:31:12.753819Z","caller":"traceutil/trace.go:171","msg":"trace[419017974] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2821; }","duration":"218.829304ms","start":"2026-04-07T01:31:12.534974Z","end":"2026-04-07T01:31:12.753804Z","steps":["trace[419017974] 'agreement among raft nodes before linearized reading' (duration: 218.407665ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:31:12.753831Z","caller":"traceutil/trace.go:171","msg":"trace[241202106] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2821; }","duration":"275.014629ms","start":"2026-04-07T01:31:12.478785Z","end":"2026-04-07T01:31:12.753799Z","steps":["trace[241202106] 'agreement among raft nodes before linearized reading' (duration: 274.60812ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:31:12.753841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:31:12.27774Z","time spent":"475.893897ms","remote":"127.0.0.1:53516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:33:12.766724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.992701ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:33:12.766894Z","caller":"traceutil/trace.go:171","msg":"trace[1540629957] linearizableReadLoop","detail":"{readStateIndex:3763; appliedIndex:3762; }","duration":"266.4262ms","start":"2026-04-07T01:33:12.500444Z","end":"2026-04-07T01:33:12.76687Z","steps":["trace[1540629957] 'read index received' (duration: 112.168783ms)","trace[1540629957] 'applied index is now lower than readState.Index' (duration: 154.255727ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:33:12.766943Z","caller":"traceutil/trace.go:171","msg":"trace[883493320] transaction","detail":"{read_only:false; response_revision:3620; number_of_response:1; }","duration":"277.097695ms","start":"2026-04-07T01:33:12.489788Z","end":"2026-04-07T01:33:12.766886Z","steps":["trace[883493320] 'process raft request' (duration: 122.831527ms)","trace[883493320] 'compare' (duration: 153.736935ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:33:12.767097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.650735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/secretgen-controller/secretgen-controller-sa\" ","response":"range_response_count:1 size:230"} {"level":"info","ts":"2026-04-07T01:33:12.76714Z","caller":"traceutil/trace.go:171","msg":"trace[276694372] range","detail":"{range_begin:/registry/serviceaccounts/secretgen-controller/secretgen-controller-sa; range_end:; response_count:1; response_revision:3620; }","duration":"266.743478ms","start":"2026-04-07T01:33:12.500382Z","end":"2026-04-07T01:33:12.767125Z","steps":["trace[276694372] 'agreement among raft nodes before linearized reading' (duration: 266.548464ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:44.384959Z","caller":"traceutil/trace.go:171","msg":"trace[1967972930] transaction","detail":"{read_only:false; response_revision:3820; number_of_response:1; }","duration":"208.269055ms","start":"2026-04-07T01:33:44.176648Z","end":"2026-04-07T01:33:44.384917Z","steps":["trace[1967972930] 'process raft request' (duration: 208.003249ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:33:44.496094Z","caller":"traceutil/trace.go:171","msg":"trace[1938465199] linearizableReadLoop","detail":"{readStateIndex:3970; appliedIndex:3968; }","duration":"286.23896ms","start":"2026-04-07T01:33:44.209825Z","end":"2026-04-07T01:33:44.496064Z","steps":["trace[1938465199] 'read index received' (duration: 174.792154ms)","trace[1938465199] 'applied index is now lower than readState.Index' (duration: 111.445236ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:33:44.496129Z","caller":"traceutil/trace.go:171","msg":"trace[1668347644] transaction","detail":"{read_only:false; response_revision:3821; number_of_response:1; }","duration":"318.959964ms","start":"2026-04-07T01:33:44.177136Z","end":"2026-04-07T01:33:44.496096Z","steps":["trace[1668347644] 'process raft request' (duration: 314.719446ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:33:44.496298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.391364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:33:44.496304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:33:44.177111Z","time spent":"319.102217ms","remote":"127.0.0.1:53516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:33:44.496344Z","caller":"traceutil/trace.go:171","msg":"trace[1101312954] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:3821; }","duration":"286.565277ms","start":"2026-04-07T01:33:44.209767Z","end":"2026-04-07T01:33:44.496333Z","steps":["trace[1101312954] 'agreement among raft nodes before linearized reading' (duration: 286.406224ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:08.335515Z","caller":"traceutil/trace.go:171","msg":"trace[2141651997] transaction","detail":"{read_only:false; response_revision:4804; number_of_response:1; }","duration":"271.179455ms","start":"2026-04-07T01:35:08.06431Z","end":"2026-04-07T01:35:08.335489Z","steps":["trace[2141651997] 'process raft request' (duration: 271.011961ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:08.336588Z","caller":"traceutil/trace.go:171","msg":"trace[1237999618] transaction","detail":"{read_only:false; response_revision:4805; number_of_response:1; }","duration":"202.238437ms","start":"2026-04-07T01:35:08.134325Z","end":"2026-04-07T01:35:08.336564Z","steps":["trace[1237999618] 'process raft request' (duration: 202.065883ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:10.231809Z","caller":"traceutil/trace.go:171","msg":"trace[428155427] transaction","detail":"{read_only:false; response_revision:4838; number_of_response:1; }","duration":"139.327218ms","start":"2026-04-07T01:35:10.092458Z","end":"2026-04-07T01:35:10.231785Z","steps":["trace[428155427] 'process raft request' (duration: 139.182465ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:10.231829Z","caller":"traceutil/trace.go:171","msg":"trace[1183817074] linearizableReadLoop","detail":"{readStateIndex:5029; appliedIndex:5026; }","duration":"138.920069ms","start":"2026-04-07T01:35:10.092889Z","end":"2026-04-07T01:35:10.231809Z","steps":["trace[1183817074] 'read index received' (duration: 25.35832ms)","trace[1183817074] 'applied index is now lower than readState.Index' (duration: 113.560619ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:35:10.231939Z","caller":"traceutil/trace.go:171","msg":"trace[1951846707] transaction","detail":"{read_only:false; response_revision:4839; number_of_response:1; }","duration":"138.899158ms","start":"2026-04-07T01:35:10.093029Z","end":"2026-04-07T01:35:10.231928Z","steps":["trace[1951846707] 'process raft request' (duration: 138.643713ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:10.232018Z","caller":"traceutil/trace.go:171","msg":"trace[1144844979] transaction","detail":"{read_only:false; response_revision:4837; number_of_response:1; }","duration":"139.800259ms","start":"2026-04-07T01:35:10.09221Z","end":"2026-04-07T01:35:10.23201Z","steps":["trace[1144844979] 'process raft request' (duration: 132.44277ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:10.232087Z","caller":"traceutil/trace.go:171","msg":"trace[719063203] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"138.404717ms","start":"2026-04-07T01:35:10.093673Z","end":"2026-04-07T01:35:10.232078Z","steps":["trace[719063203] 'process raft request' (duration: 138.027808ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:10.232169Z","caller":"traceutil/trace.go:171","msg":"trace[1522073019] transaction","detail":"{read_only:false; response_revision:4842; number_of_response:1; }","duration":"124.431917ms","start":"2026-04-07T01:35:10.107729Z","end":"2026-04-07T01:35:10.232161Z","steps":["trace[1522073019] 'process raft request' (duration: 124.019827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:35:10.232288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.381409ms","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-07T01:35:10.23232Z","caller":"traceutil/trace.go:171","msg":"trace[1914099407] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4842; }","duration":"139.448881ms","start":"2026-04-07T01:35:10.092862Z","end":"2026-04-07T01:35:10.232311Z","steps":["trace[1914099407] 'agreement among raft nodes before linearized reading' (duration: 139.301628ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:10.232335Z","caller":"traceutil/trace.go:171","msg":"trace[134189981] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"138.633721ms","start":"2026-04-07T01:35:10.093692Z","end":"2026-04-07T01:35:10.232326Z","steps":["trace[134189981] 'process raft request' (duration: 138.032918ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:11.166841Z","caller":"traceutil/trace.go:171","msg":"trace[2100133713] transaction","detail":"{read_only:false; response_revision:4860; number_of_response:1; }","duration":"135.353848ms","start":"2026-04-07T01:35:11.031451Z","end":"2026-04-07T01:35:11.166805Z","steps":["trace[2100133713] 'process raft request' (duration: 133.061325ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:14.391968Z","caller":"traceutil/trace.go:171","msg":"trace[18164016] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5014; }","duration":"123.411634ms","start":"2026-04-07T01:35:14.268527Z","end":"2026-04-07T01:35:14.391938Z","steps":["trace[18164016] 'process raft request' (duration: 123.281991ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:14.556434Z","caller":"traceutil/trace.go:171","msg":"trace[1329124588] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"158.830914ms","start":"2026-04-07T01:35:14.397571Z","end":"2026-04-07T01:35:14.556402Z","steps":["trace[1329124588] 'process raft request' (duration: 158.630539ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:14.653952Z","caller":"traceutil/trace.go:171","msg":"trace[712632761] transaction","detail":"{read_only:false; response_revision:5016; number_of_response:1; }","duration":"239.039539ms","start":"2026-04-07T01:35:14.414892Z","end":"2026-04-07T01:35:14.653931Z","steps":["trace[712632761] 'process raft request' (duration: 238.851445ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:14.653938Z","caller":"traceutil/trace.go:171","msg":"trace[1765288907] linearizableReadLoop","detail":"{readStateIndex:5214; appliedIndex:5213; }","duration":"220.845622ms","start":"2026-04-07T01:35:14.433045Z","end":"2026-04-07T01:35:14.653891Z","steps":["trace[1765288907] 'read index received' (duration: 123.443124ms)","trace[1765288907] 'applied index is now lower than readState.Index' (duration: 97.401288ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:35:14.654126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.051917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-lw2qd-tls\" ","response":"range_response_count:1 size:2183"} {"level":"info","ts":"2026-04-07T01:35:14.654172Z","caller":"traceutil/trace.go:171","msg":"trace[1984695355] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-lw2qd-tls; range_end:; response_count:1; response_revision:5016; }","duration":"221.141189ms","start":"2026-04-07T01:35:14.43302Z","end":"2026-04-07T01:35:14.654161Z","steps":["trace[1984695355] 'agreement among raft nodes before linearized reading' (duration: 220.968555ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:15.037616Z","caller":"traceutil/trace.go:171","msg":"trace[1139231968] linearizableReadLoop","detail":"{readStateIndex:5228; appliedIndex:5226; }","duration":"113.22836ms","start":"2026-04-07T01:35:14.924352Z","end":"2026-04-07T01:35:15.037581Z","steps":["trace[1139231968] 'read index received' (duration: 44.492018ms)","trace[1139231968] 'applied index is now lower than readState.Index' (duration: 68.734802ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:35:15.037669Z","caller":"traceutil/trace.go:171","msg":"trace[1725969264] transaction","detail":"{read_only:false; response_revision:5030; number_of_response:1; }","duration":"172.68049ms","start":"2026-04-07T01:35:14.864943Z","end":"2026-04-07T01:35:15.037623Z","steps":["trace[1725969264] 'process raft request' (duration: 172.523167ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:15.037772Z","caller":"traceutil/trace.go:171","msg":"trace[54025141] transaction","detail":"{read_only:false; response_revision:5029; number_of_response:1; }","duration":"212.909612ms","start":"2026-04-07T01:35:14.824823Z","end":"2026-04-07T01:35:15.037732Z","steps":["trace[54025141] 'process raft request' (duration: 144.000576ms)","trace[54025141] 'compare' (duration: 68.333113ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:35:15.037808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.428345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:35:15.037938Z","caller":"traceutil/trace.go:171","msg":"trace[709381942] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:5030; }","duration":"113.63313ms","start":"2026-04-07T01:35:14.924285Z","end":"2026-04-07T01:35:15.037918Z","steps":["trace[709381942] 'agreement among raft nodes before linearized reading' (duration: 113.429185ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:35:15.038398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.193692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:777446"} {"level":"info","ts":"2026-04-07T01:35:15.038479Z","caller":"traceutil/trace.go:171","msg":"trace[1348796220] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5030; }","duration":"103.326664ms","start":"2026-04-07T01:35:14.935136Z","end":"2026-04-07T01:35:15.038463Z","steps":["trace[1348796220] 'agreement among raft nodes before linearized reading' (duration: 102.642068ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:22.428439Z","caller":"traceutil/trace.go:171","msg":"trace[631247062] transaction","detail":"{read_only:false; response_revision:5185; number_of_response:1; }","duration":"116.436854ms","start":"2026-04-07T01:35:22.311968Z","end":"2026-04-07T01:35:22.428405Z","steps":["trace[631247062] 'process raft request' (duration: 116.168258ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:26.014989Z","caller":"traceutil/trace.go:171","msg":"trace[52027654] transaction","detail":"{read_only:false; response_revision:5245; number_of_response:1; }","duration":"112.669338ms","start":"2026-04-07T01:35:25.90229Z","end":"2026-04-07T01:35:26.01496Z","steps":["trace[52027654] 'process raft request' (duration: 31.719276ms)","trace[52027654] 'compare' (duration: 80.789439ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:35:33.937148Z","caller":"traceutil/trace.go:171","msg":"trace[1057844810] transaction","detail":"{read_only:false; response_revision:5407; number_of_response:1; }","duration":"147.466964ms","start":"2026-04-07T01:35:33.789609Z","end":"2026-04-07T01:35:33.937076Z","steps":["trace[1057844810] 'process raft request' (duration: 57.405363ms)","trace[1057844810] 'compare' (duration: 89.835116ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:35:34.220858Z","caller":"traceutil/trace.go:171","msg":"trace[1910763040] linearizableReadLoop","detail":"{readStateIndex:5614; appliedIndex:5613; }","duration":"109.572427ms","start":"2026-04-07T01:35:34.111247Z","end":"2026-04-07T01:35:34.22082Z","steps":["trace[1910763040] 'read index received' (duration: 24.078811ms)","trace[1910763040] 'applied index is now lower than readState.Index' (duration: 85.491716ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:35:34.220902Z","caller":"traceutil/trace.go:171","msg":"trace[1702193802] transaction","detail":"{read_only:false; response_revision:5408; number_of_response:1; }","duration":"152.97427ms","start":"2026-04-07T01:35:34.067885Z","end":"2026-04-07T01:35:34.220859Z","steps":["trace[1702193802] 'process raft request' (duration: 67.480964ms)","trace[1702193802] 'compare' (duration: 85.210239ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:35:34.221085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.820052ms","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-07T01:35:34.221165Z","caller":"traceutil/trace.go:171","msg":"trace[486499015] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5408; }","duration":"109.942815ms","start":"2026-04-07T01:35:34.111204Z","end":"2026-04-07T01:35:34.221147Z","steps":["trace[486499015] 'agreement among raft nodes before linearized reading' (duration: 109.72043ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:35:36.399184Z","caller":"traceutil/trace.go:171","msg":"trace[1595387288] transaction","detail":"{read_only:false; response_revision:5443; number_of_response:1; }","duration":"112.466593ms","start":"2026-04-07T01:35:36.286684Z","end":"2026-04-07T01:35:36.39915Z","steps":["trace[1595387288] 'process raft request' (duration: 84.863152ms)","trace[1595387288] 'compare' (duration: 27.456348ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:35:46.218184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.972508ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:35:46.218352Z","caller":"traceutil/trace.go:171","msg":"trace[931492337] transaction","detail":"{read_only:false; response_revision:5577; number_of_response:1; }","duration":"227.988867ms","start":"2026-04-07T01:35:45.990333Z","end":"2026-04-07T01:35:46.218322Z","steps":["trace[931492337] 'process raft request' (duration: 59.761223ms)","trace[931492337] 'compare' (duration: 167.782964ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:36:42.499407Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2986} {"level":"info","ts":"2026-04-07T01:36:42.574123Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2986,"took":"73.044895ms","hash":3050355143,"current-db-size-bytes":58355712,"current-db-size":"58 MB","current-db-size-in-use-bytes":33472512,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-07T01:36:42.574202Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3050355143,"revision":2986,"compact-revision":-1} {"level":"info","ts":"2026-04-07T01:41:42.519166Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6046} {"level":"info","ts":"2026-04-07T01:41:42.708554Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6046,"took":"186.263555ms","hash":2380658689,"current-db-size-bytes":58355712,"current-db-size":"58 MB","current-db-size-in-use-bytes":23748608,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-07T01:41:42.708634Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2380658689,"revision":6046,"compact-revision":2986} {"level":"info","ts":"2026-04-07T01:41:44.50008Z","caller":"traceutil/trace.go:171","msg":"trace[998099757] linearizableReadLoop","detail":"{readStateIndex:8574; appliedIndex:8573; }","duration":"128.318204ms","start":"2026-04-07T01:41:44.371731Z","end":"2026-04-07T01:41:44.50005Z","steps":["trace[998099757] 'read index received' (duration: 128.089279ms)","trace[998099757] 'applied index is now lower than readState.Index' (duration: 227.635µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:41:44.500112Z","caller":"traceutil/trace.go:171","msg":"trace[2045224100] transaction","detail":"{read_only:false; response_revision:8275; number_of_response:1; }","duration":"139.420473ms","start":"2026-04-07T01:41:44.360645Z","end":"2026-04-07T01:41:44.500065Z","steps":["trace[2045224100] 'process raft request' (duration: 139.193158ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:44.500509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.760213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-04-07T01:41:44.500561Z","caller":"traceutil/trace.go:171","msg":"trace[207726279] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8275; }","duration":"128.879436ms","start":"2026-04-07T01:41:44.371666Z","end":"2026-04-07T01:41:44.500546Z","steps":["trace[207726279] 'agreement among raft nodes before linearized reading' (duration: 128.558288ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:56.052119Z","caller":"traceutil/trace.go:171","msg":"trace[2021266441] transaction","detail":"{read_only:false; response_revision:8335; number_of_response:1; }","duration":"160.679002ms","start":"2026-04-07T01:41:55.891415Z","end":"2026-04-07T01:41:56.052094Z","steps":["trace[2021266441] 'process raft request' (duration: 160.517278ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:56.906448Z","caller":"traceutil/trace.go:171","msg":"trace[1525009732] transaction","detail":"{read_only:false; response_revision:8338; number_of_response:1; }","duration":"159.404873ms","start":"2026-04-07T01:41:56.747016Z","end":"2026-04-07T01:41:56.906421Z","steps":["trace[1525009732] 'process raft request' (duration: 159.193928ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:56.90701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.423232ms","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-07T01:41:56.907079Z","caller":"traceutil/trace.go:171","msg":"trace[1891308737] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8338; }","duration":"130.582756ms","start":"2026-04-07T01:41:56.776481Z","end":"2026-04-07T01:41:56.907064Z","steps":["trace[1891308737] 'agreement among raft nodes before linearized reading' (duration: 130.347381ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:56.906746Z","caller":"traceutil/trace.go:171","msg":"trace[794757511] linearizableReadLoop","detail":"{readStateIndex:8640; appliedIndex:8640; }","duration":"130.138006ms","start":"2026-04-07T01:41:56.776568Z","end":"2026-04-07T01:41:56.906706Z","steps":["trace[794757511] 'read index received' (duration: 130.117626ms)","trace[794757511] 'applied index is now lower than readState.Index' (duration: 17.2µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:41:56.934462Z","caller":"traceutil/trace.go:171","msg":"trace[1027880325] transaction","detail":"{read_only:false; response_revision:8339; number_of_response:1; }","duration":"139.944196ms","start":"2026-04-07T01:41:56.794467Z","end":"2026-04-07T01:41:56.934412Z","steps":["trace[1027880325] 'process raft request' (duration: 139.630778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:56.934582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.477948ms","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-07T01:41:56.934645Z","caller":"traceutil/trace.go:171","msg":"trace[143922174] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8339; }","duration":"148.58734ms","start":"2026-04-07T01:41:56.786043Z","end":"2026-04-07T01:41:56.93463Z","steps":["trace[143922174] 'agreement among raft nodes before linearized reading' (duration: 148.388296ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:57.152055Z","caller":"traceutil/trace.go:171","msg":"trace[1779295603] linearizableReadLoop","detail":"{readStateIndex:8642; appliedIndex:8641; }","duration":"217.788362ms","start":"2026-04-07T01:41:56.934241Z","end":"2026-04-07T01:41:57.152029Z","steps":["trace[1779295603] 'read index received' (duration: 131.820922ms)","trace[1779295603] 'applied index is now lower than readState.Index' (duration: 85.96598ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:41:57.152193Z","caller":"traceutil/trace.go:171","msg":"trace[654380242] transaction","detail":"{read_only:false; response_revision:8340; number_of_response:1; }","duration":"240.470263ms","start":"2026-04-07T01:41:56.911708Z","end":"2026-04-07T01:41:57.152178Z","steps":["trace[654380242] 'process raft request' (duration: 154.209207ms)","trace[654380242] 'compare' (duration: 85.884238ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:41:57.152353Z","caller":"traceutil/trace.go:171","msg":"trace[2017912988] transaction","detail":"{read_only:false; response_revision:8342; number_of_response:1; }","duration":"212.046583ms","start":"2026-04-07T01:41:56.940274Z","end":"2026-04-07T01:41:57.152321Z","steps":["trace[2017912988] 'process raft request' (duration: 211.956171ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:57.152559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.151418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:41:57.152627Z","caller":"traceutil/trace.go:171","msg":"trace[1130470708] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8342; }","duration":"217.244861ms","start":"2026-04-07T01:41:56.935366Z","end":"2026-04-07T01:41:57.15261Z","steps":["trace[1130470708] 'agreement among raft nodes before linearized reading' (duration: 217.113578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:41:57.152635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.653767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:41:57.152672Z","caller":"traceutil/trace.go:171","msg":"trace[1860419430] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:8342; }","duration":"244.744019ms","start":"2026-04-07T01:41:56.907918Z","end":"2026-04-07T01:41:57.152662Z","steps":["trace[1860419430] 'agreement among raft nodes before linearized reading' (duration: 244.653547ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:41:57.152659Z","caller":"traceutil/trace.go:171","msg":"trace[607757390] transaction","detail":"{read_only:false; response_revision:8341; number_of_response:1; }","duration":"212.939334ms","start":"2026-04-07T01:41:56.939645Z","end":"2026-04-07T01:41:57.152584Z","steps":["trace[607757390] 'process raft request' (duration: 212.346671ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:42:27.088859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.812591ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:42:27.089048Z","caller":"traceutil/trace.go:171","msg":"trace[1424362239] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:8555; }","duration":"162.031506ms","start":"2026-04-07T01:42:26.926993Z","end":"2026-04-07T01:42:27.089024Z","steps":["trace[1424362239] 'range keys from in-memory index tree' (duration: 161.787441ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:42:27.089587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.28452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:42:27.089633Z","caller":"traceutil/trace.go:171","msg":"trace[530658316] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8555; }","duration":"252.387762ms","start":"2026-04-07T01:42:26.837235Z","end":"2026-04-07T01:42:27.089622Z","steps":["trace[530658316] 'range keys from in-memory index tree' (duration: 252.183468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:42:30.000943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.377546ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:42:30.001089Z","caller":"traceutil/trace.go:171","msg":"trace[658187408] linearizableReadLoop","detail":"{readStateIndex:8882; appliedIndex:8881; }","duration":"321.194515ms","start":"2026-04-07T01:42:29.679864Z","end":"2026-04-07T01:42:30.001058Z","steps":["trace[658187408] 'read index received' (duration: 103.459741ms)","trace[658187408] 'applied index is now lower than readState.Index' (duration: 217.733184ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:42:30.001145Z","caller":"traceutil/trace.go:171","msg":"trace[1548087699] transaction","detail":"{read_only:false; response_revision:8572; number_of_response:1; }","duration":"400.588677ms","start":"2026-04-07T01:42:29.600502Z","end":"2026-04-07T01:42:30.001091Z","steps":["trace[1548087699] 'process raft request' (duration: 182.948335ms)","trace[1548087699] 'compare' (duration: 217.215513ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:42:30.001321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.452551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-64b494449c-mtz8g.18a3ef949ca28a69\" ","response":"range_response_count:1 size:1134"} {"level":"warn","ts":"2026-04-07T01:42:30.00135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:42:29.600482Z","time spent":"400.762692ms","remote":"127.0.0.1:53516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:42:30.001367Z","caller":"traceutil/trace.go:171","msg":"trace[1964396245] range","detail":"{range_begin:/registry/events/openstack/barbican-api-64b494449c-mtz8g.18a3ef949ca28a69; range_end:; response_count:1; response_revision:8572; }","duration":"321.515213ms","start":"2026-04-07T01:42:29.679837Z","end":"2026-04-07T01:42:30.001352Z","steps":["trace[1964396245] 'agreement among raft nodes before linearized reading' (duration: 321.329559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:42:30.001522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:42:29.679822Z","time spent":"321.690376ms","remote":"127.0.0.1:53312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":1158,"request content":"key:\"/registry/events/openstack/barbican-api-64b494449c-mtz8g.18a3ef949ca28a69\" "} {"level":"warn","ts":"2026-04-07T01:42:30.001497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.044473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:42:30.001605Z","caller":"traceutil/trace.go:171","msg":"trace[259918231] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8572; }","duration":"157.210327ms","start":"2026-04-07T01:42:29.844367Z","end":"2026-04-07T01:42:30.001577Z","steps":["trace[259918231] 'agreement among raft nodes before linearized reading' (duration: 157.045643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:42:30.001793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.138135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-07T01:42:30.001838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.60946ms","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:42:30.001885Z","caller":"traceutil/trace.go:171","msg":"trace[223805422] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8572; }","duration":"109.667861ms","start":"2026-04-07T01:42:29.892204Z","end":"2026-04-07T01:42:30.001872Z","steps":["trace[223805422] 'agreement among raft nodes before linearized reading' (duration: 109.470567ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:42:30.001884Z","caller":"traceutil/trace.go:171","msg":"trace[899817263] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:8572; }","duration":"144.242467ms","start":"2026-04-07T01:42:29.857619Z","end":"2026-04-07T01:42:30.001861Z","steps":["trace[899817263] 'agreement among raft nodes before linearized reading' (duration: 144.084144ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:42:30.213241Z","caller":"traceutil/trace.go:171","msg":"trace[713724592] transaction","detail":"{read_only:false; response_revision:8574; number_of_response:1; }","duration":"164.826018ms","start":"2026-04-07T01:42:30.048383Z","end":"2026-04-07T01:42:30.213209Z","steps":["trace[713724592] 'process raft request' (duration: 164.613784ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:42:30.231114Z","caller":"traceutil/trace.go:171","msg":"trace[1314427581] transaction","detail":"{read_only:false; response_revision:8575; number_of_response:1; }","duration":"170.072545ms","start":"2026-04-07T01:42:30.060999Z","end":"2026-04-07T01:42:30.231072Z","steps":["trace[1314427581] 'process raft request' (duration: 169.86061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:42:39.986268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.249844ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:42:39.986404Z","caller":"traceutil/trace.go:171","msg":"trace[920127920] transaction","detail":"{read_only:false; response_revision:8669; number_of_response:1; }","duration":"280.406471ms","start":"2026-04-07T01:42:39.705976Z","end":"2026-04-07T01:42:39.986383Z","steps":["trace[920127920] 'process raft request' (duration: 132.942722ms)","trace[920127920] 'compare' (duration: 146.896816ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:42:40.878753Z","caller":"traceutil/trace.go:171","msg":"trace[354460471] transaction","detail":"{read_only:false; response_revision:8677; number_of_response:1; }","duration":"191.257102ms","start":"2026-04-07T01:42:40.687466Z","end":"2026-04-07T01:42:40.878724Z","steps":["trace[354460471] 'process raft request' (duration: 191.071877ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:42:40.878837Z","caller":"traceutil/trace.go:171","msg":"trace[1253062548] linearizableReadLoop","detail":"{readStateIndex:8992; appliedIndex:8992; }","duration":"162.647979ms","start":"2026-04-07T01:42:40.716131Z","end":"2026-04-07T01:42:40.878779Z","steps":["trace[1253062548] 'read index received' (duration: 162.630948ms)","trace[1253062548] 'applied index is now lower than readState.Index' (duration: 14.531µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:42:40.879133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.985167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-04-07T01:42:40.879179Z","caller":"traceutil/trace.go:171","msg":"trace[174230139] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8677; }","duration":"163.088919ms","start":"2026-04-07T01:42:40.716078Z","end":"2026-04-07T01:42:40.879167Z","steps":["trace[174230139] 'agreement among raft nodes before linearized reading' (duration: 162.881525ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:42:58.000954Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023c9.wal"} {"level":"info","ts":"2026-04-07T01:43:46.14938Z","caller":"traceutil/trace.go:171","msg":"trace[1411061935] transaction","detail":"{read_only:false; response_revision:9361; number_of_response:1; }","duration":"107.130653ms","start":"2026-04-07T01:43:46.042204Z","end":"2026-04-07T01:43:46.149335Z","steps":["trace[1411061935] 'process raft request' (duration: 106.854437ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:43:59.041694Z","caller":"traceutil/trace.go:171","msg":"trace[1506242851] transaction","detail":"{read_only:false; response_revision:9432; number_of_response:1; }","duration":"360.452037ms","start":"2026-04-07T01:43:58.681212Z","end":"2026-04-07T01:43:59.041665Z","steps":["trace[1506242851] 'process raft request' (duration: 318.491226ms)","trace[1506242851] 'compare' (duration: 41.667735ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:43:59.041943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:43:58.681177Z","time spent":"360.646862ms","remote":"127.0.0.1:53516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:43:59.04198Z","caller":"traceutil/trace.go:171","msg":"trace[1738745487] linearizableReadLoop","detail":"{readStateIndex:9769; appliedIndex:9767; }","duration":"204.889216ms","start":"2026-04-07T01:43:58.837053Z","end":"2026-04-07T01:43:59.041942Z","steps":["trace[1738745487] 'read index received' (duration: 162.647919ms)","trace[1738745487] 'applied index is now lower than readState.Index' (duration: 42.233137ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:43:59.04215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.092442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:43:59.042189Z","caller":"traceutil/trace.go:171","msg":"trace[236108077] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9433; }","duration":"205.193374ms","start":"2026-04-07T01:43:58.836984Z","end":"2026-04-07T01:43:59.042178Z","steps":["trace[236108077] 'agreement among raft nodes before linearized reading' (duration: 205.078361ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:43:59.042336Z","caller":"traceutil/trace.go:171","msg":"trace[516062274] transaction","detail":"{read_only:false; response_revision:9433; number_of_response:1; }","duration":"360.862087ms","start":"2026-04-07T01:43:58.681454Z","end":"2026-04-07T01:43:59.042316Z","steps":["trace[516062274] 'process raft request' (duration: 360.160571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:43:59.042446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:43:58.68144Z","time spent":"360.956488ms","remote":"127.0.0.1:53516","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:44:30.812689Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c47ca1a7b1fe506b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-07T01:44:30.819902Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-07T01:44:30.820244Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-07T01:46:42.526863Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8266} {"level":"info","ts":"2026-04-07T01:46:42.618525Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8266,"took":"89.088065ms","hash":3665874206,"current-db-size-bytes":58355712,"current-db-size":"58 MB","current-db-size-in-use-bytes":24899584,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-07T01:46:42.618611Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3665874206,"revision":8266,"compact-revision":6046} {"level":"info","ts":"2026-04-07T01:51:42.532825Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10493} {"level":"info","ts":"2026-04-07T01:51:42.614077Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10493,"took":"78.838647ms","hash":1728657729,"current-db-size-bytes":58355712,"current-db-size":"58 MB","current-db-size-in-use-bytes":21405696,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-07T01:51:42.614145Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1728657729,"revision":10493,"compact-revision":8266}