{"level":"warn","ts":"2026-07-02T15:19:57.164834Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T15:19:57.164961Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.12: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.12:2380","--initial-cluster=instance=https://199.19.213.12:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.12:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.12: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-07-02T15:19:57.165051Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T15:19:57.165062Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.12:2380"]} {"level":"info","ts":"2026-07-02T15:19:57.165081Z","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-07-02T15:19:57.165774Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.12:2379"]} {"level":"info","ts":"2026-07-02T15:19:57.165859Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.12:2380"],"listen-peer-urls":["https://199.19.213.12:2380"],"advertise-client-urls":["https://199.19.213.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.12: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-07-02T15:19:57.195986Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"29.830712ms"} {"level":"info","ts":"2026-07-02T15:19:57.292278Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"790561176553eafe","cluster-id":"e32c72c573d8545f"} {"level":"info","ts":"2026-07-02T15:19:57.29264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe switched to configuration voters=()"} {"level":"info","ts":"2026-07-02T15:19:57.29275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became follower at term 0"} {"level":"info","ts":"2026-07-02T15:19:57.292838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 790561176553eafe [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-02T15:19:57.29288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became follower at term 1"} {"level":"info","ts":"2026-07-02T15:19:57.293208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe switched to configuration voters=(8720483006584974078)"} {"level":"warn","ts":"2026-07-02T15:19:57.336177Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-02T15:19:57.343626Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-02T15:19:57.352248Z","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-07-02T15:19:57.359461Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"790561176553eafe","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-02T15:19:57.359755Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"790561176553eafe","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-02T15:19:57.359871Z","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-07-02T15:19:57.359912Z","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-07-02T15:19:57.359921Z","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-07-02T15:19:57.362863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe switched to configuration voters=(8720483006584974078)"} {"level":"info","ts":"2026-07-02T15:19:57.363011Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e32c72c573d8545f","local-member-id":"790561176553eafe","added-peer-id":"790561176553eafe","added-peer-peer-urls":["https://199.19.213.12:2380"]} {"level":"info","ts":"2026-07-02T15:19:57.364896Z","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-07-02T15:19:57.365054Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.12:2380"} {"level":"info","ts":"2026-07-02T15:19:57.365148Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.12:2380"} {"level":"info","ts":"2026-07-02T15:19:57.366299Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"790561176553eafe","initial-advertise-peer-urls":["https://199.19.213.12:2380"],"listen-peer-urls":["https://199.19.213.12:2380"],"advertise-client-urls":["https://199.19.213.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-02T15:19:57.366367Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-02T15:19:57.794097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe is starting a new election at term 1"} {"level":"info","ts":"2026-07-02T15:19:57.794215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became pre-candidate at term 1"} {"level":"info","ts":"2026-07-02T15:19:57.794257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe received MsgPreVoteResp from 790561176553eafe at term 1"} {"level":"info","ts":"2026-07-02T15:19:57.794314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became candidate at term 2"} {"level":"info","ts":"2026-07-02T15:19:57.794337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe received MsgVoteResp from 790561176553eafe at term 2"} {"level":"info","ts":"2026-07-02T15:19:57.794381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became leader at term 2"} {"level":"info","ts":"2026-07-02T15:19:57.794416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 790561176553eafe elected leader 790561176553eafe at term 2"} {"level":"info","ts":"2026-07-02T15:19:57.795282Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T15:19:57.795617Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"790561176553eafe","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.12:2379]}","request-path":"/0/members/790561176553eafe/attributes","cluster-id":"e32c72c573d8545f","publish-timeout":"7s"} {"level":"info","ts":"2026-07-02T15:19:57.795692Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T15:19:57.795639Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T15:19:57.79608Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e32c72c573d8545f","local-member-id":"790561176553eafe","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T15:19:57.796181Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T15:19:57.796228Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T15:19:57.796348Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-02T15:19:57.796387Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-02T15:19:57.798923Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-02T15:19:57.813503Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.12:2379"} {"level":"info","ts":"2026-07-02T15:20:36.397877Z","caller":"traceutil/trace.go:171","msg":"trace[279028806] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"183.265815ms","start":"2026-07-02T15:20:36.214544Z","end":"2026-07-02T15:20:36.397809Z","steps":["trace[279028806] 'process raft request' (duration: 92.109851ms)","trace[279028806] 'compare' (duration: 90.348778ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:20:36.401414Z","caller":"traceutil/trace.go:171","msg":"trace[530132350] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"185.578242ms","start":"2026-07-02T15:20:36.215809Z","end":"2026-07-02T15:20:36.401387Z","steps":["trace[530132350] 'process raft request' (duration: 181.37046ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:36.401629Z","caller":"traceutil/trace.go:171","msg":"trace[370893815] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"183.851216ms","start":"2026-07-02T15:20:36.217762Z","end":"2026-07-02T15:20:36.401613Z","steps":["trace[370893815] 'process raft request' (duration: 183.305012ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:36.401603Z","caller":"traceutil/trace.go:171","msg":"trace[1628955253] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"180.852893ms","start":"2026-07-02T15:20:36.220704Z","end":"2026-07-02T15:20:36.401557Z","steps":["trace[1628955253] 'process raft request' (duration: 180.712273ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:36.401825Z","caller":"traceutil/trace.go:171","msg":"trace[706424006] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"182.966025ms","start":"2026-07-02T15:20:36.218843Z","end":"2026-07-02T15:20:36.401809Z","steps":["trace[706424006] 'process raft request' (duration: 182.443499ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:43.070181Z","caller":"traceutil/trace.go:171","msg":"trace[1193992251] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"345.93073ms","start":"2026-07-02T15:20:42.724201Z","end":"2026-07-02T15:20:43.070131Z","steps":["trace[1193992251] 'process raft request' (duration: 345.677533ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:43.071102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:42.724173Z","time spent":"346.151338ms","remote":"127.0.0.1:54964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T15:20:43.233855Z","caller":"traceutil/trace.go:171","msg":"trace[2080931238] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"451.975946ms","start":"2026-07-02T15:20:42.781856Z","end":"2026-07-02T15:20:43.233832Z","steps":["trace[2080931238] 'process raft request' (duration: 451.412695ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:20:43.234035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:42.781812Z","time spent":"452.139857ms","remote":"127.0.0.1:54888","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T15:20:43.687869Z","caller":"traceutil/trace.go:171","msg":"trace[866683814] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"377.915719ms","start":"2026-07-02T15:20:43.309909Z","end":"2026-07-02T15:20:43.687825Z","steps":["trace[866683814] 'process raft request' (duration: 338.796455ms)","trace[866683814] 'compare' (duration: 38.553573ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:20:43.688136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T15:20:43.309878Z","time spent":"378.152037ms","remote":"127.0.0.1:55290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T15:20:43.689585Z","caller":"traceutil/trace.go:171","msg":"trace[281907327] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"294.901446ms","start":"2026-07-02T15:20:43.394551Z","end":"2026-07-02T15:20:43.689453Z","steps":["trace[281907327] 'process raft request' (duration: 294.034461ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:43.850883Z","caller":"traceutil/trace.go:171","msg":"trace[2105565056] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"154.137045ms","start":"2026-07-02T15:20:43.696707Z","end":"2026-07-02T15:20:43.850844Z","steps":["trace[2105565056] 'process raft request' (duration: 153.994053ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:43.851016Z","caller":"traceutil/trace.go:171","msg":"trace[958774108] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"154.621652ms","start":"2026-07-02T15:20:43.696352Z","end":"2026-07-02T15:20:43.850973Z","steps":["trace[958774108] 'process raft request' (duration: 99.85232ms)","trace[958774108] 'compare' (duration: 54.259377ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:20:43.851631Z","caller":"traceutil/trace.go:171","msg":"trace[977533877] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"153.158906ms","start":"2026-07-02T15:20:43.698311Z","end":"2026-07-02T15:20:43.85147Z","steps":["trace[977533877] 'process raft request' (duration: 152.479151ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:20:43.852075Z","caller":"traceutil/trace.go:171","msg":"trace[1289988725] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:669; }","duration":"152.347426ms","start":"2026-07-02T15:20:43.699655Z","end":"2026-07-02T15:20:43.852003Z","steps":["trace[1289988725] 'read index received' (duration: 96.563717ms)","trace[1289988725] 'applied index is now lower than readState.Index' (duration: 55.77802ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:20:43.852172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.465381ms","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-07-02T15:20:43.852245Z","caller":"traceutil/trace.go:171","msg":"trace[76712036] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:645; }","duration":"152.614513ms","start":"2026-07-02T15:20:43.699612Z","end":"2026-07-02T15:20:43.852226Z","steps":["trace[76712036] 'agreement among raft nodes before linearized reading' (duration: 152.467011ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:24.500927Z","caller":"traceutil/trace.go:171","msg":"trace[1876333179] linearizableReadLoop","detail":"{readStateIndex:2006; appliedIndex:2002; }","duration":"201.522972ms","start":"2026-07-02T15:22:24.29938Z","end":"2026-07-02T15:22:24.500903Z","steps":["trace[1876333179] 'read index received' (duration: 13.875533ms)","trace[1876333179] 'applied index is now lower than readState.Index' (duration: 187.646559ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:22:24.501064Z","caller":"traceutil/trace.go:171","msg":"trace[1368212946] transaction","detail":"{read_only:false; response_revision:1944; number_of_response:1; }","duration":"245.565141ms","start":"2026-07-02T15:22:24.255438Z","end":"2026-07-02T15:22:24.501004Z","steps":["trace[1368212946] 'process raft request' (duration: 245.374212ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:24.501179Z","caller":"traceutil/trace.go:171","msg":"trace[1683590301] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"189.798645ms","start":"2026-07-02T15:22:24.311366Z","end":"2026-07-02T15:22:24.501165Z","steps":["trace[1683590301] 'process raft request' (duration: 189.48657ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:24.501287Z","caller":"traceutil/trace.go:171","msg":"trace[1738319381] transaction","detail":"{read_only:false; response_revision:1943; number_of_response:1; }","duration":"246.103938ms","start":"2026-07-02T15:22:24.255157Z","end":"2026-07-02T15:22:24.501261Z","steps":["trace[1738319381] 'process raft request' (duration: 245.561791ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:22:24.501476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.076879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-07-02T15:22:24.501516Z","caller":"traceutil/trace.go:171","msg":"trace[2033115140] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1945; }","duration":"202.158594ms","start":"2026-07-02T15:22:24.299344Z","end":"2026-07-02T15:22:24.501503Z","steps":["trace[2033115140] 'agreement among raft nodes before linearized reading' (duration: 202.009366ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:24.50092Z","caller":"traceutil/trace.go:171","msg":"trace[1035448002] transaction","detail":"{read_only:false; response_revision:1942; number_of_response:1; }","duration":"246.184931ms","start":"2026-07-02T15:22:24.254697Z","end":"2026-07-02T15:22:24.500882Z","steps":["trace[1035448002] 'process raft request' (duration: 154.881776ms)","trace[1035448002] 'compare' (duration: 90.684445ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:22:24.501985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.474327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T15:22:24.50204Z","caller":"traceutil/trace.go:171","msg":"trace[1910238578] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1945; }","duration":"139.564562ms","start":"2026-07-02T15:22:24.362459Z","end":"2026-07-02T15:22:24.502023Z","steps":["trace[1910238578] 'agreement among raft nodes before linearized reading' (duration: 139.466467ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:22:24.50214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.947241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-02T15:22:24.502158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.566034ms","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-07-02T15:22:24.502196Z","caller":"traceutil/trace.go:171","msg":"trace[100507286] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1945; }","duration":"125.040976ms","start":"2026-07-02T15:22:24.37713Z","end":"2026-07-02T15:22:24.502171Z","steps":["trace[100507286] 'agreement among raft nodes before linearized reading' (duration: 124.929661ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:24.502236Z","caller":"traceutil/trace.go:171","msg":"trace[1948982065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1945; }","duration":"123.676839ms","start":"2026-07-02T15:22:24.378538Z","end":"2026-07-02T15:22:24.502215Z","steps":["trace[1948982065] 'agreement among raft nodes before linearized reading' (duration: 123.450928ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:22:24.50226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.633878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-07-02T15:22:24.502307Z","caller":"traceutil/trace.go:171","msg":"trace[784586245] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1945; }","duration":"123.704271ms","start":"2026-07-02T15:22:24.378589Z","end":"2026-07-02T15:22:24.502294Z","steps":["trace[784586245] 'agreement among raft nodes before linearized reading' (duration: 123.510412ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:22:24.502334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.915897ms","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-07-02T15:22:24.504181Z","caller":"traceutil/trace.go:171","msg":"trace[318434415] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1945; }","duration":"129.013072ms","start":"2026-07-02T15:22:24.373362Z","end":"2026-07-02T15:22:24.502375Z","steps":["trace[318434415] 'agreement among raft nodes before linearized reading' (duration: 128.839034ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:26.623652Z","caller":"traceutil/trace.go:171","msg":"trace[347200220] linearizableReadLoop","detail":"{readStateIndex:2025; appliedIndex:2023; }","duration":"105.32326ms","start":"2026-07-02T15:22:26.518302Z","end":"2026-07-02T15:22:26.623626Z","steps":["trace[347200220] 'read index received' (duration: 99.823555ms)","trace[347200220] 'applied index is now lower than readState.Index' (duration: 5.498285ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:22:26.62386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.542111ms","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-07-02T15:22:26.623915Z","caller":"traceutil/trace.go:171","msg":"trace[66013233] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1961; }","duration":"105.629695ms","start":"2026-07-02T15:22:26.518271Z","end":"2026-07-02T15:22:26.623901Z","steps":["trace[66013233] 'agreement among raft nodes before linearized reading' (duration: 105.470377ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:26.623654Z","caller":"traceutil/trace.go:171","msg":"trace[513143855] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"123.10992ms","start":"2026-07-02T15:22:26.500519Z","end":"2026-07-02T15:22:26.623629Z","steps":["trace[513143855] 'process raft request' (duration: 117.593584ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:26.623745Z","caller":"traceutil/trace.go:171","msg":"trace[42849964] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"116.332641ms","start":"2026-07-02T15:22:26.5074Z","end":"2026-07-02T15:22:26.623733Z","steps":["trace[42849964] 'process raft request' (duration: 116.12158ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:22:55.654872Z","caller":"traceutil/trace.go:171","msg":"trace[831401494] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"245.809655ms","start":"2026-07-02T15:22:55.409022Z","end":"2026-07-02T15:22:55.654832Z","steps":["trace[831401494] 'process raft request' (duration: 153.616581ms)","trace[831401494] 'compare' (duration: 91.579408ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:24:10.479053Z","caller":"traceutil/trace.go:171","msg":"trace[1534931314] linearizableReadLoop","detail":"{readStateIndex:2893; appliedIndex:2892; }","duration":"114.902836ms","start":"2026-07-02T15:24:10.364084Z","end":"2026-07-02T15:24:10.478987Z","steps":["trace[1534931314] 'read index received' (duration: 114.699412ms)","trace[1534931314] 'applied index is now lower than readState.Index' (duration: 202.314µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:24:10.479103Z","caller":"traceutil/trace.go:171","msg":"trace[667422190] transaction","detail":"{read_only:false; response_revision:2785; number_of_response:1; }","duration":"226.107454ms","start":"2026-07-02T15:24:10.252954Z","end":"2026-07-02T15:24:10.479061Z","steps":["trace[667422190] 'process raft request' (duration: 225.896639ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:24:10.479288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.036785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"} {"level":"info","ts":"2026-07-02T15:24:10.479331Z","caller":"traceutil/trace.go:171","msg":"trace[1753919983] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2785; }","duration":"106.138542ms","start":"2026-07-02T15:24:10.37318Z","end":"2026-07-02T15:24:10.479319Z","steps":["trace[1753919983] 'agreement among raft nodes before linearized reading' (duration: 105.993322ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:24:10.479359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.25006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T15:24:10.479457Z","caller":"traceutil/trace.go:171","msg":"trace[6806338] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2785; }","duration":"115.419922ms","start":"2026-07-02T15:24:10.364018Z","end":"2026-07-02T15:24:10.479438Z","steps":["trace[6806338] 'agreement among raft nodes before linearized reading' (duration: 115.116471ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:24:10.619025Z","caller":"traceutil/trace.go:171","msg":"trace[82341874] linearizableReadLoop","detail":"{readStateIndex:2894; appliedIndex:2893; }","duration":"130.143025ms","start":"2026-07-02T15:24:10.488857Z","end":"2026-07-02T15:24:10.619Z","steps":["trace[82341874] 'read index received' (duration: 56.221632ms)","trace[82341874] 'applied index is now lower than readState.Index' (duration: 73.920192ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:24:10.619107Z","caller":"traceutil/trace.go:171","msg":"trace[587104771] transaction","detail":"{read_only:false; response_revision:2786; number_of_response:1; }","duration":"130.291465ms","start":"2026-07-02T15:24:10.488783Z","end":"2026-07-02T15:24:10.619075Z","steps":["trace[587104771] 'process raft request' (duration: 56.302817ms)","trace[587104771] 'compare' (duration: 73.637173ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:24:10.619616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.733077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/auth-system/keycloak\" ","response":"range_response_count:1 size:5908"} {"level":"info","ts":"2026-07-02T15:24:10.619672Z","caller":"traceutil/trace.go:171","msg":"trace[1838707593] range","detail":"{range_begin:/registry/statefulsets/auth-system/keycloak; range_end:; response_count:1; response_revision:2786; }","duration":"130.816251ms","start":"2026-07-02T15:24:10.488842Z","end":"2026-07-02T15:24:10.619658Z","steps":["trace[1838707593] 'agreement among raft nodes before linearized reading' (duration: 130.273924ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:26:22.37739Z","caller":"traceutil/trace.go:171","msg":"trace[413920474] linearizableReadLoop","detail":"{readStateIndex:4442; appliedIndex:4441; }","duration":"130.117807ms","start":"2026-07-02T15:26:22.247229Z","end":"2026-07-02T15:26:22.377347Z","steps":["trace[413920474] 'read index received' (duration: 111.862401ms)","trace[413920474] 'applied index is now lower than readState.Index' (duration: 18.253906ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:26:22.377734Z","caller":"traceutil/trace.go:171","msg":"trace[81974270] transaction","detail":"{read_only:false; response_revision:4257; number_of_response:1; }","duration":"205.210982ms","start":"2026-07-02T15:26:22.17251Z","end":"2026-07-02T15:26:22.377721Z","steps":["trace[81974270] 'process raft request' (duration: 186.677194ms)","trace[81974270] 'compare' (duration: 17.60776ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:26:22.378212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.931114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-07-02T15:26:22.378312Z","caller":"traceutil/trace.go:171","msg":"trace[261599] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4257; }","duration":"131.134036ms","start":"2026-07-02T15:26:22.24716Z","end":"2026-07-02T15:26:22.378294Z","steps":["trace[261599] 'agreement among raft nodes before linearized reading' (duration: 130.850653ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:26:22.399791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.418212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:46 size:2109529"} {"level":"info","ts":"2026-07-02T15:26:22.3999Z","caller":"traceutil/trace.go:171","msg":"trace[258211904] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:46; response_revision:4257; }","duration":"152.593643ms","start":"2026-07-02T15:26:22.247275Z","end":"2026-07-02T15:26:22.399869Z","steps":["trace[258211904] 'agreement among raft nodes before linearized reading' (duration: 131.351659ms)","trace[258211904] 'range keys from bolt db' (duration: 20.991932ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:26:30.537386Z","caller":"traceutil/trace.go:171","msg":"trace[650017893] transaction","detail":"{read_only:false; response_revision:4482; number_of_response:1; }","duration":"130.94801ms","start":"2026-07-02T15:26:30.406412Z","end":"2026-07-02T15:26:30.53736Z","steps":["trace[650017893] 'process raft request' (duration: 130.814749ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:26:30.587968Z","caller":"traceutil/trace.go:171","msg":"trace[1346638169] linearizableReadLoop","detail":"{readStateIndex:4675; appliedIndex:4673; }","duration":"156.56734ms","start":"2026-07-02T15:26:30.431379Z","end":"2026-07-02T15:26:30.587946Z","steps":["trace[1346638169] 'read index received' (duration: 105.876479ms)","trace[1346638169] 'applied index is now lower than readState.Index' (duration: 50.689281ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:26:30.588105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.703141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-62fb9a7c-8d1d-4398-8067-ce0bc3ea8df8\" ","response":"range_response_count:1 size:3765"} {"level":"info","ts":"2026-07-02T15:26:30.588138Z","caller":"traceutil/trace.go:171","msg":"trace[2142934181] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-62fb9a7c-8d1d-4398-8067-ce0bc3ea8df8; range_end:; response_count:1; response_revision:4483; }","duration":"156.770122ms","start":"2026-07-02T15:26:30.431356Z","end":"2026-07-02T15:26:30.588126Z","steps":["trace[2142934181] 'agreement among raft nodes before linearized reading' (duration: 156.673771ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:26:30.588366Z","caller":"traceutil/trace.go:171","msg":"trace[1498850202] transaction","detail":"{read_only:false; response_revision:4483; number_of_response:1; }","duration":"180.268753ms","start":"2026-07-02T15:26:30.408054Z","end":"2026-07-02T15:26:30.588322Z","steps":["trace[1498850202] 'process raft request' (duration: 179.777317ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:26:42.183695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.126133ms","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-07-02T15:26:42.183829Z","caller":"traceutil/trace.go:171","msg":"trace[1764091867] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4652; }","duration":"225.312805ms","start":"2026-07-02T15:26:41.958491Z","end":"2026-07-02T15:26:42.183804Z","steps":["trace[1764091867] 'range keys from in-memory index tree' (duration: 224.928299ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:26:42.184035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.494148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-02T15:26:42.184116Z","caller":"traceutil/trace.go:171","msg":"trace[911793144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4652; }","duration":"225.60624ms","start":"2026-07-02T15:26:41.958493Z","end":"2026-07-02T15:26:42.184099Z","steps":["trace[911793144] 'range keys from in-memory index tree' (duration: 225.263124ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:26:42.184182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.288846ms","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-07-02T15:26:42.184235Z","caller":"traceutil/trace.go:171","msg":"trace[1567475396] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4652; }","duration":"225.371317ms","start":"2026-07-02T15:26:41.958852Z","end":"2026-07-02T15:26:42.184223Z","steps":["trace[1567475396] 'range keys from in-memory index tree' (duration: 225.215455ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:26:42.486572Z","caller":"traceutil/trace.go:171","msg":"trace[955793040] transaction","detail":"{read_only:false; response_revision:4659; number_of_response:1; }","duration":"115.820976ms","start":"2026-07-02T15:26:42.370723Z","end":"2026-07-02T15:26:42.486544Z","steps":["trace[955793040] 'process raft request' (duration: 91.795352ms)","trace[955793040] 'compare' (duration: 23.888291ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:27:09.612393Z","caller":"traceutil/trace.go:171","msg":"trace[834745679] transaction","detail":"{read_only:false; response_revision:4989; number_of_response:1; }","duration":"103.942715ms","start":"2026-07-02T15:27:09.508427Z","end":"2026-07-02T15:27:09.61237Z","steps":["trace[834745679] 'process raft request' (duration: 40.566765ms)","trace[834745679] 'compare' (duration: 63.282997ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T15:27:18.742972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.52691ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T15:27:18.74309Z","caller":"traceutil/trace.go:171","msg":"trace[1907131858] linearizableReadLoop","detail":"{readStateIndex:5270; appliedIndex:5269; }","duration":"109.6434ms","start":"2026-07-02T15:27:18.63343Z","end":"2026-07-02T15:27:18.743073Z","steps":["trace[1907131858] 'read index received' (duration: 6.701388ms)","trace[1907131858] 'applied index is now lower than readState.Index' (duration: 102.940442ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T15:27:18.743131Z","caller":"traceutil/trace.go:171","msg":"trace[1871125997] transaction","detail":"{read_only:false; response_revision:5054; number_of_response:1; }","duration":"110.293629ms","start":"2026-07-02T15:27:18.632808Z","end":"2026-07-02T15:27:18.743101Z","steps":["trace[1871125997] 'compare' (duration: 102.269923ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T15:27:18.743392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.938439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-07-02T15:27:18.743474Z","caller":"traceutil/trace.go:171","msg":"trace[1273197187] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:5054; }","duration":"110.035981ms","start":"2026-07-02T15:27:18.633417Z","end":"2026-07-02T15:27:18.743453Z","steps":["trace[1273197187] 'agreement among raft nodes before linearized reading' (duration: 109.813625ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T15:29:57.825097Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3195} {"level":"info","ts":"2026-07-02T15:29:57.912692Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3195,"took":"86.182093ms","hash":330799615,"current-db-size-bytes":59699200,"current-db-size":"60 MB","current-db-size-in-use-bytes":32505856,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-02T15:29:57.912821Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":330799615,"revision":3195,"compact-revision":-1}