{"level":"warn","ts":"2026-05-21T00:17:24.063404Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-21T00:17:24.063496Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.157:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.157:2380","--initial-cluster=instance=https://199.204.45.157:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.157:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.157:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-21T00:17:24.063576Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-21T00:17:24.063589Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-05-21T00:17:24.06361Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-21T00:17:24.06434Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"]} {"level":"info","ts":"2026-05-21T00:17:24.064447Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.157:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-21T00:17:24.068347Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.702905ms"} {"level":"info","ts":"2026-05-21T00:17:24.075313Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5f170c75a1d97cc","cluster-id":"44a3176ec85feb9"} {"level":"info","ts":"2026-05-21T00:17:24.075401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=()"} {"level":"info","ts":"2026-05-21T00:17:24.075433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 0"} {"level":"info","ts":"2026-05-21T00:17:24.075449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5f170c75a1d97cc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-21T00:17:24.075461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became follower at term 1"} {"level":"info","ts":"2026-05-21T00:17:24.075506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"warn","ts":"2026-05-21T00:17:24.08146Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-21T00:17:24.082725Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-21T00:17:24.083812Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-21T00:17:24.087884Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5f170c75a1d97cc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-21T00:17:24.088518Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5f170c75a1d97cc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-21T00:17:24.08862Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-21T00:17:24.088834Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-21T00:17:24.089296Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc switched to configuration voters=(428247441089599436)"} {"level":"info","ts":"2026-05-21T00:17:24.089859Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","added-peer-id":"5f170c75a1d97cc","added-peer-peer-urls":["https://199.204.45.157:2380"]} {"level":"info","ts":"2026-05-21T00:17:24.088855Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-21T00:17:24.096018Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-21T00:17:24.096321Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-05-21T00:17:24.096407Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5f170c75a1d97cc","initial-advertise-peer-urls":["https://199.204.45.157:2380"],"listen-peer-urls":["https://199.204.45.157:2380"],"advertise-client-urls":["https://199.204.45.157:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.157:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-21T00:17:24.096452Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-21T00:17:24.096419Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.157:2380"} {"level":"info","ts":"2026-05-21T00:17:24.682718Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc is starting a new election at term 1"} {"level":"info","ts":"2026-05-21T00:17:24.682835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became pre-candidate at term 1"} {"level":"info","ts":"2026-05-21T00:17:24.683348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgPreVoteResp from 5f170c75a1d97cc at term 1"} {"level":"info","ts":"2026-05-21T00:17:24.686073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became candidate at term 2"} {"level":"info","ts":"2026-05-21T00:17:24.686104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc received MsgVoteResp from 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-05-21T00:17:24.686139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5f170c75a1d97cc became leader at term 2"} {"level":"info","ts":"2026-05-21T00:17:24.686164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5f170c75a1d97cc elected leader 5f170c75a1d97cc at term 2"} {"level":"info","ts":"2026-05-21T00:17:24.694267Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T00:17:24.694978Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5f170c75a1d97cc","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.157:2379]}","request-path":"/0/members/5f170c75a1d97cc/attributes","cluster-id":"44a3176ec85feb9","publish-timeout":"7s"} {"level":"info","ts":"2026-05-21T00:17:24.698179Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-21T00:17:24.69853Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-21T00:17:24.698713Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-21T00:17:24.698744Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-21T00:17:24.701119Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.157:2379"} {"level":"info","ts":"2026-05-21T00:17:24.701563Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-21T00:17:24.702221Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"44a3176ec85feb9","local-member-id":"5f170c75a1d97cc","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T00:17:24.702293Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T00:17:24.702322Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-21T00:18:01.96355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.39851ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T00:18:01.964217Z","caller":"traceutil/trace.go:171","msg":"trace[1456767489] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"213.349054ms","start":"2026-05-21T00:18:01.750853Z","end":"2026-05-21T00:18:01.964202Z","steps":["trace[1456767489] 'process raft request' (duration: 212.822451ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:18:01.964264Z","caller":"traceutil/trace.go:171","msg":"trace[475251530] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"213.752427ms","start":"2026-05-21T00:18:01.750486Z","end":"2026-05-21T00:18:01.964239Z","steps":["trace[475251530] 'process raft request' (duration: 43.869066ms)","trace[475251530] 'compare' (duration: 168.254479ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T00:18:01.964347Z","caller":"traceutil/trace.go:171","msg":"trace[680618151] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"211.094349ms","start":"2026-05-21T00:18:01.753244Z","end":"2026-05-21T00:18:01.964338Z","steps":["trace[680618151] 'process raft request' (duration: 210.585226ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:18:01.96445Z","caller":"traceutil/trace.go:171","msg":"trace[827114705] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"210.072064ms","start":"2026-05-21T00:18:01.75437Z","end":"2026-05-21T00:18:01.964442Z","steps":["trace[827114705] 'process raft request' (duration: 209.50427ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:18:01.964678Z","caller":"traceutil/trace.go:171","msg":"trace[1834946944] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"197.722202ms","start":"2026-05-21T00:18:01.766901Z","end":"2026-05-21T00:18:01.964623Z","steps":["trace[1834946944] 'process raft request' (duration: 197.026108ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:18:08.735008Z","caller":"traceutil/trace.go:171","msg":"trace[1131565256] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"101.478097ms","start":"2026-05-21T00:18:08.633458Z","end":"2026-05-21T00:18:08.734936Z","steps":["trace[1131565256] 'read index received' (duration: 100.582272ms)","trace[1131565256] 'applied index is now lower than readState.Index' (duration: 894.645µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T00:18:08.735333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.84404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-21T00:18:08.735372Z","caller":"traceutil/trace.go:171","msg":"trace[2025153226] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:638; }","duration":"101.93616ms","start":"2026-05-21T00:18:08.633424Z","end":"2026-05-21T00:18:08.73536Z","steps":["trace[2025153226] 'agreement among raft nodes before linearized reading' (duration: 101.675378ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:18:08.735698Z","caller":"traceutil/trace.go:171","msg":"trace[1927145234] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"115.801928ms","start":"2026-05-21T00:18:08.619861Z","end":"2026-05-21T00:18:08.735663Z","steps":["trace[1927145234] 'process raft request' (duration: 114.48226ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:18:09.242889Z","caller":"traceutil/trace.go:171","msg":"trace[424536411] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:662; }","duration":"299.234872ms","start":"2026-05-21T00:18:08.943634Z","end":"2026-05-21T00:18:09.242869Z","steps":["trace[424536411] 'read index received' (duration: 296.505035ms)","trace[424536411] 'applied index is now lower than readState.Index' (duration: 2.728987ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T00:18:09.242985Z","caller":"traceutil/trace.go:171","msg":"trace[403996723] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"456.057387ms","start":"2026-05-21T00:18:08.786919Z","end":"2026-05-21T00:18:09.242976Z","steps":["trace[403996723] 'process raft request' (duration: 453.26866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:18:09.243056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T00:18:08.786886Z","time spent":"456.117957ms","remote":"127.0.0.1:53812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-21T00:18:09.243214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.368453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-84r4r\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-21T00:18:09.243288Z","caller":"traceutil/trace.go:171","msg":"trace[1417334576] range","detail":"{range_begin:/registry/pods/kube-system/cilium-84r4r; range_end:; response_count:1; response_revision:640; }","duration":"296.477164ms","start":"2026-05-21T00:18:08.946789Z","end":"2026-05-21T00:18:09.243266Z","steps":["trace[1417334576] 'agreement among raft nodes before linearized reading' (duration: 296.226342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:18:09.243309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.652805ms","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-05-21T00:18:09.243415Z","caller":"traceutil/trace.go:171","msg":"trace[1429406902] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:640; }","duration":"299.792585ms","start":"2026-05-21T00:18:08.943579Z","end":"2026-05-21T00:18:09.243372Z","steps":["trace[1429406902] 'agreement among raft nodes before linearized reading' (duration: 299.537124ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:19:13.619483Z","caller":"traceutil/trace.go:171","msg":"trace[1414716125] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"112.244464ms","start":"2026-05-21T00:19:13.507216Z","end":"2026-05-21T00:19:13.61946Z","steps":["trace[1414716125] 'process raft request' (duration: 112.199083ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:19:13.619639Z","caller":"traceutil/trace.go:171","msg":"trace[192344754] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"112.706855ms","start":"2026-05-21T00:19:13.50689Z","end":"2026-05-21T00:19:13.619597Z","steps":["trace[192344754] 'process raft request' (duration: 112.49244ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:19:13.619541Z","caller":"traceutil/trace.go:171","msg":"trace[843909048] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"113.235159ms","start":"2026-05-21T00:19:13.506277Z","end":"2026-05-21T00:19:13.619512Z","steps":["trace[843909048] 'process raft request' (duration: 103.622472ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:19:13.898691Z","caller":"traceutil/trace.go:171","msg":"trace[498493491] transaction","detail":"{read_only:false; response_revision:1385; number_of_response:1; }","duration":"126.792265ms","start":"2026-05-21T00:19:13.77188Z","end":"2026-05-21T00:19:13.898672Z","steps":["trace[498493491] 'process raft request' (duration: 126.498218ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:19:13.898616Z","caller":"traceutil/trace.go:171","msg":"trace[1439351097] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"126.666892ms","start":"2026-05-21T00:19:13.771882Z","end":"2026-05-21T00:19:13.898549Z","steps":["trace[1439351097] 'process raft request' (duration: 120.130615ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:19:42.342333Z","caller":"traceutil/trace.go:171","msg":"trace[1491858229] linearizableReadLoop","detail":"{readStateIndex:1959; appliedIndex:1958; }","duration":"140.458656ms","start":"2026-05-21T00:19:42.201844Z","end":"2026-05-21T00:19:42.342303Z","steps":["trace[1491858229] 'read index received' (duration: 140.264812ms)","trace[1491858229] 'applied index is now lower than readState.Index' (duration: 192.504µs)"],"step_count":2} {"level":"info","ts":"2026-05-21T00:19:42.342401Z","caller":"traceutil/trace.go:171","msg":"trace[1978676880] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"186.865634ms","start":"2026-05-21T00:19:42.155499Z","end":"2026-05-21T00:19:42.342365Z","steps":["trace[1978676880] 'process raft request' (duration: 186.602149ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:19:42.342786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.892205ms","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-05-21T00:19:42.343032Z","caller":"traceutil/trace.go:171","msg":"trace[926956354] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1888; }","duration":"141.2237ms","start":"2026-05-21T00:19:42.20179Z","end":"2026-05-21T00:19:42.343014Z","steps":["trace[926956354] 'agreement among raft nodes before linearized reading' (duration: 140.7107ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:19:42.344373Z","caller":"traceutil/trace.go:171","msg":"trace[36007056] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"105.850101ms","start":"2026-05-21T00:19:42.2385Z","end":"2026-05-21T00:19:42.34435Z","steps":["trace[36007056] 'process raft request' (duration: 105.559726ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:19:53.287118Z","caller":"traceutil/trace.go:171","msg":"trace[1237168610] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"114.680114ms","start":"2026-05-21T00:19:53.172419Z","end":"2026-05-21T00:19:53.287099Z","steps":["trace[1237168610] 'process raft request' (duration: 114.568942ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:19:53.736016Z","caller":"traceutil/trace.go:171","msg":"trace[67092794] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"115.493768ms","start":"2026-05-21T00:19:53.620504Z","end":"2026-05-21T00:19:53.735997Z","steps":["trace[67092794] 'process raft request' (duration: 115.363945ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:20:15.618576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.232462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-21T00:20:15.618666Z","caller":"traceutil/trace.go:171","msg":"trace[1219672391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2121; }","duration":"116.385255ms","start":"2026-05-21T00:20:15.502262Z","end":"2026-05-21T00:20:15.618647Z","steps":["trace[1219672391] 'range keys from in-memory index tree' (duration: 115.804996ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:20:15.619115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.644514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T00:20:15.619226Z","caller":"traceutil/trace.go:171","msg":"trace[1777528277] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2121; }","duration":"138.783118ms","start":"2026-05-21T00:20:15.480428Z","end":"2026-05-21T00:20:15.619211Z","steps":["trace[1777528277] 'range keys from in-memory index tree' (duration: 138.576654ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:20:15.773963Z","caller":"traceutil/trace.go:171","msg":"trace[244845220] linearizableReadLoop","detail":"{readStateIndex:2201; appliedIndex:2200; }","duration":"149.608808ms","start":"2026-05-21T00:20:15.624336Z","end":"2026-05-21T00:20:15.773945Z","steps":["trace[244845220] 'read index received' (duration: 149.329443ms)","trace[244845220] 'applied index is now lower than readState.Index' (duration: 278.495µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T00:20:15.774067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.715129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T00:20:15.774096Z","caller":"traceutil/trace.go:171","msg":"trace[1515327971] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2122; }","duration":"149.787651ms","start":"2026-05-21T00:20:15.624294Z","end":"2026-05-21T00:20:15.774082Z","steps":["trace[1515327971] 'agreement among raft nodes before linearized reading' (duration: 149.73336ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:20:15.774064Z","caller":"traceutil/trace.go:171","msg":"trace[2048667873] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"149.842761ms","start":"2026-05-21T00:20:15.624168Z","end":"2026-05-21T00:20:15.77401Z","steps":["trace[2048667873] 'process raft request' (duration: 149.631047ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:20:16.731528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.157765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-21T00:20:16.73161Z","caller":"traceutil/trace.go:171","msg":"trace[925911617] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2127; }","duration":"104.275557ms","start":"2026-05-21T00:20:16.627314Z","end":"2026-05-21T00:20:16.731589Z","steps":["trace[925911617] 'range keys from in-memory index tree' (duration: 103.965942ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:20:17.291768Z","caller":"traceutil/trace.go:171","msg":"trace[1932301562] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"225.234202ms","start":"2026-05-21T00:20:17.06651Z","end":"2026-05-21T00:20:17.291745Z","steps":["trace[1932301562] 'process raft request' (duration: 225.09384ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:20:17.348761Z","caller":"traceutil/trace.go:171","msg":"trace[159199262] linearizableReadLoop","detail":"{readStateIndex:2208; appliedIndex:2206; }","duration":"199.547293ms","start":"2026-05-21T00:20:17.14918Z","end":"2026-05-21T00:20:17.348728Z","steps":["trace[159199262] 'read index received' (duration: 142.458528ms)","trace[159199262] 'applied index is now lower than readState.Index' (duration: 57.087605ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T00:20:17.348943Z","caller":"traceutil/trace.go:171","msg":"trace[225417567] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"246.055804ms","start":"2026-05-21T00:20:17.102823Z","end":"2026-05-21T00:20:17.348879Z","steps":["trace[225417567] 'process raft request' (duration: 232.598345ms)","trace[225417567] 'compare' (duration: 13.152874ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T00:20:17.349128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.918818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-05-21T00:20:17.349215Z","caller":"traceutil/trace.go:171","msg":"trace[1730720167] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2129; }","duration":"200.076071ms","start":"2026-05-21T00:20:17.149124Z","end":"2026-05-21T00:20:17.3492Z","steps":["trace[1730720167] 'agreement among raft nodes before linearized reading' (duration: 199.713155ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:21:25.031151Z","caller":"traceutil/trace.go:171","msg":"trace[975161556] transaction","detail":"{read_only:false; response_revision:2598; number_of_response:1; }","duration":"192.206962ms","start":"2026-05-21T00:21:24.838907Z","end":"2026-05-21T00:21:25.031114Z","steps":["trace[975161556] 'process raft request' (duration: 191.936928ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:25:56.852502Z","caller":"traceutil/trace.go:171","msg":"trace[444559408] transaction","detail":"{read_only:false; response_revision:4803; number_of_response:1; }","duration":"102.690673ms","start":"2026-05-21T00:25:56.749757Z","end":"2026-05-21T00:25:56.852448Z","steps":["trace[444559408] 'process raft request' (duration: 102.50397ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:25:57.31451Z","caller":"traceutil/trace.go:171","msg":"trace[1948884792] transaction","detail":"{read_only:false; response_revision:4805; number_of_response:1; }","duration":"137.95153ms","start":"2026-05-21T00:25:57.176529Z","end":"2026-05-21T00:25:57.31448Z","steps":["trace[1948884792] 'process raft request' (duration: 137.796297ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:25:57.37845Z","caller":"traceutil/trace.go:171","msg":"trace[1586100723] linearizableReadLoop","detail":"{readStateIndex:4985; appliedIndex:4983; }","duration":"108.438465ms","start":"2026-05-21T00:25:57.269975Z","end":"2026-05-21T00:25:57.378414Z","steps":["trace[1586100723] 'read index received' (duration: 44.460712ms)","trace[1586100723] 'applied index is now lower than readState.Index' (duration: 63.975923ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T00:25:57.378534Z","caller":"traceutil/trace.go:171","msg":"trace[694740352] transaction","detail":"{read_only:false; response_revision:4806; number_of_response:1; }","duration":"111.030683ms","start":"2026-05-21T00:25:57.267452Z","end":"2026-05-21T00:25:57.378482Z","steps":["trace[694740352] 'process raft request' (duration: 60.486248ms)","trace[694740352] 'compare' (duration: 50.208609ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T00:25:57.378819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.817772ms","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-05-21T00:25:57.378911Z","caller":"traceutil/trace.go:171","msg":"trace[1017542771] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4806; }","duration":"108.931204ms","start":"2026-05-21T00:25:57.269959Z","end":"2026-05-21T00:25:57.378891Z","steps":["trace[1017542771] 'agreement among raft nodes before linearized reading' (duration: 108.642729ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:25:57.508501Z","caller":"traceutil/trace.go:171","msg":"trace[1710225208] transaction","detail":"{read_only:false; response_revision:4808; number_of_response:1; }","duration":"123.994872ms","start":"2026-05-21T00:25:57.384477Z","end":"2026-05-21T00:25:57.508471Z","steps":["trace[1710225208] 'process raft request' (duration: 109.017666ms)","trace[1710225208] 'compare' (duration: 14.186992ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T00:25:57.508869Z","caller":"traceutil/trace.go:171","msg":"trace[1905465566] linearizableReadLoop","detail":"{readStateIndex:4987; appliedIndex:4985; }","duration":"115.696609ms","start":"2026-05-21T00:25:57.393132Z","end":"2026-05-21T00:25:57.508828Z","steps":["trace[1905465566] 'read index received' (duration: 25.286828ms)","trace[1905465566] 'applied index is now lower than readState.Index' (duration: 90.406271ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T00:25:57.509082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.924013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-05-21T00:25:57.509139Z","caller":"traceutil/trace.go:171","msg":"trace[1343179390] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4809; }","duration":"116.058116ms","start":"2026-05-21T00:25:57.393064Z","end":"2026-05-21T00:25:57.509122Z","steps":["trace[1343179390] 'agreement among raft nodes before linearized reading' (duration: 115.872992ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:25:57.509486Z","caller":"traceutil/trace.go:171","msg":"trace[1221982018] transaction","detail":"{read_only:false; response_revision:4809; number_of_response:1; }","duration":"114.934755ms","start":"2026-05-21T00:25:57.393996Z","end":"2026-05-21T00:25:57.508931Z","steps":["trace[1221982018] 'process raft request' (duration: 114.377805ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:26:00.614282Z","caller":"traceutil/trace.go:171","msg":"trace[1904885378] transaction","detail":"{read_only:false; response_revision:4859; number_of_response:1; }","duration":"117.742451ms","start":"2026-05-21T00:26:00.496499Z","end":"2026-05-21T00:26:00.614241Z","steps":["trace[1904885378] 'process raft request' (duration: 117.507057ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:26:09.978347Z","caller":"traceutil/trace.go:171","msg":"trace[70402065] transaction","detail":"{read_only:false; response_revision:4983; number_of_response:1; }","duration":"143.38662ms","start":"2026-05-21T00:26:09.834919Z","end":"2026-05-21T00:26:09.978306Z","steps":["trace[70402065] 'process raft request' (duration: 111.570318ms)","trace[70402065] 'compare' (duration: 31.584098ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T00:26:10.148374Z","caller":"traceutil/trace.go:171","msg":"trace[2015182471] linearizableReadLoop","detail":"{readStateIndex:5169; appliedIndex:5167; }","duration":"267.891084ms","start":"2026-05-21T00:26:09.880455Z","end":"2026-05-21T00:26:10.148346Z","steps":["trace[2015182471] 'read index received' (duration: 66.066708ms)","trace[2015182471] 'applied index is now lower than readState.Index' (duration: 201.823376ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T00:26:10.148505Z","caller":"traceutil/trace.go:171","msg":"trace[959759878] transaction","detail":"{read_only:false; response_revision:4985; number_of_response:1; }","duration":"229.089755ms","start":"2026-05-21T00:26:09.919404Z","end":"2026-05-21T00:26:10.148494Z","steps":["trace[959759878] 'process raft request' (duration: 228.81599ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:26:10.14892Z","caller":"traceutil/trace.go:171","msg":"trace[148521447] transaction","detail":"{read_only:false; response_revision:4984; number_of_response:1; }","duration":"274.612496ms","start":"2026-05-21T00:26:09.874282Z","end":"2026-05-21T00:26:10.148894Z","steps":["trace[148521447] 'process raft request' (duration: 272.748622ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:26:10.148984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.508965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T00:26:10.149029Z","caller":"traceutil/trace.go:171","msg":"trace[1027164889] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4985; }","duration":"268.594347ms","start":"2026-05-21T00:26:09.880421Z","end":"2026-05-21T00:26:10.149016Z","steps":["trace[1027164889] 'agreement among raft nodes before linearized reading' (duration: 268.510476ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T00:26:10.14922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.366299ms","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-05-21T00:26:10.149361Z","caller":"traceutil/trace.go:171","msg":"trace[783521887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4985; }","duration":"102.561592ms","start":"2026-05-21T00:26:10.046778Z","end":"2026-05-21T00:26:10.149339Z","steps":["trace[783521887] 'agreement among raft nodes before linearized reading' (duration: 101.891869ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T00:27:24.735076Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2919} {"level":"info","ts":"2026-05-21T00:27:24.81191Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2919,"took":"75.520021ms","hash":1281969853,"current-db-size-bytes":54067200,"current-db-size":"54 MB","current-db-size-in-use-bytes":29085696,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-21T00:27:24.81196Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1281969853,"revision":2919,"compact-revision":-1} {"level":"info","ts":"2026-05-21T00:32:24.741024Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5596} {"level":"info","ts":"2026-05-21T00:32:24.839054Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5596,"took":"96.859231ms","hash":1147622508,"current-db-size-bytes":54067200,"current-db-size":"54 MB","current-db-size-in-use-bytes":18436096,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-21T00:32:24.839101Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1147622508,"revision":5596,"compact-revision":2919}