{"level":"warn","ts":"2026-05-28T21:36:26.935937Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-28T21:36:26.936077Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72: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.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72: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-05-28T21:36:26.937948Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-28T21:36:26.937983Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-05-28T21:36:26.939274Z","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-05-28T21:36:26.940511Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-05-28T21:36:26.940665Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72: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-05-28T21:36:26.944461Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.392892ms"} {"level":"info","ts":"2026-05-28T21:36:26.959563Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-05-28T21:36:26.959672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-05-28T21:36:26.959699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-05-28T21:36:26.959762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-28T21:36:26.959777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-05-28T21:36:26.959896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-05-28T21:36:26.965881Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-28T21:36:26.967495Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-28T21:36:26.96931Z","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-05-28T21:36:26.971977Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-28T21:36:26.972598Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-28T21:36:26.973107Z","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-05-28T21:36:26.97325Z","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-05-28T21:36:26.973274Z","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-05-28T21:36:26.974653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-05-28T21:36:26.974888Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-05-28T21:36:26.976807Z","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-05-28T21:36:26.976981Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-05-28T21:36:26.977048Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-05-28T21:36:26.977041Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-28T21:36:26.977088Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-28T21:36:27.560806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-05-28T21:36:27.560879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-05-28T21:36:27.560913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-05-28T21:36:27.560939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-05-28T21:36:27.56095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-05-28T21:36:27.560967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-05-28T21:36:27.560981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-05-28T21:36:27.562231Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T21:36:27.56244Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-05-28T21:36:27.562669Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-28T21:36:27.562698Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-28T21:36:27.566347Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-05-28T21:36:27.566506Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-28T21:36:27.566573Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-28T21:36:27.566582Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-28T21:36:27.575064Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T21:36:27.575192Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T21:36:27.575231Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-28T21:37:10.583343Z","caller":"traceutil/trace.go:171","msg":"trace[646591207] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"254.397186ms","start":"2026-05-28T21:37:10.32892Z","end":"2026-05-28T21:37:10.583317Z","steps":["trace[646591207] 'process raft request' (duration: 234.852278ms)","trace[646591207] 'compare' (duration: 19.385941ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:37:10.583342Z","caller":"traceutil/trace.go:171","msg":"trace[618437622] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"129.244243ms","start":"2026-05-28T21:37:10.454069Z","end":"2026-05-28T21:37:10.583313Z","steps":["trace[618437622] 'read index received' (duration: 109.667574ms)","trace[618437622] 'applied index is now lower than readState.Index' (duration: 19.575619ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:37:10.583535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.442711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hnxwt\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-28T21:37:10.584868Z","caller":"traceutil/trace.go:171","msg":"trace[2125460030] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hnxwt; range_end:; response_count:1; response_revision:584; }","duration":"129.597297ms","start":"2026-05-28T21:37:10.454029Z","end":"2026-05-28T21:37:10.583626Z","steps":["trace[2125460030] 'agreement among raft nodes before linearized reading' (duration: 129.384058ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:37:10.990634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.672543ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T21:37:10.991402Z","caller":"traceutil/trace.go:171","msg":"trace[1283522535] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"390.662519ms","start":"2026-05-28T21:37:10.600719Z","end":"2026-05-28T21:37:10.991382Z","steps":["trace[1283522535] 'process raft request' (duration: 280.075817ms)","trace[1283522535] 'compare' (duration: 108.471045ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:37:10.991534Z","caller":"traceutil/trace.go:171","msg":"trace[102490011] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"307.792113ms","start":"2026-05-28T21:37:10.683718Z","end":"2026-05-28T21:37:10.991511Z","steps":["trace[102490011] 'process raft request' (duration: 307.008571ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:37:10.991602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:37:10.600686Z","time spent":"390.876538ms","remote":"127.0.0.1:60572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:37:10.991666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:37:10.683699Z","time spent":"307.889527ms","remote":"127.0.0.1:60396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:37:11.484521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.051114ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T21:37:11.485358Z","caller":"traceutil/trace.go:171","msg":"trace[1787680607] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"418.671102ms","start":"2026-05-28T21:37:11.066656Z","end":"2026-05-28T21:37:11.485327Z","steps":["trace[1787680607] 'process raft request' (duration: 56.730731ms)","trace[1787680607] 'compare' (duration: 360.95626ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:37:11.485383Z","caller":"traceutil/trace.go:171","msg":"trace[1872804620] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:614; }","duration":"269.92881ms","start":"2026-05-28T21:37:11.215436Z","end":"2026-05-28T21:37:11.485364Z","steps":["trace[1872804620] 'read index received' (duration: 268.545393ms)","trace[1872804620] 'applied index is now lower than readState.Index' (duration: 1.382207ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:37:11.485489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:37:11.066595Z","time spent":"418.822658ms","remote":"127.0.0.1:60640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:37:11.485506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.075286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-28T21:37:11.485494Z","caller":"traceutil/trace.go:171","msg":"trace[387471604] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"401.330729ms","start":"2026-05-28T21:37:11.084133Z","end":"2026-05-28T21:37:11.485464Z","steps":["trace[387471604] 'process raft request' (duration: 400.692483ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:37:11.485539Z","caller":"traceutil/trace.go:171","msg":"trace[259402718] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:588; }","duration":"270.15788ms","start":"2026-05-28T21:37:11.215368Z","end":"2026-05-28T21:37:11.485526Z","steps":["trace[259402718] 'agreement among raft nodes before linearized reading' (duration: 270.092997ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:37:11.485593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.34983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-28T21:37:11.485606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:37:11.08411Z","time spent":"401.439794ms","remote":"127.0.0.1:60466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036157,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T21:37:11.485651Z","caller":"traceutil/trace.go:171","msg":"trace[1451490467] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:588; }","duration":"143.456263ms","start":"2026-05-28T21:37:11.342181Z","end":"2026-05-28T21:37:11.485637Z","steps":["trace[1451490467] 'agreement among raft nodes before linearized reading' (duration: 143.351019ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:34.653859Z","caller":"traceutil/trace.go:171","msg":"trace[1684977576] transaction","detail":"{read_only:false; response_revision:1565; number_of_response:1; }","duration":"114.199482ms","start":"2026-05-28T21:38:34.539638Z","end":"2026-05-28T21:38:34.653837Z","steps":["trace[1684977576] 'process raft request' (duration: 114.16145ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:34.653899Z","caller":"traceutil/trace.go:171","msg":"trace[1972353063] transaction","detail":"{read_only:false; response_revision:1564; number_of_response:1; }","duration":"114.254503ms","start":"2026-05-28T21:38:34.539611Z","end":"2026-05-28T21:38:34.653866Z","steps":["trace[1972353063] 'process raft request' (duration: 58.325008ms)","trace[1972353063] 'compare' (duration: 55.694168ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:38:50.239456Z","caller":"traceutil/trace.go:171","msg":"trace[1339530824] linearizableReadLoop","detail":"{readStateIndex:1932; appliedIndex:1931; }","duration":"243.797734ms","start":"2026-05-28T21:38:49.995635Z","end":"2026-05-28T21:38:50.239433Z","steps":["trace[1339530824] 'read index received' (duration: 243.66237ms)","trace[1339530824] 'applied index is now lower than readState.Index' (duration: 134.244µs)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:38:50.239879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.229687ms","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-05-28T21:38:50.239956Z","caller":"traceutil/trace.go:171","msg":"trace[1573474413] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1855; }","duration":"244.355361ms","start":"2026-05-28T21:38:49.995585Z","end":"2026-05-28T21:38:50.23994Z","steps":["trace[1573474413] 'agreement among raft nodes before linearized reading' (duration: 244.114654ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:50.240062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.059292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18b3d8816a5d09d4\" ","response":"range_response_count:1 size:982"} {"level":"info","ts":"2026-05-28T21:38:50.240343Z","caller":"traceutil/trace.go:171","msg":"trace[2034163568] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18b3d8816a5d09d4; range_end:; response_count:1; response_revision:1855; }","duration":"139.406732ms","start":"2026-05-28T21:38:50.100901Z","end":"2026-05-28T21:38:50.240308Z","steps":["trace[2034163568] 'agreement among raft nodes before linearized reading' (duration: 138.883656ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:50.239967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.806262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1a978fe6-a1fc-4472-8a28-a79027c8a663\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-05-28T21:38:50.24049Z","caller":"traceutil/trace.go:171","msg":"trace[2099784315] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1a978fe6-a1fc-4472-8a28-a79027c8a663; range_end:; response_count:1; response_revision:1855; }","duration":"105.381939ms","start":"2026-05-28T21:38:50.135088Z","end":"2026-05-28T21:38:50.24047Z","steps":["trace[2099784315] 'agreement among raft nodes before linearized reading' (duration: 104.674549ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:50.240056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.541632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-28T21:38:50.240639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.689349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:476"} {"level":"info","ts":"2026-05-28T21:38:50.240694Z","caller":"traceutil/trace.go:171","msg":"trace[1462736695] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1855; }","duration":"227.767381ms","start":"2026-05-28T21:38:50.012911Z","end":"2026-05-28T21:38:50.240679Z","steps":["trace[1462736695] 'agreement among raft nodes before linearized reading' (duration: 226.818684ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:50.240649Z","caller":"traceutil/trace.go:171","msg":"trace[1198524482] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1855; }","duration":"222.18244ms","start":"2026-05-28T21:38:50.018457Z","end":"2026-05-28T21:38:50.240639Z","steps":["trace[1198524482] 'agreement among raft nodes before linearized reading' (duration: 221.4807ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:50.240089Z","caller":"traceutil/trace.go:171","msg":"trace[1593581965] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"269.102286ms","start":"2026-05-28T21:38:49.970432Z","end":"2026-05-28T21:38:50.239534Z","steps":["trace[1593581965] 'process raft request' (duration: 268.839689ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:50.390214Z","caller":"traceutil/trace.go:171","msg":"trace[622588581] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"145.696274ms","start":"2026-05-28T21:38:50.244487Z","end":"2026-05-28T21:38:50.390183Z","steps":["trace[622588581] 'process raft request' (duration: 51.266429ms)","trace[622588581] 'compare' (duration: 94.310411ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:38:50.727422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.382102ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T21:38:50.727702Z","caller":"traceutil/trace.go:171","msg":"trace[705850782] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"480.120124ms","start":"2026-05-28T21:38:50.247546Z","end":"2026-05-28T21:38:50.727666Z","steps":["trace[705850782] 'process raft request' (duration: 479.942239ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:50.727786Z","caller":"traceutil/trace.go:171","msg":"trace[1446557769] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"480.120534ms","start":"2026-05-28T21:38:50.247642Z","end":"2026-05-28T21:38:50.727763Z","steps":["trace[1446557769] 'process raft request' (duration: 479.957299ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:50.727799Z","caller":"traceutil/trace.go:171","msg":"trace[797006811] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"480.276488ms","start":"2026-05-28T21:38:50.247472Z","end":"2026-05-28T21:38:50.727748Z","steps":["trace[797006811] 'process raft request' (duration: 261.395742ms)","trace[797006811] 'compare' (duration: 217.813666ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:38:50.727935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:50.247521Z","time spent":"480.270719ms","remote":"127.0.0.1:60640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:38:50.727996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:50.247634Z","time spent":"480.265309ms","remote":"127.0.0.1:60640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:38:50.728002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:50.247445Z","time spent":"480.466684ms","remote":"127.0.0.1:60550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T21:38:50.728034Z","caller":"traceutil/trace.go:171","msg":"trace[704500743] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"480.383802ms","start":"2026-05-28T21:38:50.247637Z","end":"2026-05-28T21:38:50.72802Z","steps":["trace[704500743] 'process raft request' (duration: 479.984331ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:50.728087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:50.247625Z","time spent":"480.436453ms","remote":"127.0.0.1:60654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T21:38:50.72848Z","caller":"traceutil/trace.go:171","msg":"trace[121287970] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"480.786613ms","start":"2026-05-28T21:38:50.247675Z","end":"2026-05-28T21:38:50.728462Z","steps":["trace[121287970] 'process raft request' (duration: 480.278268ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:50.728521Z","caller":"traceutil/trace.go:171","msg":"trace[290164123] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"480.262519ms","start":"2026-05-28T21:38:50.24825Z","end":"2026-05-28T21:38:50.728513Z","steps":["trace[290164123] 'process raft request' (duration: 479.734883ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:50.72856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:50.248243Z","time spent":"480.297219ms","remote":"127.0.0.1:60550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-28T21:38:50.728581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:50.247666Z","time spent":"480.864956ms","remote":"127.0.0.1:60640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T21:38:50.728931Z","caller":"traceutil/trace.go:171","msg":"trace[1103261947] linearizableReadLoop","detail":"{readStateIndex:1934; appliedIndex:1932; }","duration":"481.387701ms","start":"2026-05-28T21:38:50.247522Z","end":"2026-05-28T21:38:50.72891Z","steps":["trace[1103261947] 'read index received' (duration: 48.241802ms)","trace[1103261947] 'applied index is now lower than readState.Index' (duration: 433.143429ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:38:50.729187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.652638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1a978fe6-a1fc-4472-8a28-a79027c8a663\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-05-28T21:38:50.729244Z","caller":"traceutil/trace.go:171","msg":"trace[1835908142] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1a978fe6-a1fc-4472-8a28-a79027c8a663; range_end:; response_count:1; response_revision:1864; }","duration":"481.738621ms","start":"2026-05-28T21:38:50.247491Z","end":"2026-05-28T21:38:50.729229Z","steps":["trace[1835908142] 'agreement among raft nodes before linearized reading' (duration: 481.537035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:50.729289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:50.247477Z","time spent":"481.800493ms","remote":"127.0.0.1:60572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1a978fe6-a1fc-4472-8a28-a79027c8a663\" "} {"level":"info","ts":"2026-05-28T21:38:50.729655Z","caller":"traceutil/trace.go:171","msg":"trace[1389356844] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"480.090303ms","start":"2026-05-28T21:38:50.247612Z","end":"2026-05-28T21:38:50.727702Z","steps":["trace[1389356844] 'process raft request' (duration: 479.957169ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:50.729764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-28T21:38:50.247602Z","time spent":"482.106512ms","remote":"127.0.0.1:60654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-28T21:38:50.730317Z","caller":"traceutil/trace.go:171","msg":"trace[2060962123] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"240.236762ms","start":"2026-05-28T21:38:50.490055Z","end":"2026-05-28T21:38:50.730292Z","steps":["trace[2060962123] 'process raft request' (duration: 238.638576ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:50.730685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.719354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-28T21:38:50.730878Z","caller":"traceutil/trace.go:171","msg":"trace[81670397] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:1866; }","duration":"233.937471ms","start":"2026-05-28T21:38:50.496911Z","end":"2026-05-28T21:38:50.730849Z","steps":["trace[81670397] 'agreement among raft nodes before linearized reading' (duration: 233.57004ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:38:50.73133Z","caller":"traceutil/trace.go:171","msg":"trace[1374512090] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"241.164409ms","start":"2026-05-28T21:38:50.490146Z","end":"2026-05-28T21:38:50.73131Z","steps":["trace[1374512090] 'process raft request' (duration: 238.581815ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:50.731752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.88619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:38:50.731846Z","caller":"traceutil/trace.go:171","msg":"trace[277231696] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1866; }","duration":"188.992123ms","start":"2026-05-28T21:38:50.542809Z","end":"2026-05-28T21:38:50.731801Z","steps":["trace[277231696] 'agreement among raft nodes before linearized reading' (duration: 188.86863ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:38:50.732052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.840428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-28T21:38:50.73211Z","caller":"traceutil/trace.go:171","msg":"trace[532231443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1866; }","duration":"145.941051ms","start":"2026-05-28T21:38:50.586158Z","end":"2026-05-28T21:38:50.732099Z","steps":["trace[532231443] 'agreement among raft nodes before linearized reading' (duration: 145.759406ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:39:02.51448Z","caller":"traceutil/trace.go:171","msg":"trace[1443036653] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"132.559461ms","start":"2026-05-28T21:39:02.381896Z","end":"2026-05-28T21:39:02.514456Z","steps":["trace[1443036653] 'process raft request' (duration: 132.351455ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:39:25.148893Z","caller":"traceutil/trace.go:171","msg":"trace[1336260759] linearizableReadLoop","detail":"{readStateIndex:2185; appliedIndex:2184; }","duration":"192.641744ms","start":"2026-05-28T21:39:24.956229Z","end":"2026-05-28T21:39:25.148871Z","steps":["trace[1336260759] 'read index received' (duration: 102.127468ms)","trace[1336260759] 'applied index is now lower than readState.Index' (duration: 90.513516ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:39:25.149067Z","caller":"traceutil/trace.go:171","msg":"trace[102260309] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"228.586223ms","start":"2026-05-28T21:39:24.920472Z","end":"2026-05-28T21:39:25.149058Z","steps":["trace[102260309] 'process raft request' (duration: 137.931283ms)","trace[102260309] 'compare' (duration: 90.385663ms)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:39:25.149258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.014224ms","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-05-28T21:39:25.149279Z","caller":"traceutil/trace.go:171","msg":"trace[77699217] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2101; }","duration":"193.048235ms","start":"2026-05-28T21:39:24.956225Z","end":"2026-05-28T21:39:25.149273Z","steps":["trace[77699217] 'agreement among raft nodes before linearized reading' (duration: 192.952903ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:25.149434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.677686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-28T21:39:25.149487Z","caller":"traceutil/trace.go:171","msg":"trace[242243102] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2101; }","duration":"192.743557ms","start":"2026-05-28T21:39:24.956737Z","end":"2026-05-28T21:39:25.149481Z","steps":["trace[242243102] 'agreement among raft nodes before linearized reading' (duration: 192.651725ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:25.149675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.779605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:39:25.1497Z","caller":"traceutil/trace.go:171","msg":"trace[968971558] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2101; }","duration":"165.830657ms","start":"2026-05-28T21:39:24.983861Z","end":"2026-05-28T21:39:25.149692Z","steps":["trace[968971558] 'agreement among raft nodes before linearized reading' (duration: 165.792606ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:25.149842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.212653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-28T21:39:25.149867Z","caller":"traceutil/trace.go:171","msg":"trace[1888573047] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2101; }","duration":"188.288675ms","start":"2026-05-28T21:39:24.961572Z","end":"2026-05-28T21:39:25.14986Z","steps":["trace[1888573047] 'agreement among raft nodes before linearized reading' (duration: 188.214763ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:25.149955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.517691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-28T21:39:25.149972Z","caller":"traceutil/trace.go:171","msg":"trace[1939600658] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2101; }","duration":"188.560872ms","start":"2026-05-28T21:39:24.961405Z","end":"2026-05-28T21:39:25.149966Z","steps":["trace[1939600658] 'agreement among raft nodes before linearized reading' (duration: 188.509511ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:25.445885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.206015ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-28T21:39:25.446109Z","caller":"traceutil/trace.go:171","msg":"trace[1880761757] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"291.790897ms","start":"2026-05-28T21:39:25.1543Z","end":"2026-05-28T21:39:25.446091Z","steps":["trace[1880761757] 'process raft request' (duration: 291.726995ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:39:25.446195Z","caller":"traceutil/trace.go:171","msg":"trace[1401204109] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"292.694622ms","start":"2026-05-28T21:39:25.153482Z","end":"2026-05-28T21:39:25.446176Z","steps":["trace[1401204109] 'process raft request' (duration: 129.134728ms)","trace[1401204109] 'compare' (duration: 163.084621ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:39:25.446447Z","caller":"traceutil/trace.go:171","msg":"trace[158508308] linearizableReadLoop","detail":"{readStateIndex:2189; appliedIndex:2185; }","duration":"280.142637ms","start":"2026-05-28T21:39:25.166292Z","end":"2026-05-28T21:39:25.446434Z","steps":["trace[158508308] 'read index received' (duration: 116.217433ms)","trace[158508308] 'applied index is now lower than readState.Index' (duration: 163.924214ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:39:25.446369Z","caller":"traceutil/trace.go:171","msg":"trace[1387504797] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"292.720563ms","start":"2026-05-28T21:39:25.153617Z","end":"2026-05-28T21:39:25.446338Z","steps":["trace[1387504797] 'process raft request' (duration: 292.361663ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:39:25.446507Z","caller":"traceutil/trace.go:171","msg":"trace[694286390] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"292.106096ms","start":"2026-05-28T21:39:25.154392Z","end":"2026-05-28T21:39:25.446498Z","steps":["trace[694286390] 'process raft request' (duration: 291.668874ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:39:25.446777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.485326ms","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-05-28T21:39:25.446818Z","caller":"traceutil/trace.go:171","msg":"trace[551220095] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2106; }","duration":"280.567608ms","start":"2026-05-28T21:39:25.166239Z","end":"2026-05-28T21:39:25.446807Z","steps":["trace[551220095] 'agreement among raft nodes before linearized reading' (duration: 280.24526ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:41:09.754622Z","caller":"traceutil/trace.go:171","msg":"trace[1363229637] transaction","detail":"{read_only:false; response_revision:2770; number_of_response:1; }","duration":"133.945987ms","start":"2026-05-28T21:41:09.620644Z","end":"2026-05-28T21:41:09.754589Z","steps":["trace[1363229637] 'process raft request' (duration: 74.410422ms)","trace[1363229637] 'compare' (duration: 59.403191ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:44:58.94301Z","caller":"traceutil/trace.go:171","msg":"trace[1221400884] transaction","detail":"{read_only:false; response_revision:4698; number_of_response:1; }","duration":"176.435536ms","start":"2026-05-28T21:44:58.766542Z","end":"2026-05-28T21:44:58.942977Z","steps":["trace[1221400884] 'process raft request' (duration: 150.531746ms)","trace[1221400884] 'compare' (duration: 25.556751ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:44:59.092622Z","caller":"traceutil/trace.go:171","msg":"trace[969458107] linearizableReadLoop","detail":"{readStateIndex:4883; appliedIndex:4882; }","duration":"109.416439ms","start":"2026-05-28T21:44:58.983181Z","end":"2026-05-28T21:44:59.092597Z","steps":["trace[969458107] 'read index received' (duration: 109.262286ms)","trace[969458107] 'applied index is now lower than readState.Index' (duration: 153.093µs)"],"step_count":2} {"level":"warn","ts":"2026-05-28T21:44:59.092832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.629754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:44:59.092919Z","caller":"traceutil/trace.go:171","msg":"trace[771922711] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4699; }","duration":"109.762908ms","start":"2026-05-28T21:44:58.983135Z","end":"2026-05-28T21:44:59.092897Z","steps":["trace[771922711] 'agreement among raft nodes before linearized reading' (duration: 109.590993ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:44:59.092695Z","caller":"traceutil/trace.go:171","msg":"trace[735719789] transaction","detail":"{read_only:false; response_revision:4699; number_of_response:1; }","duration":"140.702969ms","start":"2026-05-28T21:44:58.951964Z","end":"2026-05-28T21:44:59.092666Z","steps":["trace[735719789] 'process raft request' (duration: 140.487064ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:44:59.364104Z","caller":"traceutil/trace.go:171","msg":"trace[2050481595] transaction","detail":"{read_only:false; response_revision:4707; number_of_response:1; }","duration":"111.487889ms","start":"2026-05-28T21:44:59.252589Z","end":"2026-05-28T21:44:59.364076Z","steps":["trace[2050481595] 'process raft request' (duration: 71.449346ms)","trace[2050481595] 'compare' (duration: 39.91208ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:44:59.676945Z","caller":"traceutil/trace.go:171","msg":"trace[409097398] linearizableReadLoop","detail":"{readStateIndex:4903; appliedIndex:4899; }","duration":"108.547087ms","start":"2026-05-28T21:44:59.568373Z","end":"2026-05-28T21:44:59.67692Z","steps":["trace[409097398] 'read index received' (duration: 10.193738ms)","trace[409097398] 'applied index is now lower than readState.Index' (duration: 98.352289ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:44:59.676995Z","caller":"traceutil/trace.go:171","msg":"trace[1901295474] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"111.10386ms","start":"2026-05-28T21:44:59.565869Z","end":"2026-05-28T21:44:59.676973Z","steps":["trace[1901295474] 'process raft request' (duration: 110.953556ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:44:59.676966Z","caller":"traceutil/trace.go:171","msg":"trace[1871710879] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"111.135841ms","start":"2026-05-28T21:44:59.565786Z","end":"2026-05-28T21:44:59.676922Z","steps":["trace[1871710879] 'process raft request' (duration: 110.919195ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:44:59.677251Z","caller":"traceutil/trace.go:171","msg":"trace[1777124228] transaction","detail":"{read_only:false; response_revision:4718; number_of_response:1; }","duration":"111.294804ms","start":"2026-05-28T21:44:59.565939Z","end":"2026-05-28T21:44:59.677234Z","steps":["trace[1777124228] 'process raft request' (duration: 110.929985ms)"],"step_count":1} {"level":"warn","ts":"2026-05-28T21:44:59.677423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.005959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-28T21:44:59.677511Z","caller":"traceutil/trace.go:171","msg":"trace[2112160215] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:4718; }","duration":"109.140402ms","start":"2026-05-28T21:44:59.568348Z","end":"2026-05-28T21:44:59.677489Z","steps":["trace[2112160215] 'agreement among raft nodes before linearized reading' (duration: 108.961218ms)"],"step_count":1} {"level":"info","ts":"2026-05-28T21:45:00.690476Z","caller":"traceutil/trace.go:171","msg":"trace[1706151984] transaction","detail":"{read_only:false; response_revision:4774; number_of_response:1; }","duration":"109.653676ms","start":"2026-05-28T21:45:00.580791Z","end":"2026-05-28T21:45:00.690445Z","steps":["trace[1706151984] 'process raft request' (duration: 96.354792ms)","trace[1706151984] 'compare' (duration: 13.16524ms)"],"step_count":2} {"level":"info","ts":"2026-05-28T21:46:27.59835Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2863} {"level":"info","ts":"2026-05-28T21:46:27.697762Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2863,"took":"97.569129ms","hash":839523900,"current-db-size-bytes":54075392,"current-db-size":"54 MB","current-db-size-in-use-bytes":29257728,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-28T21:46:27.69782Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":839523900,"revision":2863,"compact-revision":-1} {"level":"info","ts":"2026-05-28T21:51:27.60336Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5542} {"level":"info","ts":"2026-05-28T21:51:27.682992Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5542,"took":"78.292025ms","hash":3138748129,"current-db-size-bytes":54075392,"current-db-size":"54 MB","current-db-size-in-use-bytes":18456576,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-28T21:51:27.683069Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3138748129,"revision":5542,"compact-revision":2863}