{"level":"warn","ts":"2026-08-03T03:21:41.789551Z","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-03T03:21:41.789663Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22: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.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-03T03:21:41.7898Z","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-03T03:21:41.789823Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-08-03T03:21:41.789864Z","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-03T03:21:41.790799Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-08-03T03:21:41.790919Z","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.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-03T03:21:41.795517Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.322637ms"} {"level":"info","ts":"2026-08-03T03:21:41.802779Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-08-03T03:21:41.802856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-08-03T03:21:41.802875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-08-03T03:21:41.802913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-03T03:21:41.802962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-08-03T03:21:41.80324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-08-03T03:21:41.816182Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-03T03:21:41.817786Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-03T03:21:41.819211Z","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-03T03:21:41.822794Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-03T03:21:41.822999Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-03T03:21:41.8231Z","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-03T03:21:41.82324Z","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-03T03:21:41.823253Z","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-03T03:21:41.824063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-08-03T03:21:41.824187Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-08-03T03:21:41.827878Z","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-03T03:21:41.827987Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-08-03T03:21:41.828029Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-08-03T03:21:41.82819Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-03T03:21:41.828227Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-03T03:21:42.004056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-08-03T03:21:42.004136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-03T03:21:42.004274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-08-03T03:21:42.004297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-08-03T03:21:42.004308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-08-03T03:21:42.004324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-08-03T03:21:42.004337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-08-03T03:21:42.00582Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-08-03T03:21:42.006147Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-03T03:21:42.007413Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-03T03:21:42.00777Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-03T03:21:42.008189Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-03T03:21:42.008205Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-03T03:21:42.008228Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-08-03T03:21:42.008753Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-03T03:21:42.008824Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-03T03:21:42.010321Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"info","ts":"2026-08-03T03:21:42.014075Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-08-03T03:21:58.394311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.533871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-08-03T03:21:58.394407Z","caller":"traceutil/trace.go:171","msg":"trace[1626895678] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:414; }","duration":"230.699669ms","start":"2026-08-03T03:21:58.163694Z","end":"2026-08-03T03:21:58.394393Z","steps":["trace[1626895678] 'range keys from in-memory index tree' (duration: 230.450777ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:21:58.533089Z","caller":"traceutil/trace.go:171","msg":"trace[1926687707] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"134.45734ms","start":"2026-08-03T03:21:58.398608Z","end":"2026-08-03T03:21:58.533065Z","steps":["trace[1926687707] 'process raft request' (duration: 134.325393ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:22:24.398957Z","caller":"traceutil/trace.go:171","msg":"trace[1478901373] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"155.878603ms","start":"2026-08-03T03:22:24.243051Z","end":"2026-08-03T03:22:24.39893Z","steps":["trace[1478901373] 'process raft request' (duration: 155.740337ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:22:24.509252Z","caller":"traceutil/trace.go:171","msg":"trace[408126072] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"256.175483ms","start":"2026-08-03T03:22:24.253042Z","end":"2026-08-03T03:22:24.509217Z","steps":["trace[408126072] 'process raft request' (duration: 255.904152ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:22:24.509345Z","caller":"traceutil/trace.go:171","msg":"trace[1536170894] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"251.344735ms","start":"2026-08-03T03:22:24.257946Z","end":"2026-08-03T03:22:24.509291Z","steps":["trace[1536170894] 'process raft request' (duration: 251.152617ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:22:24.509477Z","caller":"traceutil/trace.go:171","msg":"trace[944390329] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"251.445949ms","start":"2026-08-03T03:22:24.258001Z","end":"2026-08-03T03:22:24.509447Z","steps":["trace[944390329] 'process raft request' (duration: 251.174738ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:22:24.509624Z","caller":"traceutil/trace.go:171","msg":"trace[129698540] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"250.143028ms","start":"2026-08-03T03:22:24.259425Z","end":"2026-08-03T03:22:24.509569Z","steps":["trace[129698540] 'process raft request' (duration: 249.791935ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:22:24.510185Z","caller":"traceutil/trace.go:171","msg":"trace[797330302] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"250.69582ms","start":"2026-08-03T03:22:24.259474Z","end":"2026-08-03T03:22:24.51017Z","steps":["trace[797330302] 'process raft request' (duration: 249.93397ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:22:24.510227Z","caller":"traceutil/trace.go:171","msg":"trace[1338516806] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"246.5755ms","start":"2026-08-03T03:22:24.263629Z","end":"2026-08-03T03:22:24.510205Z","steps":["trace[1338516806] 'process raft request' (duration: 246.419114ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:22:24.510552Z","caller":"traceutil/trace.go:171","msg":"trace[809545346] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"246.85502ms","start":"2026-08-03T03:22:24.263684Z","end":"2026-08-03T03:22:24.510539Z","steps":["trace[809545346] 'process raft request' (duration: 246.451655ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:22:24.510665Z","caller":"traceutil/trace.go:171","msg":"trace[1142023379] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"240.248253ms","start":"2026-08-03T03:22:24.270401Z","end":"2026-08-03T03:22:24.510649Z","steps":["trace[1142023379] 'process raft request' (duration: 240.050306ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:22:24.510979Z","caller":"traceutil/trace.go:171","msg":"trace[1341921390] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"226.26061ms","start":"2026-08-03T03:22:24.284704Z","end":"2026-08-03T03:22:24.510964Z","steps":["trace[1341921390] 'process raft request' (duration: 225.797862ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:22:24.510993Z","caller":"traceutil/trace.go:171","msg":"trace[882368200] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:559; }","duration":"233.759532ms","start":"2026-08-03T03:22:24.277178Z","end":"2026-08-03T03:22:24.510938Z","steps":["trace[882368200] 'read index received' (duration: 121.644211ms)","trace[882368200] 'applied index is now lower than readState.Index' (duration: 112.114481ms)"],"step_count":2} {"level":"info","ts":"2026-08-03T03:22:24.511079Z","caller":"traceutil/trace.go:171","msg":"trace[1011726565] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"199.881004ms","start":"2026-08-03T03:22:24.311187Z","end":"2026-08-03T03:22:24.511068Z","steps":["trace[1011726565] 'process raft request' (duration: 199.704417ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:22:24.511984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.785971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-08-03T03:22:24.512086Z","caller":"traceutil/trace.go:171","msg":"trace[2121106633] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:549; }","duration":"234.927187ms","start":"2026-08-03T03:22:24.277144Z","end":"2026-08-03T03:22:24.512071Z","steps":["trace[2121106633] 'agreement among raft nodes before linearized reading' (duration: 234.109705ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:22:24.514238Z","caller":"traceutil/trace.go:171","msg":"trace[520781757] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"109.491558ms","start":"2026-08-03T03:22:24.404721Z","end":"2026-08-03T03:22:24.514212Z","steps":["trace[520781757] 'process raft request' (duration: 109.303311ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:22:24.514494Z","caller":"traceutil/trace.go:171","msg":"trace[540343638] transaction","detail":"{read_only:false; number_of_response:1; response_revision:551; }","duration":"107.563123ms","start":"2026-08-03T03:22:24.40692Z","end":"2026-08-03T03:22:24.514483Z","steps":["trace[540343638] 'process raft request' (duration: 107.269842ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:22:24.51453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.292338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-03T03:22:24.514594Z","caller":"traceutil/trace.go:171","msg":"trace[1610239693] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:552; }","duration":"237.375231ms","start":"2026-08-03T03:22:24.277207Z","end":"2026-08-03T03:22:24.514582Z","steps":["trace[1610239693] 'agreement among raft nodes before linearized reading' (duration: 237.242926ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:22:24.514616Z","caller":"traceutil/trace.go:171","msg":"trace[1378939146] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"108.444377ms","start":"2026-08-03T03:22:24.406162Z","end":"2026-08-03T03:22:24.514606Z","steps":["trace[1378939146] 'process raft request' (duration: 107.962839ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:22:31.283804Z","caller":"traceutil/trace.go:171","msg":"trace[873617299] linearizableReadLoop","detail":"{readStateIndex:680; appliedIndex:679; }","duration":"230.211628ms","start":"2026-08-03T03:22:31.053566Z","end":"2026-08-03T03:22:31.283778Z","steps":["trace[873617299] 'read index received' (duration: 229.498162ms)","trace[873617299] 'applied index is now lower than readState.Index' (duration: 712.316µs)"],"step_count":2} {"level":"info","ts":"2026-08-03T03:22:31.283919Z","caller":"traceutil/trace.go:171","msg":"trace[1567379203] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"418.9355ms","start":"2026-08-03T03:22:30.864953Z","end":"2026-08-03T03:22:31.283888Z","steps":["trace[1567379203] 'process raft request' (duration: 418.303767ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:22:31.283975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.392805ms","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-03T03:22:31.284011Z","caller":"traceutil/trace.go:171","msg":"trace[1010595256] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:652; }","duration":"230.482168ms","start":"2026-08-03T03:22:31.053518Z","end":"2026-08-03T03:22:31.284Z","steps":["trace[1010595256] 'agreement among raft nodes before linearized reading' (duration: 230.390225ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:22:31.284398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.534491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-03T03:22:31.284536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-03T03:22:30.864918Z","time spent":"419.082055ms","remote":"127.0.0.1:43472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-03T03:22:31.284599Z","caller":"traceutil/trace.go:171","msg":"trace[1816610274] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:652; }","duration":"153.78517ms","start":"2026-08-03T03:22:31.130737Z","end":"2026-08-03T03:22:31.284522Z","steps":["trace[1816610274] 'agreement among raft nodes before linearized reading' (duration: 153.50216ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:22:31.525769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.388182ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-03T03:22:31.525956Z","caller":"traceutil/trace.go:171","msg":"trace[1341413119] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"234.693839ms","start":"2026-08-03T03:22:31.291234Z","end":"2026-08-03T03:22:31.525928Z","steps":["trace[1341413119] 'process raft request' (duration: 69.930574ms)","trace[1341413119] 'compare' (duration: 164.178684ms)"],"step_count":2} {"level":"info","ts":"2026-08-03T03:22:31.541745Z","caller":"traceutil/trace.go:171","msg":"trace[1215246758] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"203.052432ms","start":"2026-08-03T03:22:31.338668Z","end":"2026-08-03T03:22:31.54172Z","steps":["trace[1215246758] 'process raft request' (duration: 202.933458ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:23:39.806748Z","caller":"traceutil/trace.go:171","msg":"trace[1874523728] transaction","detail":"{read_only:false; response_revision:1472; number_of_response:1; }","duration":"109.58824ms","start":"2026-08-03T03:23:39.697125Z","end":"2026-08-03T03:23:39.806714Z","steps":["trace[1874523728] 'process raft request' (duration: 109.361866ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:24:04.397282Z","caller":"traceutil/trace.go:171","msg":"trace[1153696165] linearizableReadLoop","detail":"{readStateIndex:1966; appliedIndex:1965; }","duration":"265.961073ms","start":"2026-08-03T03:24:04.131293Z","end":"2026-08-03T03:24:04.397254Z","steps":["trace[1153696165] 'read index received' (duration: 265.7995ms)","trace[1153696165] 'applied index is now lower than readState.Index' (duration: 160.493µs)"],"step_count":2} {"level":"info","ts":"2026-08-03T03:24:04.397413Z","caller":"traceutil/trace.go:171","msg":"trace[780316140] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"309.486716ms","start":"2026-08-03T03:24:04.087914Z","end":"2026-08-03T03:24:04.3974Z","steps":["trace[780316140] 'process raft request' (duration: 309.163051ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:24:04.39754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-03T03:24:04.087887Z","time spent":"309.557588ms","remote":"127.0.0.1:43636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-03T03:24:04.397539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.238557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-03T03:24:04.397619Z","caller":"traceutil/trace.go:171","msg":"trace[1506784886] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1890; }","duration":"266.3526ms","start":"2026-08-03T03:24:04.131252Z","end":"2026-08-03T03:24:04.397605Z","steps":["trace[1506784886] 'agreement among raft nodes before linearized reading' (duration: 266.239198ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:24:04.407815Z","caller":"traceutil/trace.go:171","msg":"trace[1450777782] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"111.207559ms","start":"2026-08-03T03:24:04.296586Z","end":"2026-08-03T03:24:04.407793Z","steps":["trace[1450777782] 'process raft request' (duration: 111.032376ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:24:04.408175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.369466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bc2a5533-52df-46de-bfc2-926c05debd28\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-08-03T03:24:04.408313Z","caller":"traceutil/trace.go:171","msg":"trace[204540306] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-bc2a5533-52df-46de-bfc2-926c05debd28; range_end:; response_count:1; response_revision:1891; }","duration":"160.516039ms","start":"2026-08-03T03:24:04.247745Z","end":"2026-08-03T03:24:04.408261Z","steps":["trace[204540306] 'agreement among raft nodes before linearized reading' (duration: 160.327176ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:24:16.605025Z","caller":"traceutil/trace.go:171","msg":"trace[531772884] linearizableReadLoop","detail":"{readStateIndex:2075; appliedIndex:2074; }","duration":"151.564229ms","start":"2026-08-03T03:24:16.453437Z","end":"2026-08-03T03:24:16.605002Z","steps":["trace[531772884] 'read index received' (duration: 151.421637ms)","trace[531772884] 'applied index is now lower than readState.Index' (duration: 141.512µs)"],"step_count":2} {"level":"info","ts":"2026-08-03T03:24:16.605081Z","caller":"traceutil/trace.go:171","msg":"trace[703313474] transaction","detail":"{read_only:false; response_revision:1995; number_of_response:1; }","duration":"154.168199ms","start":"2026-08-03T03:24:16.450881Z","end":"2026-08-03T03:24:16.605049Z","steps":["trace[703313474] 'process raft request' (duration: 153.950246ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:24:16.605302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.782293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-03T03:24:16.605409Z","caller":"traceutil/trace.go:171","msg":"trace[282016457] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1995; }","duration":"152.009095ms","start":"2026-08-03T03:24:16.453378Z","end":"2026-08-03T03:24:16.605387Z","steps":["trace[282016457] 'agreement among raft nodes before linearized reading' (duration: 151.743751ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:24:16.628497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.838191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-03T03:24:16.628549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.877224ms","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-03T03:24:16.628618Z","caller":"traceutil/trace.go:171","msg":"trace[1440331245] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1996; }","duration":"172.997104ms","start":"2026-08-03T03:24:16.455596Z","end":"2026-08-03T03:24:16.628593Z","steps":["trace[1440331245] 'agreement among raft nodes before linearized reading' (duration: 172.640218ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:24:16.628731Z","caller":"traceutil/trace.go:171","msg":"trace[1841125532] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1996; }","duration":"129.011986ms","start":"2026-08-03T03:24:16.49959Z","end":"2026-08-03T03:24:16.628602Z","steps":["trace[1841125532] 'agreement among raft nodes before linearized reading' (duration: 128.769902ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:24:22.997865Z","caller":"traceutil/trace.go:171","msg":"trace[2137763507] linearizableReadLoop","detail":"{readStateIndex:2118; appliedIndex:2117; }","duration":"360.938584ms","start":"2026-08-03T03:24:22.636898Z","end":"2026-08-03T03:24:22.997836Z","steps":["trace[2137763507] 'read index received' (duration: 360.790711ms)","trace[2137763507] 'applied index is now lower than readState.Index' (duration: 146.153µs)"],"step_count":2} {"level":"info","ts":"2026-08-03T03:24:22.997963Z","caller":"traceutil/trace.go:171","msg":"trace[1322014948] transaction","detail":"{read_only:false; response_revision:2037; number_of_response:1; }","duration":"371.242221ms","start":"2026-08-03T03:24:22.626675Z","end":"2026-08-03T03:24:22.997917Z","steps":["trace[1322014948] 'process raft request' (duration: 370.921046ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:24:22.998287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-03T03:24:22.626645Z","time spent":"371.439243ms","remote":"127.0.0.1:43636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-03T03:24:22.998188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.256528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11985"} {"level":"info","ts":"2026-08-03T03:24:22.998393Z","caller":"traceutil/trace.go:171","msg":"trace[1978843956] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2037; }","duration":"361.517283ms","start":"2026-08-03T03:24:22.636862Z","end":"2026-08-03T03:24:22.998379Z","steps":["trace[1978843956] 'agreement among raft nodes before linearized reading' (duration: 361.148147ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:24:22.998441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-03T03:24:22.636845Z","time spent":"361.585794ms","remote":"127.0.0.1:43556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12008,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-08-03T03:24:22.998791Z","caller":"traceutil/trace.go:171","msg":"trace[849738942] transaction","detail":"{read_only:false; response_revision:2038; number_of_response:1; }","duration":"351.471071ms","start":"2026-08-03T03:24:22.647293Z","end":"2026-08-03T03:24:22.998764Z","steps":["trace[849738942] 'process raft request' (duration: 351.084775ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:24:22.998838Z","caller":"traceutil/trace.go:171","msg":"trace[949010924] transaction","detail":"{read_only:false; response_revision:2039; number_of_response:1; }","duration":"333.947004ms","start":"2026-08-03T03:24:22.664869Z","end":"2026-08-03T03:24:22.998816Z","steps":["trace[949010924] 'process raft request' (duration: 333.789251ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:24:22.998941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-03T03:24:22.664856Z","time spent":"334.038176ms","remote":"127.0.0.1:43636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-03T03:24:22.998965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-03T03:24:22.647266Z","time spent":"351.606422ms","remote":"127.0.0.1:43636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-03T03:24:22.999087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.088559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-03T03:24:22.999064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.048345ms","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-03T03:24:22.999137Z","caller":"traceutil/trace.go:171","msg":"trace[667220690] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2039; }","duration":"319.185459ms","start":"2026-08-03T03:24:22.679941Z","end":"2026-08-03T03:24:22.999126Z","steps":["trace[667220690] 'agreement among raft nodes before linearized reading' (duration: 319.069878ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:24:22.999171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-03T03:24:22.679923Z","time spent":"319.242011ms","remote":"127.0.0.1:43636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-03T03:24:22.999175Z","caller":"traceutil/trace.go:171","msg":"trace[1928069988] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2039; }","duration":"328.350239ms","start":"2026-08-03T03:24:22.670799Z","end":"2026-08-03T03:24:22.999149Z","steps":["trace[1928069988] 'agreement among raft nodes before linearized reading' (duration: 327.946123ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:24:22.999263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-03T03:24:22.670771Z","time spent":"328.476331ms","remote":"127.0.0.1:33218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-08-03T03:24:37.631469Z","caller":"traceutil/trace.go:171","msg":"trace[2000419691] transaction","detail":"{read_only:false; response_revision:2124; number_of_response:1; }","duration":"133.474795ms","start":"2026-08-03T03:24:37.497969Z","end":"2026-08-03T03:24:37.631444Z","steps":["trace[2000419691] 'process raft request' (duration: 133.260192ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:24:37.633258Z","caller":"traceutil/trace.go:171","msg":"trace[1233939547] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"133.646988ms","start":"2026-08-03T03:24:37.499592Z","end":"2026-08-03T03:24:37.633239Z","steps":["trace[1233939547] 'process raft request' (duration: 133.604157ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:24:37.633313Z","caller":"traceutil/trace.go:171","msg":"trace[1883767548] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"135.281341ms","start":"2026-08-03T03:24:37.497995Z","end":"2026-08-03T03:24:37.633276Z","steps":["trace[1883767548] 'process raft request' (duration: 135.072948ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:24:37.633444Z","caller":"traceutil/trace.go:171","msg":"trace[590303885] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"134.048694ms","start":"2026-08-03T03:24:37.499325Z","end":"2026-08-03T03:24:37.633373Z","steps":["trace[590303885] 'process raft request' (duration: 133.831661ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:24:43.202849Z","caller":"traceutil/trace.go:171","msg":"trace[1037600823] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"122.363497ms","start":"2026-08-03T03:24:43.08045Z","end":"2026-08-03T03:24:43.202813Z","steps":["trace[1037600823] 'process raft request' (duration: 46.325306ms)","trace[1037600823] 'compare' (duration: 75.746297ms)"],"step_count":2} {"level":"warn","ts":"2026-08-03T03:24:43.420654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.286902ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-03T03:24:43.421051Z","caller":"traceutil/trace.go:171","msg":"trace[1783791618] linearizableReadLoop","detail":"{readStateIndex:2239; appliedIndex:2236; }","duration":"322.606973ms","start":"2026-08-03T03:24:43.098403Z","end":"2026-08-03T03:24:43.42101Z","steps":["trace[1783791618] 'read index received' (duration: 28.461478ms)","trace[1783791618] 'applied index is now lower than readState.Index' (duration: 294.143915ms)"],"step_count":2} {"level":"info","ts":"2026-08-03T03:24:43.421067Z","caller":"traceutil/trace.go:171","msg":"trace[1978440959] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"334.698752ms","start":"2026-08-03T03:24:43.086336Z","end":"2026-08-03T03:24:43.421035Z","steps":["trace[1978440959] 'process raft request' (duration: 334.484849ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:24:43.421085Z","caller":"traceutil/trace.go:171","msg":"trace[1071877995] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"335.060637ms","start":"2026-08-03T03:24:43.085911Z","end":"2026-08-03T03:24:43.420971Z","steps":["trace[1071877995] 'process raft request' (duration: 226.126226ms)","trace[1071877995] 'compare' (duration: 108.18276ms)"],"step_count":2} {"level":"warn","ts":"2026-08-03T03:24:43.421243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-03T03:24:43.086308Z","time spent":"334.835864ms","remote":"127.0.0.1:43636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-03T03:24:43.42126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.182307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-03T03:24:43.42133Z","caller":"traceutil/trace.go:171","msg":"trace[2047781737] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2154; }","duration":"289.288708ms","start":"2026-08-03T03:24:43.132029Z","end":"2026-08-03T03:24:43.421318Z","steps":["trace[2047781737] 'agreement among raft nodes before linearized reading' (duration: 289.176196ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:24:43.421341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.470142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12382"} {"level":"warn","ts":"2026-08-03T03:24:43.421338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.921918ms","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-03T03:24:43.421394Z","caller":"traceutil/trace.go:171","msg":"trace[483039324] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2154; }","duration":"312.567593ms","start":"2026-08-03T03:24:43.108812Z","end":"2026-08-03T03:24:43.42138Z","steps":["trace[483039324] 'agreement among raft nodes before linearized reading' (duration: 312.37918ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:24:43.421411Z","caller":"traceutil/trace.go:171","msg":"trace[1068006670] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2154; }","duration":"323.027929ms","start":"2026-08-03T03:24:43.098365Z","end":"2026-08-03T03:24:43.421393Z","steps":["trace[1068006670] 'agreement among raft nodes before linearized reading' (duration: 322.792565ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:24:43.42143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-03T03:24:43.108796Z","time spent":"312.627363ms","remote":"127.0.0.1:43556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12405,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-08-03T03:24:43.421458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-03T03:24:43.098355Z","time spent":"323.09359ms","remote":"127.0.0.1:43636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-03T03:24:43.421518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-03T03:24:43.085872Z","time spent":"335.476743ms","remote":"127.0.0.1:43636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-03T03:24:43.421641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.635713ms","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-03T03:24:43.421683Z","caller":"traceutil/trace.go:171","msg":"trace[1010014078] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2154; }","duration":"289.724984ms","start":"2026-08-03T03:24:43.131946Z","end":"2026-08-03T03:24:43.421671Z","steps":["trace[1010014078] 'agreement among raft nodes before linearized reading' (duration: 289.619262ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:24:43.950134Z","caller":"traceutil/trace.go:171","msg":"trace[1482689123] linearizableReadLoop","detail":"{readStateIndex:2242; appliedIndex:2241; }","duration":"200.952145ms","start":"2026-08-03T03:24:43.749148Z","end":"2026-08-03T03:24:43.9501Z","steps":["trace[1482689123] 'read index received' (duration: 200.704632ms)","trace[1482689123] 'applied index is now lower than readState.Index' (duration: 245.993µs)"],"step_count":2} {"level":"info","ts":"2026-08-03T03:24:43.950195Z","caller":"traceutil/trace.go:171","msg":"trace[159386402] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"232.651308ms","start":"2026-08-03T03:24:43.717507Z","end":"2026-08-03T03:24:43.950158Z","steps":["trace[159386402] 'process raft request' (duration: 232.368204ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:24:43.950355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.895286ms","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":"warn","ts":"2026-08-03T03:24:43.950413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.737495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-03T03:24:43.950449Z","caller":"traceutil/trace.go:171","msg":"trace[94574860] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2157; }","duration":"289.823826ms","start":"2026-08-03T03:24:43.660615Z","end":"2026-08-03T03:24:43.950439Z","steps":["trace[94574860] 'agreement among raft nodes before linearized reading' (duration: 289.613633ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:24:43.95045Z","caller":"traceutil/trace.go:171","msg":"trace[1104461041] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2157; }","duration":"287.017337ms","start":"2026-08-03T03:24:43.663413Z","end":"2026-08-03T03:24:43.950431Z","steps":["trace[1104461041] 'agreement among raft nodes before linearized reading' (duration: 286.759623ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:24:44.077214Z","caller":"traceutil/trace.go:171","msg":"trace[503296310] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"323.25107ms","start":"2026-08-03T03:24:43.753924Z","end":"2026-08-03T03:24:44.077176Z","steps":["trace[503296310] 'process raft request' (duration: 318.26862ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:24:44.077643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-03T03:24:43.753898Z","time spent":"323.421532ms","remote":"127.0.0.1:43636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-03T03:24:44.102712Z","caller":"traceutil/trace.go:171","msg":"trace[959409302] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"147.646606ms","start":"2026-08-03T03:24:43.955019Z","end":"2026-08-03T03:24:44.102666Z","steps":["trace[959409302] 'process raft request' (duration: 147.594586ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:24:44.102757Z","caller":"traceutil/trace.go:171","msg":"trace[2088201276] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"147.840009ms","start":"2026-08-03T03:24:43.954885Z","end":"2026-08-03T03:24:44.102725Z","steps":["trace[2088201276] 'process raft request' (duration: 147.600036ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:26:09.903573Z","caller":"traceutil/trace.go:171","msg":"trace[1179654718] transaction","detail":"{read_only:false; response_revision:2713; number_of_response:1; }","duration":"183.956079ms","start":"2026-08-03T03:26:09.719596Z","end":"2026-08-03T03:26:09.903552Z","steps":["trace[1179654718] 'process raft request' (duration: 183.847944ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:26:09.905139Z","caller":"traceutil/trace.go:171","msg":"trace[1867357420] transaction","detail":"{read_only:false; response_revision:2714; number_of_response:1; }","duration":"181.6073ms","start":"2026-08-03T03:26:09.723521Z","end":"2026-08-03T03:26:09.905128Z","steps":["trace[1867357420] 'process raft request' (duration: 181.275273ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:26:42.246327Z","caller":"traceutil/trace.go:171","msg":"trace[1210723065] linearizableReadLoop","detail":"{readStateIndex:3003; appliedIndex:3001; }","duration":"208.98804ms","start":"2026-08-03T03:26:42.037317Z","end":"2026-08-03T03:26:42.246305Z","steps":["trace[1210723065] 'read index received' (duration: 1.87741ms)","trace[1210723065] 'applied index is now lower than readState.Index' (duration: 207.10968ms)"],"step_count":2} {"level":"info","ts":"2026-08-03T03:26:42.246955Z","caller":"traceutil/trace.go:171","msg":"trace[1508148759] transaction","detail":"{read_only:false; response_revision:2891; number_of_response:1; }","duration":"217.164727ms","start":"2026-08-03T03:26:42.029775Z","end":"2026-08-03T03:26:42.24694Z","steps":["trace[1508148759] 'process raft request' (duration: 216.393115ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:26:42.248071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.732764ms","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-08-03T03:26:42.24812Z","caller":"traceutil/trace.go:171","msg":"trace[1551582278] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2891; }","duration":"210.817678ms","start":"2026-08-03T03:26:42.03729Z","end":"2026-08-03T03:26:42.248108Z","steps":["trace[1551582278] 'agreement among raft nodes before linearized reading' (duration: 210.661621ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:26:42.24846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.82866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-03T03:26:42.248501Z","caller":"traceutil/trace.go:171","msg":"trace[1948647341] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2891; }","duration":"116.906023ms","start":"2026-08-03T03:26:42.131582Z","end":"2026-08-03T03:26:42.248488Z","steps":["trace[1948647341] 'agreement among raft nodes before linearized reading' (duration: 116.849201ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:26:42.562746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.455329ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-03T03:26:42.56302Z","caller":"traceutil/trace.go:171","msg":"trace[112337151] transaction","detail":"{read_only:false; response_revision:2895; number_of_response:1; }","duration":"196.05019ms","start":"2026-08-03T03:26:42.366884Z","end":"2026-08-03T03:26:42.562934Z","steps":["trace[112337151] 'process raft request' (duration: 196.004738ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:26:42.56336Z","caller":"traceutil/trace.go:171","msg":"trace[2063223878] transaction","detail":"{read_only:false; response_revision:2893; number_of_response:1; }","duration":"260.579965ms","start":"2026-08-03T03:26:42.302767Z","end":"2026-08-03T03:26:42.563347Z","steps":["trace[2063223878] 'process raft request' (duration: 121.396104ms)","trace[2063223878] 'compare' (duration: 138.029342ms)"],"step_count":2} {"level":"info","ts":"2026-08-03T03:26:42.563495Z","caller":"traceutil/trace.go:171","msg":"trace[1875166979] transaction","detail":"{read_only:false; response_revision:2894; number_of_response:1; }","duration":"215.186744ms","start":"2026-08-03T03:26:42.3483Z","end":"2026-08-03T03:26:42.563487Z","steps":["trace[1875166979] 'process raft request' (duration: 214.545196ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:26:47.814268Z","caller":"traceutil/trace.go:171","msg":"trace[2102007447] transaction","detail":"{read_only:false; response_revision:2921; number_of_response:1; }","duration":"103.221273ms","start":"2026-08-03T03:26:47.711025Z","end":"2026-08-03T03:26:47.814246Z","steps":["trace[2102007447] 'process raft request' (duration: 103.078407ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:30:25.563585Z","caller":"traceutil/trace.go:171","msg":"trace[1992664759] transaction","detail":"{read_only:false; response_revision:4765; number_of_response:1; }","duration":"127.830535ms","start":"2026-08-03T03:30:25.435704Z","end":"2026-08-03T03:30:25.563534Z","steps":["trace[1992664759] 'process raft request' (duration: 127.639831ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:30:31.052325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.071748ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-03T03:30:31.05242Z","caller":"traceutil/trace.go:171","msg":"trace[1988877494] transaction","detail":"{read_only:false; response_revision:4817; number_of_response:1; }","duration":"168.457854ms","start":"2026-08-03T03:30:30.883947Z","end":"2026-08-03T03:30:31.052405Z","steps":["trace[1988877494] 'compare' (duration: 159.956436ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:30:31.258419Z","caller":"traceutil/trace.go:171","msg":"trace[669950719] transaction","detail":"{read_only:false; response_revision:4818; number_of_response:1; }","duration":"186.223741ms","start":"2026-08-03T03:30:31.07215Z","end":"2026-08-03T03:30:31.258373Z","steps":["trace[669950719] 'process raft request' (duration: 174.338956ms)","trace[669950719] 'compare' (duration: 11.604759ms)"],"step_count":2} {"level":"info","ts":"2026-08-03T03:30:31.266359Z","caller":"traceutil/trace.go:171","msg":"trace[1543785337] linearizableReadLoop","detail":"{readStateIndex:5004; appliedIndex:5002; }","duration":"136.821715ms","start":"2026-08-03T03:30:31.129512Z","end":"2026-08-03T03:30:31.266333Z","steps":["trace[1543785337] 'read index received' (duration: 116.955552ms)","trace[1543785337] 'applied index is now lower than readState.Index' (duration: 19.864703ms)"],"step_count":2} {"level":"info","ts":"2026-08-03T03:30:31.266461Z","caller":"traceutil/trace.go:171","msg":"trace[1185962585] transaction","detail":"{read_only:false; response_revision:4819; number_of_response:1; }","duration":"145.339223ms","start":"2026-08-03T03:30:31.121099Z","end":"2026-08-03T03:30:31.266438Z","steps":["trace[1185962585] 'process raft request' (duration: 145.090519ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:30:31.266536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.991829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-03T03:30:31.266578Z","caller":"traceutil/trace.go:171","msg":"trace[2066964706] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4819; }","duration":"137.07644ms","start":"2026-08-03T03:30:31.129489Z","end":"2026-08-03T03:30:31.266565Z","steps":["trace[2066964706] 'agreement among raft nodes before linearized reading' (duration: 136.946057ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:30:31.546029Z","caller":"traceutil/trace.go:171","msg":"trace[700918919] transaction","detail":"{read_only:false; response_revision:4823; number_of_response:1; }","duration":"138.719902ms","start":"2026-08-03T03:30:31.407258Z","end":"2026-08-03T03:30:31.545977Z","steps":["trace[700918919] 'process raft request' (duration: 67.645427ms)","trace[700918919] 'compare' (duration: 70.581845ms)"],"step_count":2} {"level":"info","ts":"2026-08-03T03:30:31.546459Z","caller":"traceutil/trace.go:171","msg":"trace[1188464191] transaction","detail":"{read_only:false; response_revision:4824; number_of_response:1; }","duration":"131.677183ms","start":"2026-08-03T03:30:31.414749Z","end":"2026-08-03T03:30:31.546426Z","steps":["trace[1188464191] 'process raft request' (duration: 131.116102ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:30:31.546492Z","caller":"traceutil/trace.go:171","msg":"trace[1196271904] linearizableReadLoop","detail":"{readStateIndex:5009; appliedIndex:5007; }","duration":"131.114381ms","start":"2026-08-03T03:30:31.415344Z","end":"2026-08-03T03:30:31.546459Z","steps":["trace[1196271904] 'read index received' (duration: 59.570508ms)","trace[1196271904] 'applied index is now lower than readState.Index' (duration: 71.542743ms)"],"step_count":2} {"level":"info","ts":"2026-08-03T03:30:31.546618Z","caller":"traceutil/trace.go:171","msg":"trace[563649747] transaction","detail":"{read_only:false; response_revision:4825; number_of_response:1; }","duration":"131.070111ms","start":"2026-08-03T03:30:31.415525Z","end":"2026-08-03T03:30:31.546595Z","steps":["trace[563649747] 'process raft request' (duration: 130.558141ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:30:31.547001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.619301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:131112"} {"level":"info","ts":"2026-08-03T03:30:31.547097Z","caller":"traceutil/trace.go:171","msg":"trace[706820044] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:4826; }","duration":"131.780355ms","start":"2026-08-03T03:30:31.415301Z","end":"2026-08-03T03:30:31.547081Z","steps":["trace[706820044] 'agreement among raft nodes before linearized reading' (duration: 131.281265ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:30:31.54724Z","caller":"traceutil/trace.go:171","msg":"trace[732026126] transaction","detail":"{read_only:false; response_revision:4826; number_of_response:1; }","duration":"130.241214ms","start":"2026-08-03T03:30:31.416979Z","end":"2026-08-03T03:30:31.54722Z","steps":["trace[732026126] 'process raft request' (duration: 129.433439ms)"],"step_count":1} {"level":"warn","ts":"2026-08-03T03:30:31.773092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.21437ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-03T03:30:31.773445Z","caller":"traceutil/trace.go:171","msg":"trace[1399171004] transaction","detail":"{read_only:false; response_revision:4832; number_of_response:1; }","duration":"127.288426ms","start":"2026-08-03T03:30:31.646137Z","end":"2026-08-03T03:30:31.773425Z","steps":["trace[1399171004] 'process raft request' (duration: 127.203545ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:30:31.773519Z","caller":"traceutil/trace.go:171","msg":"trace[655729714] transaction","detail":"{read_only:false; response_revision:4830; number_of_response:1; }","duration":"129.435299ms","start":"2026-08-03T03:30:31.644047Z","end":"2026-08-03T03:30:31.773483Z","steps":["trace[655729714] 'process raft request' (duration: 129.170373ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:30:31.773421Z","caller":"traceutil/trace.go:171","msg":"trace[1084090489] transaction","detail":"{read_only:false; response_revision:4831; number_of_response:1; }","duration":"127.577452ms","start":"2026-08-03T03:30:31.64582Z","end":"2026-08-03T03:30:31.773397Z","steps":["trace[1084090489] 'process raft request' (duration: 127.47696ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:30:31.775232Z","caller":"traceutil/trace.go:171","msg":"trace[1411829661] transaction","detail":"{read_only:false; response_revision:4829; number_of_response:1; }","duration":"131.437329ms","start":"2026-08-03T03:30:31.643767Z","end":"2026-08-03T03:30:31.775204Z","steps":["trace[1411829661] 'process raft request' (duration: 23.022145ms)","trace[1411829661] 'compare' (duration: 106.042267ms)"],"step_count":2} {"level":"info","ts":"2026-08-03T03:30:34.989608Z","caller":"traceutil/trace.go:171","msg":"trace[1699675034] transaction","detail":"{read_only:false; response_revision:4914; number_of_response:1; }","duration":"162.351442ms","start":"2026-08-03T03:30:34.827215Z","end":"2026-08-03T03:30:34.989566Z","steps":["trace[1699675034] 'process raft request' (duration: 161.997425ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:30:34.989956Z","caller":"traceutil/trace.go:171","msg":"trace[468784080] transaction","detail":"{read_only:false; response_revision:4915; number_of_response:1; }","duration":"105.350141ms","start":"2026-08-03T03:30:34.884592Z","end":"2026-08-03T03:30:34.989942Z","steps":["trace[468784080] 'process raft request' (duration: 105.060106ms)"],"step_count":1} {"level":"info","ts":"2026-08-03T03:31:42.570211Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2894} {"level":"info","ts":"2026-08-03T03:31:42.646832Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2894,"took":"74.274925ms","hash":456906356,"current-db-size-bytes":53432320,"current-db-size":"53 MB","current-db-size-in-use-bytes":29216768,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-03T03:31:42.646909Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":456906356,"revision":2894,"compact-revision":-1} {"level":"info","ts":"2026-08-03T03:34:26.013913Z","caller":"traceutil/trace.go:171","msg":"trace[2046088786] transaction","detail":"{read_only:false; response_revision:6652; number_of_response:1; }","duration":"134.661579ms","start":"2026-08-03T03:34:25.87921Z","end":"2026-08-03T03:34:26.013871Z","steps":["trace[2046088786] 'process raft request' (duration: 44.326078ms)","trace[2046088786] 'compare' (duration: 90.169999ms)"],"step_count":2} {"level":"info","ts":"2026-08-03T03:36:42.576658Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5544} {"level":"info","ts":"2026-08-03T03:36:42.668256Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5544,"took":"89.750211ms","hash":1592420461,"current-db-size-bytes":53432320,"current-db-size":"53 MB","current-db-size-in-use-bytes":18767872,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-08-03T03:36:42.668333Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1592420461,"revision":5544,"compact-revision":2894}