{"level":"warn","ts":"2026-04-08T22:58:09.866196Z","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-08T22:58:09.866286Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.153: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.153:2380","--initial-cluster=instance=https://199.204.45.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.153: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-08T22:58:09.866349Z","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-08T22:58:09.866358Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-04-08T22:58:09.866383Z","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-08T22:58:09.867694Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"]} {"level":"info","ts":"2026-04-08T22:58:09.867777Z","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.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.153: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-08T22:58:09.870901Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.873936ms"} {"level":"info","ts":"2026-04-08T22:58:09.880289Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"355195d5aae85944","cluster-id":"e424441517bc0b32"} {"level":"info","ts":"2026-04-08T22:58:09.880389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T22:58:09.880423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 0"} {"level":"info","ts":"2026-04-08T22:58:09.880438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 355195d5aae85944 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T22:58:09.880453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 1"} {"level":"info","ts":"2026-04-08T22:58:09.880502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"warn","ts":"2026-04-08T22:58:09.886222Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T22:58:09.887819Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T22:58:09.890584Z","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-08T22:58:09.892723Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"355195d5aae85944","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T22:58:09.892917Z","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-08T22:58:09.892924Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"355195d5aae85944","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T22:58:09.893027Z","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-08T22:58:09.89321Z","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-08T22:58:09.896987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"info","ts":"2026-04-08T22:58:09.897198Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","added-peer-id":"355195d5aae85944","added-peer-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-04-08T22:58:09.898085Z","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-08T22:58:09.898191Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-04-08T22:58:09.898246Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-04-08T22:58:09.898482Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"355195d5aae85944","initial-advertise-peer-urls":["https://199.204.45.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T22:58:09.898555Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T22:58:10.181102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T22:58:10.181238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T22:58:10.181269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgPreVoteResp from 355195d5aae85944 at term 1"} {"level":"info","ts":"2026-04-08T22:58:10.181311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became candidate at term 2"} {"level":"info","ts":"2026-04-08T22:58:10.181331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgVoteResp from 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-04-08T22:58:10.181383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became leader at term 2"} {"level":"info","ts":"2026-04-08T22:58:10.181426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 355195d5aae85944 elected leader 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-04-08T22:58:10.184287Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"355195d5aae85944","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.153:2379]}","request-path":"/0/members/355195d5aae85944/attributes","cluster-id":"e424441517bc0b32","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T22:58:10.18431Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T22:58:10.184404Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T22:58:10.184318Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:58:10.184823Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T22:58:10.184861Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T22:58:10.187761Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.153:2379"} {"level":"info","ts":"2026-04-08T22:58:10.188939Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T22:58:10.19177Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:58:10.192004Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:58:10.192089Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T22:58:28.23952Z","caller":"traceutil/trace.go:171","msg":"trace[111510763] linearizableReadLoop","detail":"{readStateIndex:458; appliedIndex:457; }","duration":"103.058015ms","start":"2026-04-08T22:58:28.136436Z","end":"2026-04-08T22:58:28.239494Z","steps":["trace[111510763] 'read index received' (duration: 102.846649ms)","trace[111510763] 'applied index is now lower than readState.Index' (duration: 210.106µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:58:28.239627Z","caller":"traceutil/trace.go:171","msg":"trace[824994940] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"169.464287ms","start":"2026-04-08T22:58:28.070104Z","end":"2026-04-08T22:58:28.239568Z","steps":["trace[824994940] 'process raft request' (duration: 169.159509ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:58:28.239812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.338122ms","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-08T22:58:28.239988Z","caller":"traceutil/trace.go:171","msg":"trace[656946295] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:445; }","duration":"103.589509ms","start":"2026-04-08T22:58:28.136373Z","end":"2026-04-08T22:58:28.239962Z","steps":["trace[656946295] 'agreement among raft nodes before linearized reading' (duration: 103.288071ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:42.017433Z","caller":"traceutil/trace.go:171","msg":"trace[2000405154] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"259.400376ms","start":"2026-04-08T22:58:41.758006Z","end":"2026-04-08T22:58:42.017406Z","steps":["trace[2000405154] 'process raft request' (duration: 259.261972ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:42.034383Z","caller":"traceutil/trace.go:171","msg":"trace[2011118124] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"273.499099ms","start":"2026-04-08T22:58:41.760853Z","end":"2026-04-08T22:58:42.034352Z","steps":["trace[2011118124] 'process raft request' (duration: 273.239342ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:42.034592Z","caller":"traceutil/trace.go:171","msg":"trace[873345417] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"259.467437ms","start":"2026-04-08T22:58:41.775067Z","end":"2026-04-08T22:58:42.034535Z","steps":["trace[873345417] 'process raft request' (duration: 259.291172ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:42.034526Z","caller":"traceutil/trace.go:171","msg":"trace[1265800020] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"272.775529ms","start":"2026-04-08T22:58:41.76172Z","end":"2026-04-08T22:58:42.034496Z","steps":["trace[1265800020] 'process raft request' (duration: 272.515732ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:42.034574Z","caller":"traceutil/trace.go:171","msg":"trace[1666637210] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"259.404765ms","start":"2026-04-08T22:58:41.775159Z","end":"2026-04-08T22:58:42.034563Z","steps":["trace[1666637210] 'process raft request' (duration: 259.265361ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:42.034844Z","caller":"traceutil/trace.go:171","msg":"trace[360634854] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"258.406848ms","start":"2026-04-08T22:58:41.776429Z","end":"2026-04-08T22:58:42.034836Z","steps":["trace[360634854] 'process raft request' (duration: 258.10796ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:42.034605Z","caller":"traceutil/trace.go:171","msg":"trace[211296791] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"258.679215ms","start":"2026-04-08T22:58:41.775919Z","end":"2026-04-08T22:58:42.034599Z","steps":["trace[211296791] 'process raft request' (duration: 258.550891ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:42.034948Z","caller":"traceutil/trace.go:171","msg":"trace[353591207] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"251.068757ms","start":"2026-04-08T22:58:41.783778Z","end":"2026-04-08T22:58:42.034846Z","steps":["trace[353591207] 'process raft request' (duration: 250.817801ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:42.03502Z","caller":"traceutil/trace.go:171","msg":"trace[775428247] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"233.393036ms","start":"2026-04-08T22:58:41.801619Z","end":"2026-04-08T22:58:42.035012Z","steps":["trace[775428247] 'process raft request' (duration: 233.039776ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:42.035088Z","caller":"traceutil/trace.go:171","msg":"trace[440924213] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"200.918922ms","start":"2026-04-08T22:58:41.834123Z","end":"2026-04-08T22:58:42.035042Z","steps":["trace[440924213] 'process raft request' (duration: 200.672575ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:42.035337Z","caller":"traceutil/trace.go:171","msg":"trace[1638345991] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"260.250878ms","start":"2026-04-08T22:58:41.774338Z","end":"2026-04-08T22:58:42.034588Z","steps":["trace[1638345991] 'process raft request' (duration: 259.960971ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:58:48.519671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.918178ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T22:58:48.519809Z","caller":"traceutil/trace.go:171","msg":"trace[1423756386] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"184.497696ms","start":"2026-04-08T22:58:48.335294Z","end":"2026-04-08T22:58:48.519792Z","steps":["trace[1423756386] 'read index received' (duration: 48.081µs)","trace[1423756386] 'applied index is now lower than readState.Index' (duration: 184.448085ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:58:48.519904Z","caller":"traceutil/trace.go:171","msg":"trace[1530063692] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"250.091714ms","start":"2026-04-08T22:58:48.269738Z","end":"2026-04-08T22:58:48.51983Z","steps":["trace[1530063692] 'process raft request' (duration: 17.522378ms)","trace[1530063692] 'compare' (duration: 231.731633ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T22:58:48.52008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.963443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-08T22:58:48.520123Z","caller":"traceutil/trace.go:171","msg":"trace[892907323] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:620; }","duration":"169.037845ms","start":"2026-04-08T22:58:48.351067Z","end":"2026-04-08T22:58:48.520105Z","steps":["trace[892907323] 'agreement among raft nodes before linearized reading' (duration: 168.8429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:58:48.520139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.818645ms","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-08T22:58:48.520229Z","caller":"traceutil/trace.go:171","msg":"trace[1742210213] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:620; }","duration":"184.967929ms","start":"2026-04-08T22:58:48.335236Z","end":"2026-04-08T22:58:48.520204Z","steps":["trace[1742210213] 'agreement among raft nodes before linearized reading' (duration: 184.618599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:58:48.520467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.414523ms","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-08T22:58:48.520583Z","caller":"traceutil/trace.go:171","msg":"trace[97654600] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:620; }","duration":"159.609328ms","start":"2026-04-08T22:58:48.36095Z","end":"2026-04-08T22:58:48.52056Z","steps":["trace[97654600] 'agreement among raft nodes before linearized reading' (duration: 159.29999ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:48.717462Z","caller":"traceutil/trace.go:171","msg":"trace[1429252094] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"191.859936ms","start":"2026-04-08T22:58:48.525557Z","end":"2026-04-08T22:58:48.717417Z","steps":["trace[1429252094] 'process raft request' (duration: 147.726214ms)","trace[1429252094] 'compare' (duration: 43.976328ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:58:48.735388Z","caller":"traceutil/trace.go:171","msg":"trace[776155318] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"209.700102ms","start":"2026-04-08T22:58:48.525661Z","end":"2026-04-08T22:58:48.735361Z","steps":["trace[776155318] 'process raft request' (duration: 209.485986ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:48.735846Z","caller":"traceutil/trace.go:171","msg":"trace[1826752742] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:638; }","duration":"204.266244ms","start":"2026-04-08T22:58:48.531568Z","end":"2026-04-08T22:58:48.735834Z","steps":["trace[1826752742] 'read index received' (duration: 141.72219ms)","trace[1826752742] 'applied index is now lower than readState.Index' (duration: 62.543024ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T22:58:48.735822Z","caller":"traceutil/trace.go:171","msg":"trace[1791453829] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"210.064402ms","start":"2026-04-08T22:58:48.525727Z","end":"2026-04-08T22:58:48.735791Z","steps":["trace[1791453829] 'process raft request' (duration: 209.596239ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:48.736044Z","caller":"traceutil/trace.go:171","msg":"trace[1194178018] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"202.196117ms","start":"2026-04-08T22:58:48.533835Z","end":"2026-04-08T22:58:48.736031Z","steps":["trace[1194178018] 'process raft request' (duration: 201.736665ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T22:58:48.736311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.703125ms","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-08T22:58:48.736425Z","caller":"traceutil/trace.go:171","msg":"trace[177942865] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:624; }","duration":"204.86695ms","start":"2026-04-08T22:58:48.531529Z","end":"2026-04-08T22:58:48.736396Z","steps":["trace[177942865] 'agreement among raft nodes before linearized reading' (duration: 204.646384ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T22:58:49.467344Z","caller":"traceutil/trace.go:171","msg":"trace[1407929691] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"270.017385ms","start":"2026-04-08T22:58:49.197294Z","end":"2026-04-08T22:58:49.467312Z","steps":["trace[1407929691] 'process raft request' (duration: 269.302286ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:00:23.504471Z","caller":"traceutil/trace.go:171","msg":"trace[1581955338] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"217.179499ms","start":"2026-04-08T23:00:23.287254Z","end":"2026-04-08T23:00:23.504434Z","steps":["trace[1581955338] 'process raft request' (duration: 216.939522ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:00:23.512327Z","caller":"traceutil/trace.go:171","msg":"trace[99769294] linearizableReadLoop","detail":"{readStateIndex:1927; appliedIndex:1926; }","duration":"174.795148ms","start":"2026-04-08T23:00:23.337487Z","end":"2026-04-08T23:00:23.512283Z","steps":["trace[99769294] 'read index received' (duration: 167.130078ms)","trace[99769294] 'applied index is now lower than readState.Index' (duration: 7.66317ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:00:23.512408Z","caller":"traceutil/trace.go:171","msg":"trace[1670003017] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"224.576762ms","start":"2026-04-08T23:00:23.287764Z","end":"2026-04-08T23:00:23.51234Z","steps":["trace[1670003017] 'process raft request' (duration: 224.355115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:23.512662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.149347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-08T23:00:23.512702Z","caller":"traceutil/trace.go:171","msg":"trace[1458988197] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1860; }","duration":"175.264111ms","start":"2026-04-08T23:00:23.337428Z","end":"2026-04-08T23:00:23.512692Z","steps":["trace[1458988197] 'agreement among raft nodes before linearized reading' (duration: 175.046035ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:23.512693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.22423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T23:00:23.512756Z","caller":"traceutil/trace.go:171","msg":"trace[1331523189] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1860; }","duration":"102.346053ms","start":"2026-04-08T23:00:23.410389Z","end":"2026-04-08T23:00:23.512735Z","steps":["trace[1331523189] 'agreement among raft nodes before linearized reading' (duration: 102.20724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:23.512728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.170438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-08T23:00:23.512815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.721209ms","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-08T23:00:23.512918Z","caller":"traceutil/trace.go:171","msg":"trace[1085458384] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1860; }","duration":"173.814701ms","start":"2026-04-08T23:00:23.339057Z","end":"2026-04-08T23:00:23.512872Z","steps":["trace[1085458384] 'agreement among raft nodes before linearized reading' (duration: 173.600785ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:00:23.512832Z","caller":"traceutil/trace.go:171","msg":"trace[1345344261] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1860; }","duration":"175.315472ms","start":"2026-04-08T23:00:23.337492Z","end":"2026-04-08T23:00:23.512808Z","steps":["trace[1345344261] 'agreement among raft nodes before linearized reading' (duration: 175.065435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:23.729454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.735098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-08T23:00:23.729564Z","caller":"traceutil/trace.go:171","msg":"trace[658497976] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1863; }","duration":"104.885163ms","start":"2026-04-08T23:00:23.62465Z","end":"2026-04-08T23:00:23.729535Z","steps":["trace[658497976] 'range keys from in-memory index tree' (duration: 104.535543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:00:23.729595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.902224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.153\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-08T23:00:23.729711Z","caller":"traceutil/trace.go:171","msg":"trace[636849570] range","detail":"{range_begin:/registry/masterleases/199.204.45.153; range_end:; response_count:1; response_revision:1863; }","duration":"170.089249ms","start":"2026-04-08T23:00:23.559602Z","end":"2026-04-08T23:00:23.729691Z","steps":["trace[636849570] 'range keys from in-memory index tree' (duration: 169.422751ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:02:30.81426Z","caller":"traceutil/trace.go:171","msg":"trace[1647276335] transaction","detail":"{read_only:false; response_revision:2799; number_of_response:1; }","duration":"252.869437ms","start":"2026-04-08T23:02:30.561359Z","end":"2026-04-08T23:02:30.814228Z","steps":["trace[1647276335] 'process raft request' (duration: 252.634561ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:02:30.871496Z","caller":"traceutil/trace.go:171","msg":"trace[212879102] transaction","detail":"{read_only:false; response_revision:2801; number_of_response:1; }","duration":"176.569835ms","start":"2026-04-08T23:02:30.694895Z","end":"2026-04-08T23:02:30.871465Z","steps":["trace[212879102] 'process raft request' (duration: 176.515563ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:02:30.871715Z","caller":"traceutil/trace.go:171","msg":"trace[664737201] transaction","detail":"{read_only:false; response_revision:2800; number_of_response:1; }","duration":"222.860252ms","start":"2026-04-08T23:02:30.648842Z","end":"2026-04-08T23:02:30.871702Z","steps":["trace[664737201] 'process raft request' (duration: 209.477669ms)","trace[664737201] 'compare' (duration: 12.928351ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T23:05:11.953312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.342083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T23:05:11.953181Z","caller":"traceutil/trace.go:171","msg":"trace[146269665] linearizableReadLoop","detail":"{readStateIndex:3990; appliedIndex:3989; }","duration":"201.193689ms","start":"2026-04-08T23:05:11.751951Z","end":"2026-04-08T23:05:11.953145Z","steps":["trace[146269665] 'read index received' (duration: 200.85823ms)","trace[146269665] 'applied index is now lower than readState.Index' (duration: 333.769µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:05:11.953428Z","caller":"traceutil/trace.go:171","msg":"trace[1906257796] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:3849; }","duration":"201.527968ms","start":"2026-04-08T23:05:11.751885Z","end":"2026-04-08T23:05:11.953413Z","steps":["trace[1906257796] 'agreement among raft nodes before linearized reading' (duration: 201.350743ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:05:11.953211Z","caller":"traceutil/trace.go:171","msg":"trace[1347526165] transaction","detail":"{read_only:false; response_revision:3849; number_of_response:1; }","duration":"252.326569ms","start":"2026-04-08T23:05:11.70086Z","end":"2026-04-08T23:05:11.953185Z","steps":["trace[1347526165] 'process raft request' (duration: 252.081823ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:05:17.325963Z","caller":"traceutil/trace.go:171","msg":"trace[703699117] transaction","detail":"{read_only:false; response_revision:3880; number_of_response:1; }","duration":"104.06424ms","start":"2026-04-08T23:05:17.221862Z","end":"2026-04-08T23:05:17.325926Z","steps":["trace[703699117] 'process raft request' (duration: 99.410482ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:06:46.808188Z","caller":"traceutil/trace.go:171","msg":"trace[1761406293] transaction","detail":"{read_only:false; response_revision:5065; number_of_response:1; }","duration":"215.820439ms","start":"2026-04-08T23:06:46.592345Z","end":"2026-04-08T23:06:46.808165Z","steps":["trace[1761406293] 'process raft request' (duration: 215.648414ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:06:58.41619Z","caller":"traceutil/trace.go:171","msg":"trace[897478228] transaction","detail":"{read_only:false; response_revision:5294; number_of_response:1; }","duration":"135.177488ms","start":"2026-04-08T23:06:58.280984Z","end":"2026-04-08T23:06:58.416161Z","steps":["trace[897478228] 'process raft request' (duration: 135.024904ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:06:58.574866Z","caller":"traceutil/trace.go:171","msg":"trace[892235058] linearizableReadLoop","detail":"{readStateIndex:5490; appliedIndex:5488; }","duration":"166.596249ms","start":"2026-04-08T23:06:58.408241Z","end":"2026-04-08T23:06:58.574837Z","steps":["trace[892235058] 'read index received' (duration: 7.836896ms)","trace[892235058] 'applied index is now lower than readState.Index' (duration: 158.757153ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:06:58.574875Z","caller":"traceutil/trace.go:171","msg":"trace[958240555] transaction","detail":"{read_only:false; response_revision:5295; number_of_response:1; }","duration":"198.562315ms","start":"2026-04-08T23:06:58.376266Z","end":"2026-04-08T23:06:58.574829Z","steps":["trace[958240555] 'process raft request' (duration: 134.795906ms)","trace[958240555] 'compare' (duration: 63.528583ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:06:58.574935Z","caller":"traceutil/trace.go:171","msg":"trace[536167700] transaction","detail":"{read_only:false; response_revision:5296; number_of_response:1; }","duration":"152.04538ms","start":"2026-04-08T23:06:58.422868Z","end":"2026-04-08T23:06:58.574914Z","steps":["trace[536167700] 'process raft request' (duration: 151.902346ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:06:58.57513Z","caller":"traceutil/trace.go:171","msg":"trace[1508058295] transaction","detail":"{read_only:false; response_revision:5297; number_of_response:1; }","duration":"152.002168ms","start":"2026-04-08T23:06:58.423074Z","end":"2026-04-08T23:06:58.575076Z","steps":["trace[1508058295] 'process raft request' (duration: 151.763101ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:06:58.575254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.971379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-mxkfq.18a484493952931b\" ","response":"range_response_count:1 size:906"} {"level":"info","ts":"2026-04-08T23:06:58.575359Z","caller":"traceutil/trace.go:171","msg":"trace[426151555] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-mxkfq.18a484493952931b; range_end:; response_count:1; response_revision:5297; }","duration":"167.157284ms","start":"2026-04-08T23:06:58.408176Z","end":"2026-04-08T23:06:58.575334Z","steps":["trace[426151555] 'agreement among raft nodes before linearized reading' (duration: 166.788904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:07:06.947364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.608666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2e0c2c4f-7059-46c5-ad1a-71376668629c\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-08T23:07:06.947468Z","caller":"traceutil/trace.go:171","msg":"trace[415882033] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2e0c2c4f-7059-46c5-ad1a-71376668629c; range_end:; response_count:1; response_revision:5468; }","duration":"117.76769ms","start":"2026-04-08T23:07:06.829678Z","end":"2026-04-08T23:07:06.947446Z","steps":["trace[415882033] 'range keys from in-memory index tree' (duration: 117.359389ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:08:10.486785Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3011} {"level":"info","ts":"2026-04-08T23:08:10.567928Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3011,"took":"79.581776ms","hash":759515721,"current-db-size-bytes":56774656,"current-db-size":"57 MB","current-db-size-in-use-bytes":31227904,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-08T23:08:10.568017Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":759515721,"revision":3011,"compact-revision":-1} {"level":"info","ts":"2026-04-08T23:12:03.202232Z","caller":"traceutil/trace.go:171","msg":"trace[1993038747] transaction","detail":"{read_only:false; response_revision:7697; number_of_response:1; }","duration":"107.671986ms","start":"2026-04-08T23:12:03.094522Z","end":"2026-04-08T23:12:03.202194Z","steps":["trace[1993038747] 'process raft request' (duration: 107.443689ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:03.356102Z","caller":"traceutil/trace.go:171","msg":"trace[684145316] transaction","detail":"{read_only:false; response_revision:7699; number_of_response:1; }","duration":"156.767788ms","start":"2026-04-08T23:12:03.199313Z","end":"2026-04-08T23:12:03.35608Z","steps":["trace[684145316] 'process raft request' (duration: 156.717907ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:12:03.356104Z","caller":"traceutil/trace.go:171","msg":"trace[632694774] transaction","detail":"{read_only:false; response_revision:7698; number_of_response:1; }","duration":"250.472681ms","start":"2026-04-08T23:12:03.10561Z","end":"2026-04-08T23:12:03.356082Z","steps":["trace[632694774] 'process raft request' (duration: 249.580177ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:13:10.499437Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6064} {"level":"info","ts":"2026-04-08T23:13:10.604065Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6064,"took":"102.182683ms","hash":1189536755,"current-db-size-bytes":56774656,"current-db-size":"57 MB","current-db-size-in-use-bytes":21590016,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-08T23:13:10.604141Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1189536755,"revision":6064,"compact-revision":3011} {"level":"info","ts":"2026-04-08T23:13:17.02858Z","caller":"traceutil/trace.go:171","msg":"trace[1033857377] linearizableReadLoop","detail":"{readStateIndex:8608; appliedIndex:8607; }","duration":"154.650118ms","start":"2026-04-08T23:13:16.873903Z","end":"2026-04-08T23:13:17.028553Z","steps":["trace[1033857377] 'read index received' (duration: 154.476063ms)","trace[1033857377] 'applied index is now lower than readState.Index' (duration: 172.415µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:13:17.028717Z","caller":"traceutil/trace.go:171","msg":"trace[2046394413] transaction","detail":"{read_only:false; response_revision:8318; number_of_response:1; }","duration":"178.15129ms","start":"2026-04-08T23:13:16.850511Z","end":"2026-04-08T23:13:17.028662Z","steps":["trace[2046394413] 'process raft request' (duration: 177.854702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:13:17.028818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.895614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T23:13:17.028908Z","caller":"traceutil/trace.go:171","msg":"trace[1415065443] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8318; }","duration":"155.017067ms","start":"2026-04-08T23:13:16.873856Z","end":"2026-04-08T23:13:17.028873Z","steps":["trace[1415065443] 'agreement among raft nodes before linearized reading' (duration: 154.863293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:13:17.028961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.49574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T23:13:17.029099Z","caller":"traceutil/trace.go:171","msg":"trace[602318093] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:8318; }","duration":"110.747517ms","start":"2026-04-08T23:13:16.918322Z","end":"2026-04-08T23:13:17.02907Z","steps":["trace[602318093] 'agreement among raft nodes before linearized reading' (duration: 110.48122ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:13:29.296742Z","caller":"traceutil/trace.go:171","msg":"trace[1676511188] transaction","detail":"{read_only:false; response_revision:8381; number_of_response:1; }","duration":"207.375509ms","start":"2026-04-08T23:13:29.089338Z","end":"2026-04-08T23:13:29.296713Z","steps":["trace[1676511188] 'process raft request' (duration: 207.187713ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:13:30.024788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.761978ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T23:13:30.025011Z","caller":"traceutil/trace.go:171","msg":"trace[398071666] linearizableReadLoop","detail":"{readStateIndex:8678; appliedIndex:8677; }","duration":"213.559527ms","start":"2026-04-08T23:13:29.811413Z","end":"2026-04-08T23:13:30.024973Z","steps":["trace[398071666] 'read index received' (duration: 55.231µs)","trace[398071666] 'applied index is now lower than readState.Index' (duration: 213.502376ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T23:13:30.025218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.806455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-67889fbd7f-5hdxg.18a484a341d925e6\" ","response":"range_response_count:1 size:1135"} {"level":"info","ts":"2026-04-08T23:13:30.025273Z","caller":"traceutil/trace.go:171","msg":"trace[1503186837] range","detail":"{range_begin:/registry/events/openstack/barbican-api-67889fbd7f-5hdxg.18a484a341d925e6; range_end:; response_count:1; response_revision:8384; }","duration":"213.908957ms","start":"2026-04-08T23:13:29.811349Z","end":"2026-04-08T23:13:30.025258Z","steps":["trace[1503186837] 'agreement among raft nodes before linearized reading' (duration: 213.714092ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:13:30.025374Z","caller":"traceutil/trace.go:171","msg":"trace[956274656] transaction","detail":"{read_only:false; response_revision:8384; number_of_response:1; }","duration":"312.346969ms","start":"2026-04-08T23:13:29.713001Z","end":"2026-04-08T23:13:30.025348Z","steps":["trace[956274656] 'process raft request' (duration: 61.718968ms)","trace[956274656] 'compare' (duration: 249.570002ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T23:13:30.025495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T23:13:29.712973Z","time spent":"312.457361ms","remote":"127.0.0.1:59470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T23:13:58.626675Z","caller":"traceutil/trace.go:171","msg":"trace[777169414] linearizableReadLoop","detail":"{readStateIndex:8895; appliedIndex:8894; }","duration":"197.407516ms","start":"2026-04-08T23:13:58.429236Z","end":"2026-04-08T23:13:58.626644Z","steps":["trace[777169414] 'read index received' (duration: 197.111968ms)","trace[777169414] 'applied index is now lower than readState.Index' (duration: 293.978µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T23:13:58.626839Z","caller":"traceutil/trace.go:171","msg":"trace[1624575088] transaction","detail":"{read_only:false; response_revision:8594; number_of_response:1; }","duration":"227.239252ms","start":"2026-04-08T23:13:58.399551Z","end":"2026-04-08T23:13:58.626791Z","steps":["trace[1624575088] 'process raft request' (duration: 226.882142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:13:58.627064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.64833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-08T23:13:58.627143Z","caller":"traceutil/trace.go:171","msg":"trace[1437178596] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8594; }","duration":"179.772514ms","start":"2026-04-08T23:13:58.447352Z","end":"2026-04-08T23:13:58.627125Z","steps":["trace[1437178596] 'agreement among raft nodes before linearized reading' (duration: 179.550248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:13:58.627282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.176569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-08T23:13:58.627297Z","caller":"traceutil/trace.go:171","msg":"trace[468707563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8594; }","duration":"156.323973ms","start":"2026-04-08T23:13:58.470969Z","end":"2026-04-08T23:13:58.627293Z","steps":["trace[468707563] 'agreement among raft nodes before linearized reading' (duration: 156.270991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:13:58.627468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.132984ms","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-08T23:13:58.627484Z","caller":"traceutil/trace.go:171","msg":"trace[1898829787] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8594; }","duration":"161.194166ms","start":"2026-04-08T23:13:58.466285Z","end":"2026-04-08T23:13:58.627479Z","steps":["trace[1898829787] 'agreement among raft nodes before linearized reading' (duration: 161.139754ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:13:58.627553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.87987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-08T23:13:58.627602Z","caller":"traceutil/trace.go:171","msg":"trace[1152995376] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8594; }","duration":"159.954463ms","start":"2026-04-08T23:13:58.467633Z","end":"2026-04-08T23:13:58.627587Z","steps":["trace[1152995376] 'agreement among raft nodes before linearized reading' (duration: 159.748417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T23:13:58.629055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.662133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T23:13:58.629135Z","caller":"traceutil/trace.go:171","msg":"trace[2001297673] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8594; }","duration":"199.951356ms","start":"2026-04-08T23:13:58.429166Z","end":"2026-04-08T23:13:58.629117Z","steps":["trace[2001297673] 'agreement among raft nodes before linearized reading' (duration: 197.685593ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:13:58.810485Z","caller":"traceutil/trace.go:171","msg":"trace[596661408] transaction","detail":"{read_only:false; response_revision:8595; number_of_response:1; }","duration":"176.431742ms","start":"2026-04-08T23:13:58.63402Z","end":"2026-04-08T23:13:58.810452Z","steps":["trace[596661408] 'process raft request' (duration: 176.216536ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:13:58.81249Z","caller":"traceutil/trace.go:171","msg":"trace[1778388391] transaction","detail":"{read_only:false; response_revision:8598; number_of_response:1; }","duration":"175.720682ms","start":"2026-04-08T23:13:58.636747Z","end":"2026-04-08T23:13:58.812468Z","steps":["trace[1778388391] 'process raft request' (duration: 175.679791ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:13:58.812806Z","caller":"traceutil/trace.go:171","msg":"trace[201148755] transaction","detail":"{read_only:false; response_revision:8596; number_of_response:1; }","duration":"178.19694ms","start":"2026-04-08T23:13:58.634596Z","end":"2026-04-08T23:13:58.812793Z","steps":["trace[201148755] 'process raft request' (duration: 177.712117ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:13:58.813309Z","caller":"traceutil/trace.go:171","msg":"trace[1513925861] transaction","detail":"{read_only:false; response_revision:8597; number_of_response:1; }","duration":"177.220773ms","start":"2026-04-08T23:13:58.635755Z","end":"2026-04-08T23:13:58.812976Z","steps":["trace[1513925861] 'process raft request' (duration: 176.627387ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T23:14:37.186446Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000245d.wal"} {"level":"info","ts":"2026-04-08T23:15:56.222196Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"355195d5aae85944","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-08T23:15:56.227345Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-08T23:15:56.227526Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-08T23:18:10.505401Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8155} {"level":"info","ts":"2026-04-08T23:18:10.568684Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8155,"took":"60.565507ms","hash":2360919228,"current-db-size-bytes":56774656,"current-db-size":"57 MB","current-db-size-in-use-bytes":29245440,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-08T23:18:10.568749Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2360919228,"revision":8155,"compact-revision":6064} {"level":"info","ts":"2026-04-08T23:23:10.512039Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10681} {"level":"info","ts":"2026-04-08T23:23:10.591005Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10681,"took":"76.468022ms","hash":2607653941,"current-db-size-bytes":56774656,"current-db-size":"57 MB","current-db-size-in-use-bytes":21327872,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-08T23:23:10.591079Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2607653941,"revision":10681,"compact-revision":8155}