{"level":"warn","ts":"2026-05-08T10:16:41.297034Z","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-08T10:16:41.297107Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.162: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.162:2380","--initial-cluster=instance=https://199.204.45.162:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.162:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.162: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-08T10:16:41.29716Z","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-08T10:16:41.297172Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-05-08T10:16:41.297189Z","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-08T10:16:41.297801Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"]} {"level":"info","ts":"2026-05-08T10:16:41.297884Z","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.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.162: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-08T10:16:41.301252Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.1744ms"} {"level":"info","ts":"2026-05-08T10:16:41.307481Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2d372260bb4c37a","cluster-id":"52bb6ec15e8722ff"} {"level":"info","ts":"2026-05-08T10:16:41.307533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=()"} {"level":"info","ts":"2026-05-08T10:16:41.307552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 0"} {"level":"info","ts":"2026-05-08T10:16:41.307564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2d372260bb4c37a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-08T10:16:41.307571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 1"} {"level":"info","ts":"2026-05-08T10:16:41.307603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"warn","ts":"2026-05-08T10:16:41.314282Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-08T10:16:41.316064Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-08T10:16:41.317217Z","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-08T10:16:41.318753Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2d372260bb4c37a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-08T10:16:41.31893Z","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-08T10:16:41.319044Z","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-08T10:16:41.319073Z","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-08T10:16:41.31931Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2d372260bb4c37a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-08T10:16:41.32523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"info","ts":"2026-05-08T10:16:41.325316Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","added-peer-id":"2d372260bb4c37a","added-peer-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-05-08T10:16:41.325787Z","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-08T10:16:41.325892Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-05-08T10:16:41.325909Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-05-08T10:16:41.326026Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2d372260bb4c37a","initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-08T10:16:41.326065Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-08T10:16:41.407854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a is starting a new election at term 1"} {"level":"info","ts":"2026-05-08T10:16:41.407882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became pre-candidate at term 1"} {"level":"info","ts":"2026-05-08T10:16:41.407894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgPreVoteResp from 2d372260bb4c37a at term 1"} {"level":"info","ts":"2026-05-08T10:16:41.407903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became candidate at term 2"} {"level":"info","ts":"2026-05-08T10:16:41.407908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgVoteResp from 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-05-08T10:16:41.407918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became leader at term 2"} {"level":"info","ts":"2026-05-08T10:16:41.407925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2d372260bb4c37a elected leader 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-05-08T10:16:41.408647Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2d372260bb4c37a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.162:2379]}","request-path":"/0/members/2d372260bb4c37a/attributes","cluster-id":"52bb6ec15e8722ff","publish-timeout":"7s"} {"level":"info","ts":"2026-05-08T10:16:41.408736Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T10:16:41.408884Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T10:16:41.408983Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-08T10:16:41.409079Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-08T10:16:41.409071Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:16:41.410355Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.162:2379"} {"level":"info","ts":"2026-05-08T10:16:41.410433Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:16:41.41056Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:16:41.410609Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:16:41.413052Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-08T10:17:19.000682Z","caller":"traceutil/trace.go:171","msg":"trace[867998083] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"209.5374ms","start":"2026-05-08T10:17:18.791116Z","end":"2026-05-08T10:17:19.000654Z","steps":["trace[867998083] 'process raft request' (duration: 209.345856ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:17:19.057659Z","caller":"traceutil/trace.go:171","msg":"trace[1845156779] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:598; }","duration":"112.237099ms","start":"2026-05-08T10:17:18.945393Z","end":"2026-05-08T10:17:19.05763Z","steps":["trace[1845156779] 'read index received' (duration: 55.166136ms)","trace[1845156779] 'applied index is now lower than readState.Index' (duration: 57.069963ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:17:19.057908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.470124ms","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-08T10:17:19.058034Z","caller":"traceutil/trace.go:171","msg":"trace[663217013] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:578; }","duration":"112.692828ms","start":"2026-05-08T10:17:18.945325Z","end":"2026-05-08T10:17:19.058018Z","steps":["trace[663217013] 'agreement among raft nodes before linearized reading' (duration: 112.415783ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:17:19.058238Z","caller":"traceutil/trace.go:171","msg":"trace[898533453] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"161.879823ms","start":"2026-05-08T10:17:18.895805Z","end":"2026-05-08T10:17:19.057685Z","steps":["trace[898533453] 'process raft request' (duration: 161.301342ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:17:19.222501Z","caller":"traceutil/trace.go:171","msg":"trace[1765642377] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"110.340592ms","start":"2026-05-08T10:17:19.112124Z","end":"2026-05-08T10:17:19.222465Z","steps":["trace[1765642377] 'process raft request' (duration: 110.192209ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:17:19.786525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.009779ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T10:17:19.786635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.541539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-08T10:17:19.786715Z","caller":"traceutil/trace.go:171","msg":"trace[1273843303] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:580; }","duration":"373.241944ms","start":"2026-05-08T10:17:19.413424Z","end":"2026-05-08T10:17:19.786666Z","steps":["trace[1273843303] 'range keys from in-memory index tree' (duration: 372.985428ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:17:19.786746Z","caller":"traceutil/trace.go:171","msg":"trace[1959877299] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"448.706033ms","start":"2026-05-08T10:17:19.338021Z","end":"2026-05-08T10:17:19.786727Z","steps":["trace[1959877299] 'range keys from in-memory index tree' (duration: 448.376716ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:17:19.786781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:17:19.338003Z","time spent":"448.771264ms","remote":"127.0.0.1:41166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-08T10:17:19.788249Z","caller":"traceutil/trace.go:171","msg":"trace[1229018712] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"162.892276ms","start":"2026-05-08T10:17:19.625334Z","end":"2026-05-08T10:17:19.788226Z","steps":["trace[1229018712] 'process raft request' (duration: 162.180562ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:18:07.187066Z","caller":"traceutil/trace.go:171","msg":"trace[1635281448] linearizableReadLoop","detail":"{readStateIndex:1190; appliedIndex:1189; }","duration":"108.848048ms","start":"2026-05-08T10:18:07.078193Z","end":"2026-05-08T10:18:07.187041Z","steps":["trace[1635281448] 'read index received' (duration: 108.586272ms)","trace[1635281448] 'applied index is now lower than readState.Index' (duration: 260.496µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:18:07.187137Z","caller":"traceutil/trace.go:171","msg":"trace[365497540] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"172.385679ms","start":"2026-05-08T10:18:07.014713Z","end":"2026-05-08T10:18:07.187099Z","steps":["trace[365497540] 'process raft request' (duration: 172.076463ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:18:07.187475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.213276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T10:18:07.187555Z","caller":"traceutil/trace.go:171","msg":"trace[1032370586] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1156; }","duration":"109.378199ms","start":"2026-05-08T10:18:07.078161Z","end":"2026-05-08T10:18:07.187539Z","steps":["trace[1032370586] 'agreement among raft nodes before linearized reading' (duration: 108.98108ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:18:54.387148Z","caller":"traceutil/trace.go:171","msg":"trace[445210843] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"122.954954ms","start":"2026-05-08T10:18:54.264166Z","end":"2026-05-08T10:18:54.387121Z","steps":["trace[445210843] 'process raft request' (duration: 122.805802ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:18:54.523218Z","caller":"traceutil/trace.go:171","msg":"trace[133798581] linearizableReadLoop","detail":"{readStateIndex:1891; appliedIndex:1889; }","duration":"242.94714ms","start":"2026-05-08T10:18:54.280245Z","end":"2026-05-08T10:18:54.523192Z","steps":["trace[133798581] 'read index received' (duration: 106.700304ms)","trace[133798581] 'applied index is now lower than readState.Index' (duration: 136.245756ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:18:54.523271Z","caller":"traceutil/trace.go:171","msg":"trace[1293791002] transaction","detail":"{read_only:false; response_revision:1819; number_of_response:1; }","duration":"254.25942ms","start":"2026-05-08T10:18:54.26898Z","end":"2026-05-08T10:18:54.52324Z","steps":["trace[1293791002] 'process raft request' (duration: 254.038735ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:18:54.523462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.209265ms","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-08T10:18:54.523505Z","caller":"traceutil/trace.go:171","msg":"trace[285730977] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1819; }","duration":"243.307377ms","start":"2026-05-08T10:18:54.280184Z","end":"2026-05-08T10:18:54.523492Z","steps":["trace[285730977] 'agreement among raft nodes before linearized reading' (duration: 243.146784ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:18:54.523523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.393863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-21975ede-f052-4eb8-acf1-9334042baf6c\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-05-08T10:18:54.523523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.936973ms","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-05-08T10:18:54.523552Z","caller":"traceutil/trace.go:171","msg":"trace[19012108] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-21975ede-f052-4eb8-acf1-9334042baf6c; range_end:; response_count:1; response_revision:1819; }","duration":"171.477914ms","start":"2026-05-08T10:18:54.352065Z","end":"2026-05-08T10:18:54.523543Z","steps":["trace[19012108] 'agreement among raft nodes before linearized reading' (duration: 171.367552ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:18:54.523579Z","caller":"traceutil/trace.go:171","msg":"trace[351016265] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1819; }","duration":"172.039336ms","start":"2026-05-08T10:18:54.351525Z","end":"2026-05-08T10:18:54.523564Z","steps":["trace[351016265] 'agreement among raft nodes before linearized reading' (duration: 171.848102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:18:55.04055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.192402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-08T10:18:55.041305Z","caller":"traceutil/trace.go:171","msg":"trace[537745693] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:1826; }","duration":"235.001638ms","start":"2026-05-08T10:18:54.806274Z","end":"2026-05-08T10:18:55.041276Z","steps":["trace[537745693] 'range keys from in-memory index tree' (duration: 233.966217ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:18:55.040647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.799108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-05-08T10:18:55.041677Z","caller":"traceutil/trace.go:171","msg":"trace[417719071] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1826; }","duration":"194.86626ms","start":"2026-05-08T10:18:54.846786Z","end":"2026-05-08T10:18:55.041653Z","steps":["trace[417719071] 'range keys from in-memory index tree' (duration: 193.588294ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:18:55.040867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.069905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:18:55.041794Z","caller":"traceutil/trace.go:171","msg":"trace[1204084011] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1826; }","duration":"335.030006ms","start":"2026-05-08T10:18:54.70674Z","end":"2026-05-08T10:18:55.04177Z","steps":["trace[1204084011] 'range keys from in-memory index tree' (duration: 333.968024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:18:55.041864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:18:54.706715Z","time spent":"335.127018ms","remote":"127.0.0.1:40874","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T10:18:55.162073Z","caller":"traceutil/trace.go:171","msg":"trace[1022004532] linearizableReadLoop","detail":"{readStateIndex:1899; appliedIndex:1898; }","duration":"172.890513ms","start":"2026-05-08T10:18:54.98916Z","end":"2026-05-08T10:18:55.16205Z","steps":["trace[1022004532] 'read index received' (duration: 172.72236ms)","trace[1022004532] 'applied index is now lower than readState.Index' (duration: 167.173µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:18:55.162132Z","caller":"traceutil/trace.go:171","msg":"trace[1666132623] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"300.934111ms","start":"2026-05-08T10:18:54.861165Z","end":"2026-05-08T10:18:55.162099Z","steps":["trace[1666132623] 'process raft request' (duration: 300.734247ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:18:55.162396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.232189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-08T10:18:55.162462Z","caller":"traceutil/trace.go:171","msg":"trace[1739002878] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1827; }","duration":"173.363972ms","start":"2026-05-08T10:18:54.989086Z","end":"2026-05-08T10:18:55.16245Z","steps":["trace[1739002878] 'agreement among raft nodes before linearized reading' (duration: 173.045476ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:18:55.162841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:18:54.861142Z","time spent":"301.086975ms","remote":"127.0.0.1:41166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:18:55.370393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.167371ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T10:18:55.370805Z","caller":"traceutil/trace.go:171","msg":"trace[941986633] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"173.422933ms","start":"2026-05-08T10:18:55.197363Z","end":"2026-05-08T10:18:55.370786Z","steps":["trace[941986633] 'process raft request' (duration: 173.141908ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:18:55.370914Z","caller":"traceutil/trace.go:171","msg":"trace[44044547] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"185.05184ms","start":"2026-05-08T10:18:55.185816Z","end":"2026-05-08T10:18:55.370868Z","steps":["trace[44044547] 'process raft request' (duration: 55.178254ms)","trace[44044547] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/masterleases/199.204.45.162; req_size:118; } (duration: 129.007488ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:18:55.760449Z","caller":"traceutil/trace.go:171","msg":"trace[1203409559] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"130.271524ms","start":"2026-05-08T10:18:55.630158Z","end":"2026-05-08T10:18:55.76043Z","steps":["trace[1203409559] 'process raft request' (duration: 130.156462ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:18:55.762011Z","caller":"traceutil/trace.go:171","msg":"trace[1363741756] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"128.477967ms","start":"2026-05-08T10:18:55.633516Z","end":"2026-05-08T10:18:55.761994Z","steps":["trace[1363741756] 'process raft request' (duration: 128.419616ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:19:06.703493Z","caller":"traceutil/trace.go:171","msg":"trace[68416575] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"153.000425ms","start":"2026-05-08T10:19:06.550468Z","end":"2026-05-08T10:19:06.703469Z","steps":["trace[68416575] 'process raft request' (duration: 152.799491ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:19:43.524098Z","caller":"traceutil/trace.go:171","msg":"trace[254305191] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"181.817966ms","start":"2026-05-08T10:19:43.342253Z","end":"2026-05-08T10:19:43.524071Z","steps":["trace[254305191] 'process raft request' (duration: 181.624102ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:19:43.534993Z","caller":"traceutil/trace.go:171","msg":"trace[234520201] linearizableReadLoop","detail":"{readStateIndex:2223; appliedIndex:2221; }","duration":"150.224914ms","start":"2026-05-08T10:19:43.384738Z","end":"2026-05-08T10:19:43.534963Z","steps":["trace[234520201] 'read index received' (duration: 139.20541ms)","trace[234520201] 'applied index is now lower than readState.Index' (duration: 11.018134ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:19:43.535372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.765312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-08T10:19:43.535435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.684314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"warn","ts":"2026-05-08T10:19:43.535464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.57545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12383"} {"level":"info","ts":"2026-05-08T10:19:43.536156Z","caller":"traceutil/trace.go:171","msg":"trace[1801460345] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2140; }","duration":"116.345895ms","start":"2026-05-08T10:19:43.419797Z","end":"2026-05-08T10:19:43.536143Z","steps":["trace[1801460345] 'agreement among raft nodes before linearized reading' (duration: 115.309715ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:19:43.535465Z","caller":"traceutil/trace.go:171","msg":"trace[1132414322] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:2140; }","duration":"111.927745ms","start":"2026-05-08T10:19:43.423517Z","end":"2026-05-08T10:19:43.535445Z","steps":["trace[1132414322] 'agreement among raft nodes before linearized reading' (duration: 111.614549ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:19:43.535495Z","caller":"traceutil/trace.go:171","msg":"trace[795999378] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2140; }","duration":"150.806256ms","start":"2026-05-08T10:19:43.38467Z","end":"2026-05-08T10:19:43.535477Z","steps":["trace[795999378] 'agreement among raft nodes before linearized reading' (duration: 150.431179ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:19:43.535647Z","caller":"traceutil/trace.go:171","msg":"trace[864717296] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"191.175686ms","start":"2026-05-08T10:19:43.343911Z","end":"2026-05-08T10:19:43.535087Z","steps":["trace[864717296] 'process raft request' (duration: 190.89493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:20:58.174735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.776755ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T10:20:58.175Z","caller":"traceutil/trace.go:171","msg":"trace[626858139] linearizableReadLoop","detail":"{readStateIndex:2755; appliedIndex:2754; }","duration":"163.06012ms","start":"2026-05-08T10:20:58.011923Z","end":"2026-05-08T10:20:58.174983Z","steps":["trace[626858139] 'read index received' (duration: 32.956269ms)","trace[626858139] 'applied index is now lower than readState.Index' (duration: 130.102141ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:20:58.17504Z","caller":"traceutil/trace.go:171","msg":"trace[2006572885] transaction","detail":"{read_only:false; response_revision:2654; number_of_response:1; }","duration":"316.001885ms","start":"2026-05-08T10:20:57.859Z","end":"2026-05-08T10:20:58.175002Z","steps":["trace[2006572885] 'process raft request' (duration: 185.877013ms)","trace[2006572885] 'compare' (duration: 129.617961ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:20:58.17517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.241904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18ad8fe3007d1a1f\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-05-08T10:20:58.175213Z","caller":"traceutil/trace.go:171","msg":"trace[31137295] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18ad8fe3007d1a1f; range_end:; response_count:1; response_revision:2654; }","duration":"163.321246ms","start":"2026-05-08T10:20:58.011883Z","end":"2026-05-08T10:20:58.175204Z","steps":["trace[31137295] 'agreement among raft nodes before linearized reading' (duration: 163.182863ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:20:58.175271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:57.85898Z","time spent":"316.162157ms","remote":"127.0.0.1:41166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:20:58.175518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.097459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-05-08T10:20:58.175581Z","caller":"traceutil/trace.go:171","msg":"trace[2034530642] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2654; }","duration":"126.173791ms","start":"2026-05-08T10:20:58.049391Z","end":"2026-05-08T10:20:58.175565Z","steps":["trace[2034530642] 'agreement among raft nodes before linearized reading' (duration: 125.933116ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:38.129155Z","caller":"traceutil/trace.go:171","msg":"trace[241242379] transaction","detail":"{read_only:false; response_revision:4554; number_of_response:1; }","duration":"107.349694ms","start":"2026-05-08T10:24:38.021778Z","end":"2026-05-08T10:24:38.129127Z","steps":["trace[241242379] 'process raft request' (duration: 107.210631ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:38.129522Z","caller":"traceutil/trace.go:171","msg":"trace[1668111854] transaction","detail":"{read_only:false; response_revision:4555; number_of_response:1; }","duration":"107.608667ms","start":"2026-05-08T10:24:38.021843Z","end":"2026-05-08T10:24:38.129452Z","steps":["trace[1668111854] 'process raft request' (duration: 107.244291ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:38.129772Z","caller":"traceutil/trace.go:171","msg":"trace[1314314592] transaction","detail":"{read_only:false; response_revision:4556; number_of_response:1; }","duration":"107.459876ms","start":"2026-05-08T10:24:38.022277Z","end":"2026-05-08T10:24:38.129736Z","steps":["trace[1314314592] 'process raft request' (duration: 107.058618ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:24:38.129668Z","caller":"traceutil/trace.go:171","msg":"trace[1353516265] transaction","detail":"{read_only:false; response_revision:4557; number_of_response:1; }","duration":"107.023518ms","start":"2026-05-08T10:24:38.02263Z","end":"2026-05-08T10:24:38.129654Z","steps":["trace[1353516265] 'process raft request' (duration: 106.862475ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:24:50.462644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.561867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-29b91ab6-1702-414d-9c05-6457403632a7\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-08T10:24:50.462809Z","caller":"traceutil/trace.go:171","msg":"trace[1241360412] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-29b91ab6-1702-414d-9c05-6457403632a7; range_end:; response_count:1; response_revision:4758; }","duration":"142.845752ms","start":"2026-05-08T10:24:50.319934Z","end":"2026-05-08T10:24:50.46278Z","steps":["trace[1241360412] 'range keys from in-memory index tree' (duration: 142.335103ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:24:50.463041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.164625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-08T10:24:50.463144Z","caller":"traceutil/trace.go:171","msg":"trace[1926583620] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4758; }","duration":"157.305418ms","start":"2026-05-08T10:24:50.305812Z","end":"2026-05-08T10:24:50.463117Z","steps":["trace[1926583620] 'range keys from in-memory index tree' (duration: 157.031053ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:25:40.847802Z","caller":"traceutil/trace.go:171","msg":"trace[1506745640] transaction","detail":"{read_only:false; response_revision:5173; number_of_response:1; }","duration":"102.667908ms","start":"2026-05-08T10:25:40.745102Z","end":"2026-05-08T10:25:40.84777Z","steps":["trace[1506745640] 'process raft request' (duration: 102.515025ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:25:41.195642Z","caller":"traceutil/trace.go:171","msg":"trace[2012342284] linearizableReadLoop","detail":"{readStateIndex:5367; appliedIndex:5366; }","duration":"148.321545ms","start":"2026-05-08T10:25:41.047292Z","end":"2026-05-08T10:25:41.195614Z","steps":["trace[2012342284] 'read index received' (duration: 81.595474ms)","trace[2012342284] 'applied index is now lower than readState.Index' (duration: 66.724781ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:25:41.195732Z","caller":"traceutil/trace.go:171","msg":"trace[2087127193] transaction","detail":"{read_only:false; response_revision:5176; number_of_response:1; }","duration":"231.386794ms","start":"2026-05-08T10:25:40.964314Z","end":"2026-05-08T10:25:41.195701Z","steps":["trace[2087127193] 'process raft request' (duration: 164.627433ms)","trace[2087127193] 'compare' (duration: 66.505207ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:25:41.195789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.476438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:25:41.195883Z","caller":"traceutil/trace.go:171","msg":"trace[1363343406] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:5176; }","duration":"148.60338ms","start":"2026-05-08T10:25:41.047255Z","end":"2026-05-08T10:25:41.195859Z","steps":["trace[1363343406] 'agreement among raft nodes before linearized reading' (duration: 148.456548ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:25:41.195825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.020157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:25:41.196049Z","caller":"traceutil/trace.go:171","msg":"trace[179673449] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:5176; }","duration":"132.294992ms","start":"2026-05-08T10:25:41.063738Z","end":"2026-05-08T10:25:41.196032Z","steps":["trace[179673449] 'agreement among raft nodes before linearized reading' (duration: 132.026747ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:26:41.910566Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2884} {"level":"info","ts":"2026-05-08T10:26:41.993578Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2884,"took":"81.674081ms","hash":3166642783,"current-db-size-bytes":54206464,"current-db-size":"54 MB","current-db-size-in-use-bytes":29306880,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-08T10:26:41.993716Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3166642783,"revision":2884,"compact-revision":-1} {"level":"info","ts":"2026-05-08T10:31:41.919242Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5622} {"level":"info","ts":"2026-05-08T10:31:41.997161Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5622,"took":"76.824466ms","hash":1529723985,"current-db-size-bytes":54206464,"current-db-size":"54 MB","current-db-size-in-use-bytes":18227200,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-08T10:31:41.997206Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1529723985,"revision":5622,"compact-revision":2884}