{"level":"warn","ts":"2026-08-10T22:24:55.494775Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-10T22:24:55.494897Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.14: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.14:2380","--initial-cluster=instance=https://199.19.213.14:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.14:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.14: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-08-10T22:24:55.494975Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-10T22:24:55.494985Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.14:2380"]} {"level":"info","ts":"2026-08-10T22:24:55.49502Z","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-08-10T22:24:55.495669Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.14:2379"]} {"level":"info","ts":"2026-08-10T22:24:55.495752Z","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.14:2380"],"listen-peer-urls":["https://199.19.213.14:2380"],"advertise-client-urls":["https://199.19.213.14:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.14:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.14: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-08-10T22:24:55.49987Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.809724ms"} {"level":"info","ts":"2026-08-10T22:24:55.509473Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"329f95029c2a91ed","cluster-id":"5fd85759a04d0f9f"} {"level":"info","ts":"2026-08-10T22:24:55.509594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed switched to configuration voters=()"} {"level":"info","ts":"2026-08-10T22:24:55.509628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became follower at term 0"} {"level":"info","ts":"2026-08-10T22:24:55.509642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 329f95029c2a91ed [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-10T22:24:55.509656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became follower at term 1"} {"level":"info","ts":"2026-08-10T22:24:55.509695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed switched to configuration voters=(3647798061635899885)"} {"level":"warn","ts":"2026-08-10T22:24:55.521552Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-10T22:24:55.523144Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-10T22:24:55.524328Z","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-08-10T22:24:55.526511Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"329f95029c2a91ed","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-10T22:24:55.526888Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"329f95029c2a91ed","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-10T22:24:55.526997Z","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-08-10T22:24:55.528596Z","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-08-10T22:24:55.52862Z","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-08-10T22:24:55.533756Z","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-08-10T22:24:55.533915Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.14:2380"} {"level":"info","ts":"2026-08-10T22:24:55.533966Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.14:2380"} {"level":"info","ts":"2026-08-10T22:24:55.534169Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"329f95029c2a91ed","initial-advertise-peer-urls":["https://199.19.213.14:2380"],"listen-peer-urls":["https://199.19.213.14:2380"],"advertise-client-urls":["https://199.19.213.14:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.14:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-10T22:24:55.534222Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-10T22:24:55.534623Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed switched to configuration voters=(3647798061635899885)"} {"level":"info","ts":"2026-08-10T22:24:55.534755Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5fd85759a04d0f9f","local-member-id":"329f95029c2a91ed","added-peer-id":"329f95029c2a91ed","added-peer-peer-urls":["https://199.19.213.14:2380"]} {"level":"info","ts":"2026-08-10T22:24:55.810619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed is starting a new election at term 1"} {"level":"info","ts":"2026-08-10T22:24:55.810716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became pre-candidate at term 1"} {"level":"info","ts":"2026-08-10T22:24:55.810818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed received MsgPreVoteResp from 329f95029c2a91ed at term 1"} {"level":"info","ts":"2026-08-10T22:24:55.810951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became candidate at term 2"} {"level":"info","ts":"2026-08-10T22:24:55.810974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed received MsgVoteResp from 329f95029c2a91ed at term 2"} {"level":"info","ts":"2026-08-10T22:24:55.810996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became leader at term 2"} {"level":"info","ts":"2026-08-10T22:24:55.811079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 329f95029c2a91ed elected leader 329f95029c2a91ed at term 2"} {"level":"info","ts":"2026-08-10T22:24:55.811959Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"329f95029c2a91ed","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.14:2379]}","request-path":"/0/members/329f95029c2a91ed/attributes","cluster-id":"5fd85759a04d0f9f","publish-timeout":"7s"} {"level":"info","ts":"2026-08-10T22:24:55.812002Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-10T22:24:55.812128Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-10T22:24:55.812255Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:24:55.812492Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-10T22:24:55.812557Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-10T22:24:55.813121Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5fd85759a04d0f9f","local-member-id":"329f95029c2a91ed","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:24:55.813355Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:24:55.813411Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-10T22:24:55.816405Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-10T22:24:55.816548Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.14:2379"} {"level":"info","ts":"2026-08-10T22:25:33.077844Z","caller":"traceutil/trace.go:171","msg":"trace[527426859] transaction","detail":"{read_only:false; number_of_response:1; response_revision:501; }","duration":"100.461598ms","start":"2026-08-10T22:25:32.977355Z","end":"2026-08-10T22:25:33.077817Z","steps":["trace[527426859] 'process raft request' (duration: 99.049369ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:25:33.078132Z","caller":"traceutil/trace.go:171","msg":"trace[1971829757] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"100.674401ms","start":"2026-08-10T22:25:32.977429Z","end":"2026-08-10T22:25:33.078103Z","steps":["trace[1971829757] 'process raft request' (duration: 100.155354ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:25:33.078205Z","caller":"traceutil/trace.go:171","msg":"trace[1910934180] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"100.692112ms","start":"2026-08-10T22:25:32.977494Z","end":"2026-08-10T22:25:33.078186Z","steps":["trace[1910934180] 'process raft request' (duration: 100.180874ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:25:33.084989Z","caller":"traceutil/trace.go:171","msg":"trace[945555362] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"101.115718ms","start":"2026-08-10T22:25:32.983849Z","end":"2026-08-10T22:25:33.084964Z","steps":["trace[945555362] 'process raft request' (duration: 100.386318ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:25:33.576773Z","caller":"traceutil/trace.go:171","msg":"trace[295642360] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"246.396659ms","start":"2026-08-10T22:25:33.330349Z","end":"2026-08-10T22:25:33.576746Z","steps":["trace[295642360] 'process raft request' (duration: 190.494081ms)","trace[295642360] 'compare' (duration: 55.012925ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:25:33.577423Z","caller":"traceutil/trace.go:171","msg":"trace[154650886] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"245.647617ms","start":"2026-08-10T22:25:33.331747Z","end":"2026-08-10T22:25:33.577395Z","steps":["trace[154650886] 'process raft request' (duration: 244.704414ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:25:33.577679Z","caller":"traceutil/trace.go:171","msg":"trace[924217646] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"240.543547ms","start":"2026-08-10T22:25:33.336936Z","end":"2026-08-10T22:25:33.577479Z","steps":["trace[924217646] 'process raft request' (duration: 240.314074ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:25:33.578223Z","caller":"traceutil/trace.go:171","msg":"trace[1920402411] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"228.085734ms","start":"2026-08-10T22:25:33.350122Z","end":"2026-08-10T22:25:33.578208Z","steps":["trace[1920402411] 'process raft request' (duration: 227.301563ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:25:39.765843Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515236548581317181,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-10T22:25:39.771444Z","caller":"traceutil/trace.go:171","msg":"trace[1844024190] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"506.33175ms","start":"2026-08-10T22:25:39.265092Z","end":"2026-08-10T22:25:39.771424Z","steps":["trace[1844024190] 'read index received' (duration: 505.476988ms)","trace[1844024190] 'applied index is now lower than readState.Index' (duration: 853.921µs)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:25:39.771569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.462301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.14\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-08-10T22:25:39.771615Z","caller":"traceutil/trace.go:171","msg":"trace[1699626236] range","detail":"{range_begin:/registry/masterleases/199.19.213.14; range_end:; response_count:1; response_revision:591; }","duration":"506.547352ms","start":"2026-08-10T22:25:39.265058Z","end":"2026-08-10T22:25:39.771606Z","steps":["trace[1699626236] 'agreement among raft nodes before linearized reading' (duration: 506.448401ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:25:39.771637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:25:39.26504Z","time spent":"506.591672ms","remote":"127.0.0.1:60208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.19.213.14\" "} {"level":"info","ts":"2026-08-10T22:25:39.771639Z","caller":"traceutil/trace.go:171","msg":"trace[142695455] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"511.952566ms","start":"2026-08-10T22:25:39.259589Z","end":"2026-08-10T22:25:39.771541Z","steps":["trace[142695455] 'process raft request' (duration: 511.197256ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:25:39.773744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:25:39.259547Z","time spent":"512.215709ms","remote":"127.0.0.1:60268","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-10T22:27:13.843036Z","caller":"traceutil/trace.go:171","msg":"trace[704925826] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"237.0689ms","start":"2026-08-10T22:27:13.605935Z","end":"2026-08-10T22:27:13.843004Z","steps":["trace[704925826] 'process raft request' (duration: 236.919788ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:27:13.892343Z","caller":"traceutil/trace.go:171","msg":"trace[145285193] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"257.974507ms","start":"2026-08-10T22:27:13.63434Z","end":"2026-08-10T22:27:13.892314Z","steps":["trace[145285193] 'process raft request' (duration: 225.390524ms)","trace[145285193] 'compare' (duration: 32.28321ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:27:26.250416Z","caller":"traceutil/trace.go:171","msg":"trace[1385565855] linearizableReadLoop","detail":"{readStateIndex:2026; appliedIndex:2025; }","duration":"169.171949ms","start":"2026-08-10T22:27:26.08122Z","end":"2026-08-10T22:27:26.250392Z","steps":["trace[1385565855] 'read index received' (duration: 168.926647ms)","trace[1385565855] 'applied index is now lower than readState.Index' (duration: 244.622µs)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:27:26.250595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.333411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-10T22:27:26.250662Z","caller":"traceutil/trace.go:171","msg":"trace[2130442571] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1955; }","duration":"169.437202ms","start":"2026-08-10T22:27:26.081212Z","end":"2026-08-10T22:27:26.250649Z","steps":["trace[2130442571] 'agreement among raft nodes before linearized reading' (duration: 169.29425ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:27:26.250604Z","caller":"traceutil/trace.go:171","msg":"trace[1368929771] transaction","detail":"{read_only:false; response_revision:1955; number_of_response:1; }","duration":"171.694087ms","start":"2026-08-10T22:27:26.078853Z","end":"2026-08-10T22:27:26.250547Z","steps":["trace[1368929771] 'process raft request' (duration: 171.319913ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:27:42.430703Z","caller":"traceutil/trace.go:171","msg":"trace[1315012920] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"122.35566ms","start":"2026-08-10T22:27:42.308316Z","end":"2026-08-10T22:27:42.430672Z","steps":["trace[1315012920] 'process raft request' (duration: 122.170988ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:27:48.617037Z","caller":"traceutil/trace.go:171","msg":"trace[821820959] linearizableReadLoop","detail":"{readStateIndex:2169; appliedIndex:2167; }","duration":"138.186911ms","start":"2026-08-10T22:27:48.478828Z","end":"2026-08-10T22:27:48.617015Z","steps":["trace[821820959] 'read index received' (duration: 57.16655ms)","trace[821820959] 'applied index is now lower than readState.Index' (duration: 81.019271ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:27:48.617226Z","caller":"traceutil/trace.go:171","msg":"trace[502025140] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"159.771898ms","start":"2026-08-10T22:27:48.457403Z","end":"2026-08-10T22:27:48.617175Z","steps":["trace[502025140] 'process raft request' (duration: 117.336652ms)","trace[502025140] 'compare' (duration: 42.176872ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:27:48.617546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.706507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-10T22:27:48.617592Z","caller":"traceutil/trace.go:171","msg":"trace[481437781] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2094; }","duration":"138.818608ms","start":"2026-08-10T22:27:48.478762Z","end":"2026-08-10T22:27:48.61758Z","steps":["trace[481437781] 'agreement among raft nodes before linearized reading' (duration: 138.339773ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:49.494971Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515236548581320165,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-10T22:27:49.505898Z","caller":"traceutil/trace.go:171","msg":"trace[746220585] linearizableReadLoop","detail":"{readStateIndex:2174; appliedIndex:2173; }","duration":"511.7536ms","start":"2026-08-10T22:27:48.994111Z","end":"2026-08-10T22:27:49.505865Z","steps":["trace[746220585] 'read index received' (duration: 511.429047ms)","trace[746220585] 'applied index is now lower than readState.Index' (duration: 323.583µs)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:27:49.506055Z","caller":"traceutil/trace.go:171","msg":"trace[1609324078] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"520.120588ms","start":"2026-08-10T22:27:48.985818Z","end":"2026-08-10T22:27:49.505939Z","steps":["trace[1609324078] 'process raft request' (duration: 519.859176ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:49.506177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.036644ms","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-08-10T22:27:49.506241Z","caller":"traceutil/trace.go:171","msg":"trace[983244799] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2099; }","duration":"512.162955ms","start":"2026-08-10T22:27:48.994061Z","end":"2026-08-10T22:27:49.506224Z","steps":["trace[983244799] 'agreement among raft nodes before linearized reading' (duration: 511.931652ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:49.506295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:27:48.994039Z","time spent":"512.240567ms","remote":"127.0.0.1:60456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-10T22:27:49.50637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.761702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-10T22:27:49.506491Z","caller":"traceutil/trace.go:171","msg":"trace[1843760271] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2099; }","duration":"511.949323ms","start":"2026-08-10T22:27:48.994514Z","end":"2026-08-10T22:27:49.506463Z","steps":["trace[1843760271] 'agreement among raft nodes before linearized reading' (duration: 511.58791ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:49.506546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:27:48.994506Z","time spent":"512.029854ms","remote":"127.0.0.1:60456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-10T22:27:49.506609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.971686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-10T22:27:49.506669Z","caller":"traceutil/trace.go:171","msg":"trace[719892512] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2099; }","duration":"234.072896ms","start":"2026-08-10T22:27:49.272579Z","end":"2026-08-10T22:27:49.506652Z","steps":["trace[719892512] 'agreement among raft nodes before linearized reading' (duration: 233.983495ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:49.506592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-10T22:27:48.985787Z","time spent":"520.365311ms","remote":"127.0.0.1:60456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-10T22:27:49.506725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.206307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.14\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-08-10T22:27:49.506919Z","caller":"traceutil/trace.go:171","msg":"trace[1238683316] range","detail":"{range_begin:/registry/masterleases/199.19.213.14; range_end:; response_count:1; response_revision:2099; }","duration":"231.51142ms","start":"2026-08-10T22:27:49.275387Z","end":"2026-08-10T22:27:49.506899Z","steps":["trace[1238683316] 'agreement among raft nodes before linearized reading' (duration: 231.058675ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:27:49.732208Z","caller":"traceutil/trace.go:171","msg":"trace[1268645086] linearizableReadLoop","detail":"{readStateIndex:2177; appliedIndex:2174; }","duration":"106.466138ms","start":"2026-08-10T22:27:49.62571Z","end":"2026-08-10T22:27:49.732177Z","steps":["trace[1268645086] 'read index received' (duration: 28.774982ms)","trace[1268645086] 'applied index is now lower than readState.Index' (duration: 77.689946ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:27:49.732499Z","caller":"traceutil/trace.go:171","msg":"trace[1002332439] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"220.624054ms","start":"2026-08-10T22:27:49.511841Z","end":"2026-08-10T22:27:49.732465Z","steps":["trace[1002332439] 'process raft request' (duration: 219.971278ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:27:49.732558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.838251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-10T22:27:49.732545Z","caller":"traceutil/trace.go:171","msg":"trace[748933214] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"220.291371ms","start":"2026-08-10T22:27:49.512222Z","end":"2026-08-10T22:27:49.732513Z","steps":["trace[748933214] 'process raft request' (duration: 219.855557ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:27:49.732622Z","caller":"traceutil/trace.go:171","msg":"trace[969144424] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2101; }","duration":"106.963652ms","start":"2026-08-10T22:27:49.625637Z","end":"2026-08-10T22:27:49.732601Z","steps":["trace[969144424] 'agreement among raft nodes before linearized reading' (duration: 106.668869ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:29:35.046808Z","caller":"traceutil/trace.go:171","msg":"trace[2134027899] transaction","detail":"{read_only:false; response_revision:2772; number_of_response:1; }","duration":"108.26825ms","start":"2026-08-10T22:29:34.93851Z","end":"2026-08-10T22:29:35.046778Z","steps":["trace[2134027899] 'process raft request' (duration: 108.031865ms)"],"step_count":1} {"level":"warn","ts":"2026-08-10T22:29:35.281225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.35176ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-10T22:29:35.28142Z","caller":"traceutil/trace.go:171","msg":"trace[1557098666] transaction","detail":"{read_only:false; response_revision:2774; number_of_response:1; }","duration":"107.765405ms","start":"2026-08-10T22:29:35.173635Z","end":"2026-08-10T22:29:35.281401Z","steps":["trace[1557098666] 'process raft request' (duration: 107.702983ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:29:35.281557Z","caller":"traceutil/trace.go:171","msg":"trace[1817875588] transaction","detail":"{read_only:false; response_revision:2773; number_of_response:1; }","duration":"250.002186ms","start":"2026-08-10T22:29:35.031514Z","end":"2026-08-10T22:29:35.281516Z","steps":["trace[1817875588] 'process raft request' (duration: 127.037572ms)","trace[1817875588] 'compare' (duration: 122.144226ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:33:43.965147Z","caller":"traceutil/trace.go:171","msg":"trace[1329135696] transaction","detail":"{read_only:false; response_revision:4831; number_of_response:1; }","duration":"102.032246ms","start":"2026-08-10T22:33:43.863093Z","end":"2026-08-10T22:33:43.965125Z","steps":["trace[1329135696] 'process raft request' (duration: 27.362394ms)","trace[1329135696] 'compare' (duration: 74.307117ms)"],"step_count":2} {"level":"info","ts":"2026-08-10T22:33:57.058901Z","caller":"traceutil/trace.go:171","msg":"trace[979748727] transaction","detail":"{read_only:false; response_revision:5008; number_of_response:1; }","duration":"104.699769ms","start":"2026-08-10T22:33:56.954171Z","end":"2026-08-10T22:33:57.058871Z","steps":["trace[979748727] 'process raft request' (duration: 104.500186ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:33:57.080342Z","caller":"traceutil/trace.go:171","msg":"trace[449538633] transaction","detail":"{read_only:false; response_revision:5009; number_of_response:1; }","duration":"125.774235ms","start":"2026-08-10T22:33:56.954538Z","end":"2026-08-10T22:33:57.080312Z","steps":["trace[449538633] 'process raft request' (duration: 125.586223ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:33:57.080677Z","caller":"traceutil/trace.go:171","msg":"trace[1087473655] transaction","detail":"{read_only:false; response_revision:5010; number_of_response:1; }","duration":"123.809898ms","start":"2026-08-10T22:33:56.956825Z","end":"2026-08-10T22:33:57.080635Z","steps":["trace[1087473655] 'process raft request' (duration: 123.442793ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:33:57.080902Z","caller":"traceutil/trace.go:171","msg":"trace[1424200487] transaction","detail":"{read_only:false; response_revision:5011; number_of_response:1; }","duration":"123.956159ms","start":"2026-08-10T22:33:56.956916Z","end":"2026-08-10T22:33:57.080872Z","steps":["trace[1424200487] 'process raft request' (duration: 123.630895ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:33:57.080937Z","caller":"traceutil/trace.go:171","msg":"trace[2121272638] linearizableReadLoop","detail":"{readStateIndex:5196; appliedIndex:5192; }","duration":"114.052756ms","start":"2026-08-10T22:33:56.966788Z","end":"2026-08-10T22:33:57.080841Z","steps":["trace[2121272638] 'read index received' (duration: 91.799744ms)","trace[2121272638] 'applied index is now lower than readState.Index' (duration: 22.251612ms)"],"step_count":2} {"level":"warn","ts":"2026-08-10T22:33:57.081288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.43201ms","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-08-10T22:33:57.081371Z","caller":"traceutil/trace.go:171","msg":"trace[596348978] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5012; }","duration":"114.607932ms","start":"2026-08-10T22:33:56.96675Z","end":"2026-08-10T22:33:57.081358Z","steps":["trace[596348978] 'agreement among raft nodes before linearized reading' (duration: 114.263638ms)"],"step_count":1} {"level":"info","ts":"2026-08-10T22:34:56.163295Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2885} {"level":"info","ts":"2026-08-10T22:34:56.238249Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2885,"took":"73.370202ms","hash":3561136070,"current-db-size-bytes":52580352,"current-db-size":"53 MB","current-db-size-in-use-bytes":29138944,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-10T22:34:56.238421Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3561136070,"revision":2885,"compact-revision":-1} {"level":"info","ts":"2026-08-10T22:39:56.170846Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5525} {"level":"info","ts":"2026-08-10T22:39:56.275459Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5525,"took":"103.120088ms","hash":1025022623,"current-db-size-bytes":52580352,"current-db-size":"53 MB","current-db-size-in-use-bytes":18554880,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-08-10T22:39:56.276018Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1025022623,"revision":5525,"compact-revision":2885}