{"level":"warn","ts":"2026-06-18T15:07:03.363079Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-18T15:07:03.363197Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.117: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.19.213.117:2380","--initial-cluster=instance=https://199.19.213.117:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.117:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.117: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-06-18T15:07:03.363275Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-18T15:07:03.363286Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.117:2380"]} {"level":"info","ts":"2026-06-18T15:07:03.36332Z","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-06-18T15:07:03.363989Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.117:2379"]} {"level":"info","ts":"2026-06-18T15:07:03.364076Z","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.19.213.117:2380"],"listen-peer-urls":["https://199.19.213.117:2380"],"advertise-client-urls":["https://199.19.213.117:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.117:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.117: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-06-18T15:07:03.366725Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.344908ms"} {"level":"info","ts":"2026-06-18T15:07:03.372246Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f9f905057b5b268","cluster-id":"293172f52aeb3f03"} {"level":"info","ts":"2026-06-18T15:07:03.372413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 switched to configuration voters=()"} {"level":"info","ts":"2026-06-18T15:07:03.372443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 became follower at term 0"} {"level":"info","ts":"2026-06-18T15:07:03.372459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f9f905057b5b268 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-18T15:07:03.372473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 became follower at term 1"} {"level":"info","ts":"2026-06-18T15:07:03.37252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 switched to configuration voters=(6890384629643457128)"} {"level":"warn","ts":"2026-06-18T15:07:03.376717Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-18T15:07:03.377834Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-18T15:07:03.378782Z","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-06-18T15:07:03.380783Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f9f905057b5b268","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-18T15:07:03.380912Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f9f905057b5b268","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-18T15:07:03.381086Z","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-06-18T15:07:03.381217Z","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-06-18T15:07:03.381232Z","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-06-18T15:07:03.38183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 switched to configuration voters=(6890384629643457128)"} {"level":"info","ts":"2026-06-18T15:07:03.381948Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"293172f52aeb3f03","local-member-id":"5f9f905057b5b268","added-peer-id":"5f9f905057b5b268","added-peer-peer-urls":["https://199.19.213.117:2380"]} {"level":"info","ts":"2026-06-18T15:07:03.385657Z","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-06-18T15:07:03.385733Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.117:2380"} {"level":"info","ts":"2026-06-18T15:07:03.385761Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.117:2380"} {"level":"info","ts":"2026-06-18T15:07:03.386019Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f9f905057b5b268","initial-advertise-peer-urls":["https://199.19.213.117:2380"],"listen-peer-urls":["https://199.19.213.117:2380"],"advertise-client-urls":["https://199.19.213.117:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.117:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-18T15:07:03.386064Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-18T15:07:03.873346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 is starting a new election at term 1"} {"level":"info","ts":"2026-06-18T15:07:03.873427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-18T15:07:03.87347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 received MsgPreVoteResp from 5f9f905057b5b268 at term 1"} {"level":"info","ts":"2026-06-18T15:07:03.873492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 became candidate at term 2"} {"level":"info","ts":"2026-06-18T15:07:03.873504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 received MsgVoteResp from 5f9f905057b5b268 at term 2"} {"level":"info","ts":"2026-06-18T15:07:03.873528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f9f905057b5b268 became leader at term 2"} {"level":"info","ts":"2026-06-18T15:07:03.873538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f9f905057b5b268 elected leader 5f9f905057b5b268 at term 2"} {"level":"info","ts":"2026-06-18T15:07:03.874697Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f9f905057b5b268","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.117:2379]}","request-path":"/0/members/5f9f905057b5b268/attributes","cluster-id":"293172f52aeb3f03","publish-timeout":"7s"} {"level":"info","ts":"2026-06-18T15:07:03.874733Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-18T15:07:03.874762Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-18T15:07:03.874774Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-18T15:07:03.875068Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-18T15:07:03.87518Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-18T15:07:03.875632Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"293172f52aeb3f03","local-member-id":"5f9f905057b5b268","cluster-version":"3.5"} {"level":"info","ts":"2026-06-18T15:07:03.875775Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-18T15:07:03.875817Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-18T15:07:03.878006Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.117:2379"} {"level":"info","ts":"2026-06-18T15:07:03.87831Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-18T15:07:40.399537Z","caller":"traceutil/trace.go:171","msg":"trace[1526845014] transaction","detail":"{read_only:false; number_of_response:0; response_revision:497; }","duration":"237.578308ms","start":"2026-06-18T15:07:40.161908Z","end":"2026-06-18T15:07:40.399486Z","steps":["trace[1526845014] 'process raft request' (duration: 237.337252ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:40.399885Z","caller":"traceutil/trace.go:171","msg":"trace[1354830081] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"230.462832ms","start":"2026-06-18T15:07:40.169407Z","end":"2026-06-18T15:07:40.39987Z","steps":["trace[1354830081] 'process raft request' (duration: 230.188005ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:40.399945Z","caller":"traceutil/trace.go:171","msg":"trace[716544027] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"230.116284ms","start":"2026-06-18T15:07:40.169793Z","end":"2026-06-18T15:07:40.399909Z","steps":["trace[716544027] 'process raft request' (duration: 230.027332ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:40.400021Z","caller":"traceutil/trace.go:171","msg":"trace[445140303] transaction","detail":"{read_only:false; number_of_response:1; response_revision:500; }","duration":"229.251202ms","start":"2026-06-18T15:07:40.170751Z","end":"2026-06-18T15:07:40.400002Z","steps":["trace[445140303] 'process raft request' (duration: 229.105449ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:40.399996Z","caller":"traceutil/trace.go:171","msg":"trace[1680463933] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:513; }","duration":"231.224431ms","start":"2026-06-18T15:07:40.168736Z","end":"2026-06-18T15:07:40.39996Z","steps":["trace[1680463933] 'read index received' (duration: 17.415559ms)","trace[1680463933] 'applied index is now lower than readState.Index' (duration: 213.808022ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:07:40.400162Z","caller":"traceutil/trace.go:171","msg":"trace[1307591058] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"220.687622ms","start":"2026-06-18T15:07:40.17944Z","end":"2026-06-18T15:07:40.400128Z","steps":["trace[1307591058] 'process raft request' (duration: 220.459657ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:40.40015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.375375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:07:40.400408Z","caller":"traceutil/trace.go:171","msg":"trace[410199823] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:501; }","duration":"231.693373ms","start":"2026-06-18T15:07:40.168699Z","end":"2026-06-18T15:07:40.400393Z","steps":["trace[410199823] 'agreement among raft nodes before linearized reading' (duration: 231.360295ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:40.399836Z","caller":"traceutil/trace.go:171","msg":"trace[651303299] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"230.428541ms","start":"2026-06-18T15:07:40.169344Z","end":"2026-06-18T15:07:40.399773Z","steps":["trace[651303299] 'process raft request' (duration: 230.029361ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:40.417759Z","caller":"traceutil/trace.go:171","msg":"trace[1964152943] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"225.037509ms","start":"2026-06-18T15:07:40.192666Z","end":"2026-06-18T15:07:40.417704Z","steps":["trace[1964152943] 'process raft request' (duration: 224.789273ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:40.418273Z","caller":"traceutil/trace.go:171","msg":"trace[2118946308] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"221.239296ms","start":"2026-06-18T15:07:40.197007Z","end":"2026-06-18T15:07:40.418246Z","steps":["trace[2118946308] 'process raft request' (duration: 221.131483ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:40.418521Z","caller":"traceutil/trace.go:171","msg":"trace[1361382191] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"220.173689ms","start":"2026-06-18T15:07:40.198317Z","end":"2026-06-18T15:07:40.418491Z","steps":["trace[1361382191] 'process raft request' (duration: 219.873171ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:40.419481Z","caller":"traceutil/trace.go:171","msg":"trace[13574444] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"221.963514ms","start":"2026-06-18T15:07:40.196898Z","end":"2026-06-18T15:07:40.418861Z","steps":["trace[13574444] 'process raft request' (duration: 221.055171ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:40.419752Z","caller":"traceutil/trace.go:171","msg":"trace[1185002673] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"219.973225ms","start":"2026-06-18T15:07:40.199762Z","end":"2026-06-18T15:07:40.419736Z","steps":["trace[1185002673] 'process raft request' (duration: 218.773286ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:40.419962Z","caller":"traceutil/trace.go:171","msg":"trace[1309409043] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"217.083313ms","start":"2026-06-18T15:07:40.202864Z","end":"2026-06-18T15:07:40.419947Z","steps":["trace[1309409043] 'process raft request' (duration: 216.856588ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:40.420063Z","caller":"traceutil/trace.go:171","msg":"trace[473108333] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"118.333662ms","start":"2026-06-18T15:07:40.30169Z","end":"2026-06-18T15:07:40.420024Z","steps":["trace[473108333] 'process raft request' (duration: 118.201309ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:40.6358Z","caller":"traceutil/trace.go:171","msg":"trace[1814252119] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"112.334784ms","start":"2026-06-18T15:07:40.52342Z","end":"2026-06-18T15:07:40.635755Z","steps":["trace[1814252119] 'process raft request' (duration: 98.035133ms)","trace[1814252119] 'compare' (duration: 13.999034ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:07:40.635882Z","caller":"traceutil/trace.go:171","msg":"trace[454176296] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"104.333758ms","start":"2026-06-18T15:07:40.531522Z","end":"2026-06-18T15:07:40.635855Z","steps":["trace[454176296] 'process raft request' (duration: 104.106822ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:46.550774Z","caller":"traceutil/trace.go:171","msg":"trace[121112781] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"250.934367ms","start":"2026-06-18T15:07:46.299804Z","end":"2026-06-18T15:07:46.550738Z","steps":["trace[121112781] 'process raft request' (duration: 250.373402ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:46.984682Z","caller":"traceutil/trace.go:171","msg":"trace[1988263073] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:615; }","duration":"193.148664ms","start":"2026-06-18T15:07:46.791501Z","end":"2026-06-18T15:07:46.984649Z","steps":["trace[1988263073] 'read index received' (duration: 192.99979ms)","trace[1988263073] 'applied index is now lower than readState.Index' (duration: 147.694µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:07:46.984814Z","caller":"traceutil/trace.go:171","msg":"trace[264007640] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"376.950557ms","start":"2026-06-18T15:07:46.607783Z","end":"2026-06-18T15:07:46.984734Z","steps":["trace[264007640] 'process raft request' (duration: 376.66602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:46.984971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.44538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.117\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-06-18T15:07:46.985029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.842855ms","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-06-18T15:07:46.985052Z","caller":"traceutil/trace.go:171","msg":"trace[1060880802] range","detail":"{range_begin:/registry/masterleases/199.19.213.117; range_end:; response_count:1; response_revision:591; }","duration":"193.597386ms","start":"2026-06-18T15:07:46.79144Z","end":"2026-06-18T15:07:46.985037Z","steps":["trace[1060880802] 'agreement among raft nodes before linearized reading' (duration: 193.364809ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:46.985084Z","caller":"traceutil/trace.go:171","msg":"trace[579119614] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:591; }","duration":"105.901117ms","start":"2026-06-18T15:07:46.879168Z","end":"2026-06-18T15:07:46.985069Z","steps":["trace[579119614] 'agreement among raft nodes before linearized reading' (duration: 105.65597ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:46.985423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:07:46.607736Z","time spent":"377.188113ms","remote":"127.0.0.1:33750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-18T15:07:47.218907Z","caller":"traceutil/trace.go:171","msg":"trace[2014746899] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:616; }","duration":"220.887417ms","start":"2026-06-18T15:07:46.99799Z","end":"2026-06-18T15:07:47.218878Z","steps":["trace[2014746899] 'read index received' (duration: 50.983125ms)","trace[2014746899] 'applied index is now lower than readState.Index' (duration: 169.903282ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:07:47.218928Z","caller":"traceutil/trace.go:171","msg":"trace[79781351] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"218.524129ms","start":"2026-06-18T15:07:47.000371Z","end":"2026-06-18T15:07:47.218895Z","steps":["trace[79781351] 'process raft request' (duration: 218.401206ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:07:47.218934Z","caller":"traceutil/trace.go:171","msg":"trace[1713100821] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"230.190936ms","start":"2026-06-18T15:07:46.988697Z","end":"2026-06-18T15:07:47.218888Z","steps":["trace[1713100821] 'process raft request' (duration: 153.16021ms)","trace[1713100821] 'compare' (duration: 76.686437ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:07:47.219041Z","caller":"traceutil/trace.go:171","msg":"trace[1824266819] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"169.00703ms","start":"2026-06-18T15:07:47.050021Z","end":"2026-06-18T15:07:47.219028Z","steps":["trace[1824266819] 'process raft request' (duration: 168.819935ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:07:47.219348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.340658ms","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-06-18T15:07:47.219421Z","caller":"traceutil/trace.go:171","msg":"trace[1892159027] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:594; }","duration":"221.477321ms","start":"2026-06-18T15:07:46.997924Z","end":"2026-06-18T15:07:47.219402Z","steps":["trace[1892159027] 'agreement among raft nodes before linearized reading' (duration: 221.068561ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:08:01.90973Z","caller":"traceutil/trace.go:171","msg":"trace[1147430923] linearizableReadLoop","detail":"{readStateIndex:778; appliedIndex:777; }","duration":"123.242033ms","start":"2026-06-18T15:08:01.786461Z","end":"2026-06-18T15:08:01.909703Z","steps":["trace[1147430923] 'read index received' (duration: 123.017708ms)","trace[1147430923] 'applied index is now lower than readState.Index' (duration: 223.525µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:08:01.909792Z","caller":"traceutil/trace.go:171","msg":"trace[185666666] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"124.401522ms","start":"2026-06-18T15:08:01.785355Z","end":"2026-06-18T15:08:01.909756Z","steps":["trace[185666666] 'process raft request' (duration: 124.188936ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:08:01.909951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.468308ms","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-06-18T15:08:01.909984Z","caller":"traceutil/trace.go:171","msg":"trace[779264547] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:749; }","duration":"123.53033ms","start":"2026-06-18T15:08:01.786446Z","end":"2026-06-18T15:08:01.909976Z","steps":["trace[779264547] 'agreement among raft nodes before linearized reading' (duration: 123.363716ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:08:33.636658Z","caller":"traceutil/trace.go:171","msg":"trace[1428412082] transaction","detail":"{read_only:false; response_revision:1157; number_of_response:1; }","duration":"123.848887ms","start":"2026-06-18T15:08:33.512786Z","end":"2026-06-18T15:08:33.636634Z","steps":["trace[1428412082] 'process raft request' (duration: 123.667223ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:08:54.445518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.950668ms","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-06-18T15:08:54.44563Z","caller":"traceutil/trace.go:171","msg":"trace[1619655691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1411; }","duration":"187.103312ms","start":"2026-06-18T15:08:54.258505Z","end":"2026-06-18T15:08:54.445608Z","steps":["trace[1619655691] 'range keys from in-memory index tree' (duration: 186.757573ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:08:54.448204Z","caller":"traceutil/trace.go:171","msg":"trace[1267239065] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"152.367638ms","start":"2026-06-18T15:08:54.295807Z","end":"2026-06-18T15:08:54.448175Z","steps":["trace[1267239065] 'process raft request' (duration: 152.163693ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:09:35.697499Z","caller":"traceutil/trace.go:171","msg":"trace[1144619697] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"122.223292ms","start":"2026-06-18T15:09:35.575251Z","end":"2026-06-18T15:09:35.697474Z","steps":["trace[1144619697] 'process raft request' (duration: 121.7162ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:10:35.086616Z","caller":"traceutil/trace.go:171","msg":"trace[980368019] transaction","detail":"{read_only:false; response_revision:2272; number_of_response:1; }","duration":"120.547907ms","start":"2026-06-18T15:10:34.966046Z","end":"2026-06-18T15:10:35.086594Z","steps":["trace[980368019] 'process raft request' (duration: 120.406274ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:10:35.215032Z","caller":"traceutil/trace.go:171","msg":"trace[1089499351] transaction","detail":"{read_only:false; response_revision:2273; number_of_response:1; }","duration":"247.193876ms","start":"2026-06-18T15:10:34.967799Z","end":"2026-06-18T15:10:35.214993Z","steps":["trace[1089499351] 'process raft request' (duration: 238.437187ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:10:35.877186Z","caller":"traceutil/trace.go:171","msg":"trace[1712428432] transaction","detail":"{read_only:false; response_revision:2275; number_of_response:1; }","duration":"125.628873ms","start":"2026-06-18T15:10:35.751533Z","end":"2026-06-18T15:10:35.877162Z","steps":["trace[1712428432] 'process raft request' (duration: 62.975016ms)","trace[1712428432] 'compare' (duration: 62.379571ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:11:25.493925Z","caller":"traceutil/trace.go:171","msg":"trace[810048409] transaction","detail":"{read_only:false; response_revision:2719; number_of_response:1; }","duration":"138.441775ms","start":"2026-06-18T15:11:25.355448Z","end":"2026-06-18T15:11:25.49389Z","steps":["trace[810048409] 'process raft request' (duration: 138.214369ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:11:31.659837Z","caller":"traceutil/trace.go:171","msg":"trace[1644264003] transaction","detail":"{read_only:false; response_revision:2760; number_of_response:1; }","duration":"120.890103ms","start":"2026-06-18T15:11:31.53891Z","end":"2026-06-18T15:11:31.6598Z","steps":["trace[1644264003] 'process raft request' (duration: 93.549431ms)","trace[1644264003] 'compare' (duration: 27.210409ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:12:00.489289Z","caller":"traceutil/trace.go:171","msg":"trace[827686830] transaction","detail":"{read_only:false; response_revision:2927; number_of_response:1; }","duration":"112.21409ms","start":"2026-06-18T15:12:00.377045Z","end":"2026-06-18T15:12:00.489259Z","steps":["trace[827686830] 'process raft request' (duration: 111.902843ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:14:25.724283Z","caller":"traceutil/trace.go:171","msg":"trace[966736131] transaction","detail":"{read_only:false; response_revision:3897; number_of_response:1; }","duration":"161.128836ms","start":"2026-06-18T15:14:25.563075Z","end":"2026-06-18T15:14:25.724204Z","steps":["trace[966736131] 'process raft request' (duration: 160.917731ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:15:44.52428Z","caller":"traceutil/trace.go:171","msg":"trace[1678403501] linearizableReadLoop","detail":"{readStateIndex:5119; appliedIndex:5118; }","duration":"105.592299ms","start":"2026-06-18T15:15:44.418658Z","end":"2026-06-18T15:15:44.52425Z","steps":["trace[1678403501] 'read index received' (duration: 11.381489ms)","trace[1678403501] 'applied index is now lower than readState.Index' (duration: 94.20939ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:15:44.52442Z","caller":"traceutil/trace.go:171","msg":"trace[421900397] transaction","detail":"{read_only:false; response_revision:4928; number_of_response:1; }","duration":"132.655952ms","start":"2026-06-18T15:15:44.391738Z","end":"2026-06-18T15:15:44.524394Z","steps":["trace[421900397] 'process raft request' (duration: 132.323694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:15:44.524484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.802314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:1219"} {"level":"info","ts":"2026-06-18T15:15:44.524517Z","caller":"traceutil/trace.go:171","msg":"trace[778567117] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4928; }","duration":"105.890856ms","start":"2026-06-18T15:15:44.418617Z","end":"2026-06-18T15:15:44.524508Z","steps":["trace[778567117] 'agreement among raft nodes before linearized reading' (duration: 105.725562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:15:50.09325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.762142ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-18T15:15:50.093386Z","caller":"traceutil/trace.go:171","msg":"trace[1043145538] transaction","detail":"{read_only:false; response_revision:5133; number_of_response:1; }","duration":"190.563772ms","start":"2026-06-18T15:15:49.902804Z","end":"2026-06-18T15:15:50.093368Z","steps":["trace[1043145538] 'process raft request' (duration: 18.494013ms)","trace[1043145538] 'compare' (duration: 171.621138ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:17:03.908074Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2949} {"level":"info","ts":"2026-06-18T15:17:03.976939Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2949,"took":"67.267726ms","hash":2364686521,"current-db-size-bytes":57802752,"current-db-size":"58 MB","current-db-size-in-use-bytes":34123776,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-18T15:17:03.977006Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2364686521,"revision":2949,"compact-revision":-1} {"level":"info","ts":"2026-06-18T15:22:03.92228Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6032} {"level":"info","ts":"2026-06-18T15:22:04.016848Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6032,"took":"93.214709ms","hash":3184037471,"current-db-size-bytes":57802752,"current-db-size":"58 MB","current-db-size-in-use-bytes":21360640,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-06-18T15:22:04.01694Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3184037471,"revision":6032,"compact-revision":2949} {"level":"info","ts":"2026-06-18T15:22:36.737718Z","caller":"traceutil/trace.go:171","msg":"trace[1363075565] transaction","detail":"{read_only:false; response_revision:8425; number_of_response:1; }","duration":"100.166149ms","start":"2026-06-18T15:22:36.637533Z","end":"2026-06-18T15:22:36.737699Z","steps":["trace[1363075565] 'process raft request' (duration: 100.048416ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:22:36.739958Z","caller":"traceutil/trace.go:171","msg":"trace[1701524290] transaction","detail":"{read_only:false; response_revision:8426; number_of_response:1; }","duration":"102.361483ms","start":"2026-06-18T15:22:36.637588Z","end":"2026-06-18T15:22:36.739949Z","steps":["trace[1701524290] 'process raft request' (duration: 102.304441ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:22:48.407473Z","caller":"traceutil/trace.go:171","msg":"trace[1256181836] transaction","detail":"{read_only:false; response_revision:8487; number_of_response:1; }","duration":"135.727089ms","start":"2026-06-18T15:22:48.271719Z","end":"2026-06-18T15:22:48.407446Z","steps":["trace[1256181836] 'process raft request' (duration: 135.579866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:22:49.395035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.078988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:22:49.39512Z","caller":"traceutil/trace.go:171","msg":"trace[1253806844] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8493; }","duration":"231.209621ms","start":"2026-06-18T15:22:49.163892Z","end":"2026-06-18T15:22:49.395102Z","steps":["trace[1253806844] 'range keys from in-memory index tree' (duration: 230.952655ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:22:49.877011Z","caller":"traceutil/trace.go:171","msg":"trace[1452968573] transaction","detail":"{read_only:false; response_revision:8495; number_of_response:1; }","duration":"145.661771ms","start":"2026-06-18T15:22:49.731326Z","end":"2026-06-18T15:22:49.876988Z","steps":["trace[1452968573] 'process raft request' (duration: 145.520617ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:22:49.89941Z","caller":"traceutil/trace.go:171","msg":"trace[936962557] transaction","detail":"{read_only:false; response_revision:8496; number_of_response:1; }","duration":"166.494039ms","start":"2026-06-18T15:22:49.732894Z","end":"2026-06-18T15:22:49.899388Z","steps":["trace[936962557] 'process raft request' (duration: 166.12645ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:23:21.959085Z","caller":"traceutil/trace.go:171","msg":"trace[929824528] transaction","detail":"{read_only:false; response_revision:8723; number_of_response:1; }","duration":"181.269781ms","start":"2026-06-18T15:23:21.777784Z","end":"2026-06-18T15:23:21.959054Z","steps":["trace[929824528] 'process raft request' (duration: 127.26216ms)","trace[929824528] 'compare' (duration: 53.825366ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:23:21.959279Z","caller":"traceutil/trace.go:171","msg":"trace[1303249758] transaction","detail":"{read_only:false; response_revision:8724; number_of_response:1; }","duration":"169.284369ms","start":"2026-06-18T15:23:21.789946Z","end":"2026-06-18T15:23:21.95923Z","steps":["trace[1303249758] 'process raft request' (duration: 169.060803ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:23:30.050913Z","caller":"traceutil/trace.go:171","msg":"trace[1342687205] transaction","detail":"{read_only:false; response_revision:8807; number_of_response:1; }","duration":"219.849477ms","start":"2026-06-18T15:23:29.831038Z","end":"2026-06-18T15:23:30.050887Z","steps":["trace[1342687205] 'process raft request' (duration: 219.661212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:23:30.280319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.007045ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-18T15:23:30.280425Z","caller":"traceutil/trace.go:171","msg":"trace[355298095] linearizableReadLoop","detail":"{readStateIndex:9124; appliedIndex:9123; }","duration":"226.12346ms","start":"2026-06-18T15:23:30.054284Z","end":"2026-06-18T15:23:30.280408Z","steps":["trace[355298095] 'read index received' (duration: 90.736326ms)","trace[355298095] 'applied index is now lower than readState.Index' (duration: 135.383814ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:23:30.280662Z","caller":"traceutil/trace.go:171","msg":"trace[1294801171] transaction","detail":"{read_only:false; response_revision:8808; number_of_response:1; }","duration":"293.950446ms","start":"2026-06-18T15:23:29.986698Z","end":"2026-06-18T15:23:30.280649Z","steps":["trace[1294801171] 'process raft request' (duration: 158.369667ms)","trace[1294801171] 'compare' (duration: 134.595155ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:23:30.281139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.232818ms","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-06-18T15:23:30.281215Z","caller":"traceutil/trace.go:171","msg":"trace[1184514057] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8808; }","duration":"155.343991ms","start":"2026-06-18T15:23:30.125853Z","end":"2026-06-18T15:23:30.281197Z","steps":["trace[1184514057] 'agreement among raft nodes before linearized reading' (duration: 155.143486ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:23:30.281237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.94884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-g4lwx\" ","response":"range_response_count:1 size:4650"} {"level":"info","ts":"2026-06-18T15:23:30.281294Z","caller":"traceutil/trace.go:171","msg":"trace[567046447] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-g4lwx; range_end:; response_count:1; response_revision:8808; }","duration":"227.035272ms","start":"2026-06-18T15:23:30.05424Z","end":"2026-06-18T15:23:30.281275Z","steps":["trace[567046447] 'agreement among raft nodes before linearized reading' (duration: 226.95309ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:23:30.281156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.418004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:23:30.281632Z","caller":"traceutil/trace.go:171","msg":"trace[1604139889] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8808; }","duration":"119.859135ms","start":"2026-06-18T15:23:30.161698Z","end":"2026-06-18T15:23:30.281558Z","steps":["trace[1604139889] 'agreement among raft nodes before linearized reading' (duration: 119.403064ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:23:30.281429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.141741ms","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-06-18T15:23:30.281912Z","caller":"traceutil/trace.go:171","msg":"trace[1713455797] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8808; }","duration":"147.629574ms","start":"2026-06-18T15:23:30.134243Z","end":"2026-06-18T15:23:30.281873Z","steps":["trace[1713455797] 'agreement among raft nodes before linearized reading' (duration: 147.0716ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:23:31.234831Z","caller":"traceutil/trace.go:171","msg":"trace[2042290430] transaction","detail":"{read_only:false; response_revision:8814; number_of_response:1; }","duration":"102.261077ms","start":"2026-06-18T15:23:31.13249Z","end":"2026-06-18T15:23:31.234751Z","steps":["trace[2042290430] 'process raft request' (duration: 102.013911ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:23:31.294786Z","caller":"traceutil/trace.go:171","msg":"trace[861138347] transaction","detail":"{read_only:false; response_revision:8815; number_of_response:1; }","duration":"128.422155ms","start":"2026-06-18T15:23:31.166333Z","end":"2026-06-18T15:23:31.294755Z","steps":["trace[861138347] 'process raft request' (duration: 92.887707ms)","trace[861138347] 'compare' (duration: 35.364074ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:23:31.295074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.749931ms","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-06-18T15:23:31.295163Z","caller":"traceutil/trace.go:171","msg":"trace[121331313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8816; }","duration":"121.872924ms","start":"2026-06-18T15:23:31.173271Z","end":"2026-06-18T15:23:31.295144Z","steps":["trace[121331313] 'agreement among raft nodes before linearized reading' (duration: 121.666379ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:23:31.518153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.505754ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-18T15:23:31.518392Z","caller":"traceutil/trace.go:171","msg":"trace[2013789814] transaction","detail":"{read_only:false; response_revision:8820; number_of_response:1; }","duration":"160.010486ms","start":"2026-06-18T15:23:31.358364Z","end":"2026-06-18T15:23:31.518375Z","steps":["trace[2013789814] 'process raft request' (duration: 159.912504ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:23:31.518441Z","caller":"traceutil/trace.go:171","msg":"trace[497688206] transaction","detail":"{read_only:false; response_revision:8819; number_of_response:1; }","duration":"169.950389ms","start":"2026-06-18T15:23:31.348453Z","end":"2026-06-18T15:23:31.518403Z","steps":["trace[497688206] 'process raft request' (duration: 46.104826ms)","trace[497688206] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/events/openstack/barbican-api-7c99957f9f-vwr5p.18ba3626719c8b98; req_size:1117; } (duration: 123.005243ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:23:44.455932Z","caller":"traceutil/trace.go:171","msg":"trace[1946095294] transaction","detail":"{read_only:false; response_revision:8918; number_of_response:1; }","duration":"131.47071ms","start":"2026-06-18T15:23:44.324421Z","end":"2026-06-18T15:23:44.455892Z","steps":["trace[1946095294] 'process raft request' (duration: 131.283425ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:23:46.571975Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002437.wal"} {"level":"info","ts":"2026-06-18T15:25:00.615442Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5f9f905057b5b268","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-18T15:25:00.620854Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-18T15:25:00.620995Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-18T15:27:03.930775Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8076} {"level":"info","ts":"2026-06-18T15:27:03.991383Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8076,"took":"58.34793ms","hash":2708684755,"current-db-size-bytes":57802752,"current-db-size":"58 MB","current-db-size-in-use-bytes":28090368,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-18T15:27:03.991437Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2708684755,"revision":8076,"compact-revision":6032} {"level":"info","ts":"2026-06-18T15:30:07.523693Z","caller":"traceutil/trace.go:171","msg":"trace[1781472461] transaction","detail":"{read_only:false; response_revision:11891; number_of_response:1; }","duration":"235.813015ms","start":"2026-06-18T15:30:07.287857Z","end":"2026-06-18T15:30:07.52367Z","steps":["trace[1781472461] 'process raft request' (duration: 235.61979ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:30:07.524315Z","caller":"traceutil/trace.go:171","msg":"trace[1456058717] linearizableReadLoop","detail":"{readStateIndex:12304; appliedIndex:12301; }","duration":"182.553427ms","start":"2026-06-18T15:30:07.341748Z","end":"2026-06-18T15:30:07.524302Z","steps":["trace[1456058717] 'read index received' (duration: 181.716087ms)","trace[1456058717] 'applied index is now lower than readState.Index' (duration: 836.33µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:30:07.524477Z","caller":"traceutil/trace.go:171","msg":"trace[1468577301] transaction","detail":"{read_only:false; response_revision:11892; number_of_response:1; }","duration":"236.0047ms","start":"2026-06-18T15:30:07.288436Z","end":"2026-06-18T15:30:07.524441Z","steps":["trace[1468577301] 'process raft request' (duration: 235.711443ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:30:07.524513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.734502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-pphbx\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-06-18T15:30:07.524547Z","caller":"traceutil/trace.go:171","msg":"trace[592455060] range","detail":"{range_begin:/registry/pods/openstack/keepalived-pphbx; range_end:; response_count:1; response_revision:11893; }","duration":"182.814854ms","start":"2026-06-18T15:30:07.341724Z","end":"2026-06-18T15:30:07.524539Z","steps":["trace[592455060] 'agreement among raft nodes before linearized reading' (duration: 182.62961ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:30:07.524577Z","caller":"traceutil/trace.go:171","msg":"trace[1066723427] transaction","detail":"{read_only:false; response_revision:11893; number_of_response:1; }","duration":"194.738814ms","start":"2026-06-18T15:30:07.329761Z","end":"2026-06-18T15:30:07.524499Z","steps":["trace[1066723427] 'process raft request' (duration: 194.503768ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:30:24.689481Z","caller":"traceutil/trace.go:171","msg":"trace[1946657235] transaction","detail":"{read_only:false; response_revision:11986; number_of_response:1; }","duration":"117.725778ms","start":"2026-06-18T15:30:24.571734Z","end":"2026-06-18T15:30:24.68946Z","steps":["trace[1946657235] 'process raft request' (duration: 117.592595ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:30:24.716099Z","caller":"traceutil/trace.go:171","msg":"trace[1343427041] linearizableReadLoop","detail":"{readStateIndex:12401; appliedIndex:12400; }","duration":"124.232856ms","start":"2026-06-18T15:30:24.591839Z","end":"2026-06-18T15:30:24.716072Z","steps":["trace[1343427041] 'read index received' (duration: 97.675029ms)","trace[1343427041] 'applied index is now lower than readState.Index' (duration: 26.556907ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:30:24.716375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.522983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/cinder-backup-7d9976b586-bhhkn.18ba368f95a437a8\" ","response":"range_response_count:1 size:811"} {"level":"info","ts":"2026-06-18T15:30:24.716434Z","caller":"traceutil/trace.go:171","msg":"trace[1173757717] range","detail":"{range_begin:/registry/events/openstack/cinder-backup-7d9976b586-bhhkn.18ba368f95a437a8; range_end:; response_count:1; response_revision:11989; }","duration":"124.617176ms","start":"2026-06-18T15:30:24.591803Z","end":"2026-06-18T15:30:24.716421Z","steps":["trace[1173757717] 'agreement among raft nodes before linearized reading' (duration: 124.431861ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:30:24.716186Z","caller":"traceutil/trace.go:171","msg":"trace[1040595794] transaction","detail":"{read_only:false; response_revision:11987; number_of_response:1; }","duration":"144.408968ms","start":"2026-06-18T15:30:24.571749Z","end":"2026-06-18T15:30:24.716158Z","steps":["trace[1040595794] 'process raft request' (duration: 144.107241ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:30:25.79119Z","caller":"traceutil/trace.go:171","msg":"trace[1740667786] linearizableReadLoop","detail":"{readStateIndex:12407; appliedIndex:12406; }","duration":"180.372375ms","start":"2026-06-18T15:30:25.610801Z","end":"2026-06-18T15:30:25.791173Z","steps":["trace[1740667786] 'read index received' (duration: 180.238202ms)","trace[1740667786] 'applied index is now lower than readState.Index' (duration: 133.063µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:30:25.791254Z","caller":"traceutil/trace.go:171","msg":"trace[938327614] transaction","detail":"{read_only:false; response_revision:11993; number_of_response:1; }","duration":"185.956911ms","start":"2026-06-18T15:30:25.605263Z","end":"2026-06-18T15:30:25.79122Z","steps":["trace[938327614] 'process raft request' (duration: 185.788877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:30:25.791438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.62034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-18T15:30:25.791503Z","caller":"traceutil/trace.go:171","msg":"trace[1955504551] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11993; }","duration":"180.733893ms","start":"2026-06-18T15:30:25.610755Z","end":"2026-06-18T15:30:25.791489Z","steps":["trace[1955504551] 'agreement among raft nodes before linearized reading' (duration: 180.488758ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:30:25.791683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.788326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-pphbx\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-06-18T15:30:25.79176Z","caller":"traceutil/trace.go:171","msg":"trace[1103893548] range","detail":"{range_begin:/registry/pods/openstack/keepalived-pphbx; range_end:; response_count:1; response_revision:11993; }","duration":"153.912489ms","start":"2026-06-18T15:30:25.637829Z","end":"2026-06-18T15:30:25.791742Z","steps":["trace[1103893548] 'agreement among raft nodes before linearized reading' (duration: 153.648333ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:31:51.27704Z","caller":"traceutil/trace.go:171","msg":"trace[991681442] linearizableReadLoop","detail":"{readStateIndex:12983; appliedIndex:12982; }","duration":"112.89831ms","start":"2026-06-18T15:31:51.164119Z","end":"2026-06-18T15:31:51.277017Z","steps":["trace[991681442] 'read index received' (duration: 106.584276ms)","trace[991681442] 'applied index is now lower than readState.Index' (duration: 6.313064ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:31:51.277325Z","caller":"traceutil/trace.go:171","msg":"trace[313790014] transaction","detail":"{read_only:false; response_revision:12551; number_of_response:1; }","duration":"131.559714ms","start":"2026-06-18T15:31:51.145751Z","end":"2026-06-18T15:31:51.277311Z","steps":["trace[313790014] 'process raft request' (duration: 125.023775ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:31:51.27745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.311001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:31:51.277508Z","caller":"traceutil/trace.go:171","msg":"trace[167611346] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12551; }","duration":"113.403993ms","start":"2026-06-18T15:31:51.16409Z","end":"2026-06-18T15:31:51.277494Z","steps":["trace[167611346] 'agreement among raft nodes before linearized reading' (duration: 113.303201ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:31:57.177862Z","caller":"traceutil/trace.go:171","msg":"trace[942929926] transaction","detail":"{read_only:false; response_revision:12605; number_of_response:1; }","duration":"111.179879ms","start":"2026-06-18T15:31:57.066662Z","end":"2026-06-18T15:31:57.177842Z","steps":["trace[942929926] 'process raft request' (duration: 111.096487ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:31:57.824332Z","caller":"traceutil/trace.go:171","msg":"trace[854669096] transaction","detail":"{read_only:false; response_revision:12610; number_of_response:1; }","duration":"122.745471ms","start":"2026-06-18T15:31:57.701554Z","end":"2026-06-18T15:31:57.824299Z","steps":["trace[854669096] 'process raft request' (duration: 122.404982ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:32:03.938671Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10485} {"level":"info","ts":"2026-06-18T15:32:04.014249Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10485,"took":"73.33133ms","hash":3611761240,"current-db-size-bytes":57802752,"current-db-size":"58 MB","current-db-size-in-use-bytes":26353664,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-18T15:32:04.014303Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3611761240,"revision":10485,"compact-revision":8076} {"level":"info","ts":"2026-06-18T15:35:03.437475Z","caller":"traceutil/trace.go:171","msg":"trace[846216356] linearizableReadLoop","detail":"{readStateIndex:14357; appliedIndex:14356; }","duration":"129.77405ms","start":"2026-06-18T15:35:03.307681Z","end":"2026-06-18T15:35:03.437455Z","steps":["trace[846216356] 'read index received' (duration: 129.578485ms)","trace[846216356] 'applied index is now lower than readState.Index' (duration: 194.515µs)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:35:03.437608Z","caller":"traceutil/trace.go:171","msg":"trace[1499975310] transaction","detail":"{read_only:false; response_revision:13878; number_of_response:1; }","duration":"195.428824ms","start":"2026-06-18T15:35:03.242139Z","end":"2026-06-18T15:35:03.437568Z","steps":["trace[1499975310] 'process raft request' (duration: 195.185328ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:35:03.437699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.998755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:35:03.437742Z","caller":"traceutil/trace.go:171","msg":"trace[1411507967] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:13878; }","duration":"130.094558ms","start":"2026-06-18T15:35:03.307636Z","end":"2026-06-18T15:35:03.437731Z","steps":["trace[1411507967] 'agreement among raft nodes before linearized reading' (duration: 130.007316ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:35:03.43777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.321687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-18T15:35:03.437802Z","caller":"traceutil/trace.go:171","msg":"trace[2132497144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13878; }","duration":"103.379219ms","start":"2026-06-18T15:35:03.334413Z","end":"2026-06-18T15:35:03.437792Z","steps":["trace[2132497144] 'agreement among raft nodes before linearized reading' (duration: 103.254946ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:36:54.384453Z","caller":"traceutil/trace.go:171","msg":"trace[762487900] transaction","detail":"{read_only:false; response_revision:14585; number_of_response:1; }","duration":"137.902679ms","start":"2026-06-18T15:36:54.24653Z","end":"2026-06-18T15:36:54.384433Z","steps":["trace[762487900] 'process raft request' (duration: 137.777626ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:37:03.953309Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12647} {"level":"info","ts":"2026-06-18T15:37:04.042233Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12647,"took":"86.925208ms","hash":1167712917,"current-db-size-bytes":57802752,"current-db-size":"58 MB","current-db-size-in-use-bytes":27148288,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-18T15:37:04.042291Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1167712917,"revision":12647,"compact-revision":10485} {"level":"warn","ts":"2026-06-18T15:37:09.87087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.199157ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-18T15:37:09.871081Z","caller":"traceutil/trace.go:171","msg":"trace[601947614] linearizableReadLoop","detail":"{readStateIndex:15194; appliedIndex:15193; }","duration":"213.496124ms","start":"2026-06-18T15:37:09.657511Z","end":"2026-06-18T15:37:09.871007Z","steps":["trace[601947614] 'read index received' (duration: 102.639527ms)","trace[601947614] 'applied index is now lower than readState.Index' (duration: 110.853136ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:37:09.871313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.785421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-18T15:37:09.871272Z","caller":"traceutil/trace.go:171","msg":"trace[135357441] transaction","detail":"{read_only:false; response_revision:14682; number_of_response:1; }","duration":"213.789781ms","start":"2026-06-18T15:37:09.657412Z","end":"2026-06-18T15:37:09.871202Z","steps":["trace[135357441] 'process raft request' (duration: 102.627527ms)","trace[135357441] 'compare' (duration: 104.051103ms)"],"step_count":2} {"level":"info","ts":"2026-06-18T15:37:09.871369Z","caller":"traceutil/trace.go:171","msg":"trace[1514181078] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:14682; }","duration":"213.884483ms","start":"2026-06-18T15:37:09.657457Z","end":"2026-06-18T15:37:09.871341Z","steps":["trace[1514181078] 'agreement among raft nodes before linearized reading' (duration: 213.659777ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:37:10.909313Z","caller":"traceutil/trace.go:171","msg":"trace[1895657380] transaction","detail":"{read_only:false; response_revision:14689; number_of_response:1; }","duration":"190.033918ms","start":"2026-06-18T15:37:10.719253Z","end":"2026-06-18T15:37:10.909287Z","steps":["trace[1895657380] 'process raft request' (duration: 189.876674ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:37:11.303848Z","caller":"traceutil/trace.go:171","msg":"trace[1809050207] linearizableReadLoop","detail":"{readStateIndex:15203; appliedIndex:15201; }","duration":"372.617756ms","start":"2026-06-18T15:37:10.93118Z","end":"2026-06-18T15:37:11.303798Z","steps":["trace[1809050207] 'read index received' (duration: 55.169202ms)","trace[1809050207] 'applied index is now lower than readState.Index' (duration: 317.446774ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:37:11.304142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.922314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-18T15:37:11.304259Z","caller":"traceutil/trace.go:171","msg":"trace[988870135] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:14691; }","duration":"373.021026ms","start":"2026-06-18T15:37:10.931174Z","end":"2026-06-18T15:37:11.304195Z","steps":["trace[988870135] 'agreement among raft nodes before linearized reading' (duration: 372.870693ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:37:11.30433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:37:10.931127Z","time spent":"373.18391ms","remote":"127.0.0.1:53156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-06-18T15:37:11.30387Z","caller":"traceutil/trace.go:171","msg":"trace[852242944] transaction","detail":"{read_only:false; response_revision:14691; number_of_response:1; }","duration":"389.707247ms","start":"2026-06-18T15:37:10.914118Z","end":"2026-06-18T15:37:11.303826Z","steps":["trace[852242944] 'process raft request' (duration: 389.224876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:37:11.304436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.02679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-18T15:37:11.304465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.389343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-pphbx\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-06-18T15:37:11.304501Z","caller":"traceutil/trace.go:171","msg":"trace[1436193316] range","detail":"{range_begin:/registry/pods/openstack/keepalived-pphbx; range_end:; response_count:1; response_revision:14691; }","duration":"351.457365ms","start":"2026-06-18T15:37:10.953033Z","end":"2026-06-18T15:37:11.304491Z","steps":["trace[1436193316] 'agreement among raft nodes before linearized reading' (duration: 351.328342ms)"],"step_count":1} {"level":"warn","ts":"2026-06-18T15:37:11.304488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:37:10.914096Z","time spent":"390.297223ms","remote":"127.0.0.1:33520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-18T15:37:11.304522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-18T15:37:10.953017Z","time spent":"351.500546ms","remote":"127.0.0.1:33420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6553,"request content":"key:\"/registry/pods/openstack/keepalived-pphbx\" "} {"level":"info","ts":"2026-06-18T15:37:11.304509Z","caller":"traceutil/trace.go:171","msg":"trace[640600938] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14691; }","duration":"140.138453ms","start":"2026-06-18T15:37:11.16435Z","end":"2026-06-18T15:37:11.304488Z","steps":["trace[640600938] 'agreement among raft nodes before linearized reading' (duration: 140.01759ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:37:33.21314Z","caller":"traceutil/trace.go:171","msg":"trace[1506813422] transaction","detail":"{read_only:false; response_revision:14999; number_of_response:1; }","duration":"121.40902ms","start":"2026-06-18T15:37:33.091707Z","end":"2026-06-18T15:37:33.213116Z","steps":["trace[1506813422] 'process raft request' (duration: 98.825855ms)","trace[1506813422] 'compare' (duration: 22.039052ms)"],"step_count":2} {"level":"warn","ts":"2026-06-18T15:38:58.523793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.378374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-18T15:38:58.523892Z","caller":"traceutil/trace.go:171","msg":"trace[1048576687] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:15803; }","duration":"129.549728ms","start":"2026-06-18T15:38:58.394327Z","end":"2026-06-18T15:38:58.523877Z","steps":["trace[1048576687] 'count revisions from in-memory index tree' (duration: 129.298131ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:39:05.035509Z","caller":"traceutil/trace.go:171","msg":"trace[979495882] transaction","detail":"{read_only:false; response_revision:15836; number_of_response:1; }","duration":"144.252543ms","start":"2026-06-18T15:39:04.891237Z","end":"2026-06-18T15:39:05.03549Z","steps":["trace[979495882] 'process raft request' (duration: 144.13116ms)"],"step_count":1} {"level":"info","ts":"2026-06-18T15:42:03.959409Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14634} {"level":"info","ts":"2026-06-18T15:42:04.033939Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14634,"took":"71.790435ms","hash":163780170,"current-db-size-bytes":57802752,"current-db-size":"58 MB","current-db-size-in-use-bytes":33890304,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-18T15:42:04.034052Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":163780170,"revision":14634,"compact-revision":12647} {"level":"info","ts":"2026-06-18T15:47:03.965326Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17296} {"level":"info","ts":"2026-06-18T15:47:04.059322Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17296,"took":"90.792482ms","hash":431767159,"current-db-size-bytes":57802752,"current-db-size":"58 MB","current-db-size-in-use-bytes":30519296,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-18T15:47:04.05938Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":431767159,"revision":17296,"compact-revision":14634} {"level":"info","ts":"2026-06-18T15:47:49.889547Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5f9f905057b5b268","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-18T15:47:49.895776Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-18T15:47:49.895869Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-18T15:52:03.971125Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19090} {"level":"info","ts":"2026-06-18T15:52:04.053531Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19090,"took":"79.163962ms","hash":2407100078,"current-db-size-bytes":57802752,"current-db-size":"58 MB","current-db-size-in-use-bytes":23797760,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-18T15:52:04.053584Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2407100078,"revision":19090,"compact-revision":17296}