{"level":"warn","ts":"2026-04-10T01:08:24.032312Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-10T01:08:24.032435Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.204: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://162.253.55.204:2380","--initial-cluster=instance=https://162.253.55.204:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.204:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.204: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-04-10T01:08:24.032527Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-10T01:08:24.032548Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.204:2380"]} {"level":"info","ts":"2026-04-10T01:08:24.032573Z","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-04-10T01:08:24.033479Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"]} {"level":"info","ts":"2026-04-10T01:08:24.033583Z","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":16,"max-cpu-available":16,"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://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.204: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-04-10T01:08:24.037971Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.094478ms"} {"level":"info","ts":"2026-04-10T01:08:24.04662Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a11c20306510c1f7","cluster-id":"97da89d0cbebd2b5"} {"level":"info","ts":"2026-04-10T01:08:24.046706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=()"} {"level":"info","ts":"2026-04-10T01:08:24.046732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 0"} {"level":"info","ts":"2026-04-10T01:08:24.046748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a11c20306510c1f7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-10T01:08:24.046761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became follower at term 1"} {"level":"info","ts":"2026-04-10T01:08:24.046807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"} {"level":"warn","ts":"2026-04-10T01:08:24.058824Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-10T01:08:24.062222Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-10T01:08:24.064818Z","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-04-10T01:08:24.067364Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a11c20306510c1f7","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-10T01:08:24.06813Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a11c20306510c1f7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-10T01:08:24.068261Z","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-04-10T01:08:24.068321Z","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-04-10T01:08:24.068332Z","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-04-10T01:08:24.069355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 switched to configuration voters=(11609189331680412151)"} {"level":"info","ts":"2026-04-10T01:08:24.069512Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","added-peer-id":"a11c20306510c1f7","added-peer-peer-urls":["https://162.253.55.204:2380"]} {"level":"info","ts":"2026-04-10T01:08:24.071549Z","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-04-10T01:08:24.071785Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.204:2380"} {"level":"info","ts":"2026-04-10T01:08:24.071841Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.204:2380"} {"level":"info","ts":"2026-04-10T01:08:24.072074Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a11c20306510c1f7","initial-advertise-peer-urls":["https://162.253.55.204:2380"],"listen-peer-urls":["https://162.253.55.204:2380"],"advertise-client-urls":["https://162.253.55.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-10T01:08:24.072125Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-10T01:08:24.347485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 is starting a new election at term 1"} {"level":"info","ts":"2026-04-10T01:08:24.347545Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-10T01:08:24.347578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgPreVoteResp from a11c20306510c1f7 at term 1"} {"level":"info","ts":"2026-04-10T01:08:24.347593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became candidate at term 2"} {"level":"info","ts":"2026-04-10T01:08:24.3476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 received MsgVoteResp from a11c20306510c1f7 at term 2"} {"level":"info","ts":"2026-04-10T01:08:24.347611Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a11c20306510c1f7 became leader at term 2"} {"level":"info","ts":"2026-04-10T01:08:24.347621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a11c20306510c1f7 elected leader a11c20306510c1f7 at term 2"} {"level":"info","ts":"2026-04-10T01:08:24.34867Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a11c20306510c1f7","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.204:2379]}","request-path":"/0/members/a11c20306510c1f7/attributes","cluster-id":"97da89d0cbebd2b5","publish-timeout":"7s"} {"level":"info","ts":"2026-04-10T01:08:24.348814Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T01:08:24.348914Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T01:08:24.349055Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-10T01:08:24.349601Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-10T01:08:24.349725Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-10T01:08:24.34988Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"97da89d0cbebd2b5","local-member-id":"a11c20306510c1f7","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T01:08:24.350041Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T01:08:24.350089Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-10T01:08:24.351972Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.204:2379"} {"level":"info","ts":"2026-04-10T01:08:24.352536Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-10T01:08:58.201705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.385828ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T01:08:58.201922Z","caller":"traceutil/trace.go:171","msg":"trace[1335775261] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"177.134904ms","start":"2026-04-10T01:08:58.024772Z","end":"2026-04-10T01:08:58.201907Z","steps":["trace[1335775261] 'process raft request' (duration: 177.078292ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:08:58.201903Z","caller":"traceutil/trace.go:171","msg":"trace[552087722] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"224.945606ms","start":"2026-04-10T01:08:57.976914Z","end":"2026-04-10T01:08:58.20186Z","steps":["trace[552087722] 'process raft request' (duration: 107.91906ms)","trace[552087722] 'compare' (duration: 116.208873ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:08:58.201995Z","caller":"traceutil/trace.go:171","msg":"trace[911380056] linearizableReadLoop","detail":"{readStateIndex:564; appliedIndex:563; }","duration":"187.286729ms","start":"2026-04-10T01:08:58.014662Z","end":"2026-04-10T01:08:58.201949Z","steps":["trace[911380056] 'read index received' (duration: 70.247262ms)","trace[911380056] 'applied index is now lower than readState.Index' (duration: 117.034147ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:08:58.20217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.503745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.204\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-10T01:08:58.202197Z","caller":"traceutil/trace.go:171","msg":"trace[1018782406] range","detail":"{range_begin:/registry/masterleases/162.253.55.204; range_end:; response_count:1; response_revision:545; }","duration":"187.558216ms","start":"2026-04-10T01:08:58.014632Z","end":"2026-04-10T01:08:58.20219Z","steps":["trace[1018782406] 'agreement among raft nodes before linearized reading' (duration: 187.481014ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:08:58.208816Z","caller":"traceutil/trace.go:171","msg":"trace[1550563392] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"102.036595ms","start":"2026-04-10T01:08:58.106753Z","end":"2026-04-10T01:08:58.20879Z","steps":["trace[1550563392] 'process raft request' (duration: 101.361616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:08:58.209067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.4315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-10T01:08:58.209115Z","caller":"traceutil/trace.go:171","msg":"trace[1839830626] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:546; }","duration":"136.505162ms","start":"2026-04-10T01:08:58.072597Z","end":"2026-04-10T01:08:58.209102Z","steps":["trace[1839830626] 'agreement among raft nodes before linearized reading' (duration: 136.165713ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:09:03.096945Z","caller":"traceutil/trace.go:171","msg":"trace[114512550] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"143.288083ms","start":"2026-04-10T01:09:02.953587Z","end":"2026-04-10T01:09:03.096875Z","steps":["trace[114512550] 'process raft request' (duration: 142.541682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:09:03.29343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.863395ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-10T01:09:03.298074Z","caller":"traceutil/trace.go:171","msg":"trace[1979296795] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"185.531099ms","start":"2026-04-10T01:09:03.112496Z","end":"2026-04-10T01:09:03.298027Z","steps":["trace[1979296795] 'process raft request' (duration: 185.353895ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:09:03.30367Z","caller":"traceutil/trace.go:171","msg":"trace[178784653] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"144.703642ms","start":"2026-04-10T01:09:03.158939Z","end":"2026-04-10T01:09:03.303643Z","steps":["trace[178784653] 'process raft request' (duration: 144.559628ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:09:03.812386Z","caller":"traceutil/trace.go:171","msg":"trace[57146436] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"104.313919ms","start":"2026-04-10T01:09:03.708032Z","end":"2026-04-10T01:09:03.812346Z","steps":["trace[57146436] 'process raft request' (duration: 93.828555ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:09:05.264095Z","caller":"traceutil/trace.go:171","msg":"trace[760281202] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"103.409053ms","start":"2026-04-10T01:09:05.160648Z","end":"2026-04-10T01:09:05.264057Z","steps":["trace[760281202] 'read index received' (duration: 23.316135ms)","trace[760281202] 'applied index is now lower than readState.Index' (duration: 80.091478ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:09:05.264148Z","caller":"traceutil/trace.go:171","msg":"trace[1250570046] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"103.609979ms","start":"2026-04-10T01:09:05.160503Z","end":"2026-04-10T01:09:05.264113Z","steps":["trace[1250570046] 'process raft request' (duration: 23.536581ms)","trace[1250570046] 'compare' (duration: 79.854652ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:09:05.264405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.287459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:09:05.264475Z","caller":"traceutil/trace.go:171","msg":"trace[55376858] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:619; }","duration":"103.413374ms","start":"2026-04-10T01:09:05.161052Z","end":"2026-04-10T01:09:05.264466Z","steps":["trace[55376858] 'agreement among raft nodes before linearized reading' (duration: 103.231869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:09:05.26446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.739442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:09:05.264581Z","caller":"traceutil/trace.go:171","msg":"trace[1704637941] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:619; }","duration":"103.922507ms","start":"2026-04-10T01:09:05.160635Z","end":"2026-04-10T01:09:05.264557Z","steps":["trace[1704637941] 'agreement among raft nodes before linearized reading' (duration: 103.600118ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:09:18.452513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.414663ms","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-04-10T01:09:18.452593Z","caller":"traceutil/trace.go:171","msg":"trace[1406519073] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:744; }","duration":"134.562858ms","start":"2026-04-10T01:09:18.318016Z","end":"2026-04-10T01:09:18.452579Z","steps":["trace[1406519073] 'range keys from in-memory index tree' (duration: 134.233649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:09:18.452593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.275289ms","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-04-10T01:09:18.452675Z","caller":"traceutil/trace.go:171","msg":"trace[1817822491] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:744; }","duration":"155.401332ms","start":"2026-04-10T01:09:18.297259Z","end":"2026-04-10T01:09:18.452661Z","steps":["trace[1817822491] 'range keys from in-memory index tree' (duration: 155.011752ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:09:50.844764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.191689ms","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-04-10T01:09:50.844812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.920307ms","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-04-10T01:09:50.844884Z","caller":"traceutil/trace.go:171","msg":"trace[1151029403] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1159; }","duration":"198.353484ms","start":"2026-04-10T01:09:50.646507Z","end":"2026-04-10T01:09:50.84486Z","steps":["trace[1151029403] 'range keys from in-memory index tree' (duration: 197.894102ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:09:50.844912Z","caller":"traceutil/trace.go:171","msg":"trace[933101987] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1159; }","duration":"200.066491ms","start":"2026-04-10T01:09:50.644826Z","end":"2026-04-10T01:09:50.844893Z","steps":["trace[933101987] 'range keys from in-memory index tree' (duration: 199.696881ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:11.40504Z","caller":"traceutil/trace.go:171","msg":"trace[340970710] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"140.422054ms","start":"2026-04-10T01:10:11.264577Z","end":"2026-04-10T01:10:11.404999Z","steps":["trace[340970710] 'process raft request' (duration: 140.085504ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:30.801319Z","caller":"traceutil/trace.go:171","msg":"trace[1408889337] transaction","detail":"{read_only:false; response_revision:1724; number_of_response:1; }","duration":"224.910513ms","start":"2026-04-10T01:10:30.576382Z","end":"2026-04-10T01:10:30.801292Z","steps":["trace[1408889337] 'process raft request' (duration: 224.742178ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:31.001317Z","caller":"traceutil/trace.go:171","msg":"trace[825693693] transaction","detail":"{read_only:false; response_revision:1725; number_of_response:1; }","duration":"247.632057ms","start":"2026-04-10T01:10:30.753659Z","end":"2026-04-10T01:10:31.001291Z","steps":["trace[825693693] 'process raft request' (duration: 244.222894ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:31.001361Z","caller":"traceutil/trace.go:171","msg":"trace[351149986] linearizableReadLoop","detail":"{readStateIndex:1795; appliedIndex:1793; }","duration":"240.847681ms","start":"2026-04-10T01:10:30.760495Z","end":"2026-04-10T01:10:31.001343Z","steps":["trace[351149986] 'read index received' (duration: 40.670166ms)","trace[351149986] 'applied index is now lower than readState.Index' (duration: 200.175634ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:10:31.00147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.965283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:31.001504Z","caller":"traceutil/trace.go:171","msg":"trace[1459982374] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1726; }","duration":"241.043846ms","start":"2026-04-10T01:10:30.760452Z","end":"2026-04-10T01:10:31.001496Z","steps":["trace[1459982374] 'agreement among raft nodes before linearized reading' (duration: 240.974894ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:31.001561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.927401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/percona-xtradb\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:31.001649Z","caller":"traceutil/trace.go:171","msg":"trace[1636806776] range","detail":"{range_begin:/registry/secrets/openstack/percona-xtradb; range_end:; response_count:0; response_revision:1726; }","duration":"132.064204ms","start":"2026-04-10T01:10:30.869567Z","end":"2026-04-10T01:10:31.001631Z","steps":["trace[1636806776] 'agreement among raft nodes before linearized reading' (duration: 131.90568ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:31.613961Z","caller":"traceutil/trace.go:171","msg":"trace[1904345899] transaction","detail":"{read_only:false; response_revision:1731; number_of_response:1; }","duration":"214.830127ms","start":"2026-04-10T01:10:31.399092Z","end":"2026-04-10T01:10:31.613922Z","steps":["trace[1904345899] 'process raft request' (duration: 214.427126ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:32.404622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"641.511056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:32.404734Z","caller":"traceutil/trace.go:171","msg":"trace[515206879] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1732; }","duration":"641.698061ms","start":"2026-04-10T01:10:31.763015Z","end":"2026-04-10T01:10:32.404713Z","steps":["trace[515206879] 'range keys from in-memory index tree' (duration: 641.431494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:32.404814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.254012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:10:32.404914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.564333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:10:32.404788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:31.762993Z","time spent":"641.783934ms","remote":"127.0.0.1:35912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T01:10:32.405089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.413732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:32.405167Z","caller":"traceutil/trace.go:171","msg":"trace[607565371] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1732; }","duration":"136.545907ms","start":"2026-04-10T01:10:32.268602Z","end":"2026-04-10T01:10:32.405148Z","steps":["trace[607565371] 'range keys from in-memory index tree' (duration: 136.257018ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:32.405184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.077297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:32.40522Z","caller":"traceutil/trace.go:171","msg":"trace[881214823] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1732; }","duration":"111.159189ms","start":"2026-04-10T01:10:32.294052Z","end":"2026-04-10T01:10:32.405212Z","steps":["trace[881214823] 'count revisions from in-memory index tree' (duration: 110.945474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:32.404953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.373384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:32.405411Z","caller":"traceutil/trace.go:171","msg":"trace[124090654] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1732; }","duration":"174.871098ms","start":"2026-04-10T01:10:32.230522Z","end":"2026-04-10T01:10:32.405393Z","steps":["trace[124090654] 'count revisions from in-memory index tree' (duration: 174.309393ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:32.405113Z","caller":"traceutil/trace.go:171","msg":"trace[762674067] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1732; }","duration":"110.854561ms","start":"2026-04-10T01:10:32.294155Z","end":"2026-04-10T01:10:32.40501Z","steps":["trace[762674067] 'range keys from in-memory index tree' (duration: 110.399039ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:32.405672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.811183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:10:32.4057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.270347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:32.405732Z","caller":"traceutil/trace.go:171","msg":"trace[422467371] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1732; }","duration":"219.303708ms","start":"2026-04-10T01:10:32.186417Z","end":"2026-04-10T01:10:32.405721Z","steps":["trace[422467371] 'range keys from in-memory index tree' (duration: 219.100422ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:32.404862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.147615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:32.404966Z","caller":"traceutil/trace.go:171","msg":"trace[20065411] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1732; }","duration":"174.522639ms","start":"2026-04-10T01:10:32.230415Z","end":"2026-04-10T01:10:32.404938Z","steps":["trace[20065411] 'range keys from in-memory index tree' (duration: 174.086787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:32.405755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.959516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:32.405791Z","caller":"traceutil/trace.go:171","msg":"trace[1611732946] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1732; }","duration":"208.067339ms","start":"2026-04-10T01:10:32.197714Z","end":"2026-04-10T01:10:32.405782Z","steps":["trace[1611732946] 'count revisions from in-memory index tree' (duration: 207.856863ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:32.405794Z","caller":"traceutil/trace.go:171","msg":"trace[2088891205] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1732; }","duration":"137.146903ms","start":"2026-04-10T01:10:32.268621Z","end":"2026-04-10T01:10:32.405768Z","steps":["trace[2088891205] 'count revisions from in-memory index tree' (duration: 135.995042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:32.405861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.329699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:10:32.405887Z","caller":"traceutil/trace.go:171","msg":"trace[1498415852] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1732; }","duration":"219.38857ms","start":"2026-04-10T01:10:32.18649Z","end":"2026-04-10T01:10:32.405879Z","steps":["trace[1498415852] 'count revisions from in-memory index tree' (duration: 219.288498ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:32.40573Z","caller":"traceutil/trace.go:171","msg":"trace[1869507468] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:1732; }","duration":"207.928155ms","start":"2026-04-10T01:10:32.197786Z","end":"2026-04-10T01:10:32.405714Z","steps":["trace[1869507468] 'range keys from in-memory index tree' (duration: 207.677538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:32.406275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.5718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-10T01:10:32.406308Z","caller":"traceutil/trace.go:171","msg":"trace[1974138383] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1732; }","duration":"534.662813ms","start":"2026-04-10T01:10:31.871639Z","end":"2026-04-10T01:10:32.406302Z","steps":["trace[1974138383] 'range keys from in-memory index tree' (duration: 533.567803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:32.406328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:10:31.871609Z","time spent":"534.712755ms","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-10T01:10:40.933486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.951328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f0491a31-4238-4140-9f8b-fa8d14684bde\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-10T01:10:40.933607Z","caller":"traceutil/trace.go:171","msg":"trace[206694043] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f0491a31-4238-4140-9f8b-fa8d14684bde; range_end:; response_count:1; response_revision:1849; }","duration":"239.119342ms","start":"2026-04-10T01:10:40.694466Z","end":"2026-04-10T01:10:40.933585Z","steps":["trace[206694043] 'range keys from in-memory index tree' (duration: 238.788843ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:40.934046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.238169ms","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-04-10T01:10:40.934112Z","caller":"traceutil/trace.go:171","msg":"trace[999595118] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1849; }","duration":"144.340071ms","start":"2026-04-10T01:10:40.789754Z","end":"2026-04-10T01:10:40.934094Z","steps":["trace[999595118] 'range keys from in-memory index tree' (duration: 144.033773ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:10:41.266642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.040451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-04-10T01:10:41.266675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.527642ms","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-04-10T01:10:41.266741Z","caller":"traceutil/trace.go:171","msg":"trace[486425986] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1851; }","duration":"106.189705ms","start":"2026-04-10T01:10:41.160531Z","end":"2026-04-10T01:10:41.266721Z","steps":["trace[486425986] 'range keys from in-memory index tree' (duration: 105.896497ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:41.26676Z","caller":"traceutil/trace.go:171","msg":"trace[615265649] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1851; }","duration":"103.663465ms","start":"2026-04-10T01:10:41.163061Z","end":"2026-04-10T01:10:41.266724Z","steps":["trace[615265649] 'range keys from in-memory index tree' (duration: 103.385028ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:10:53.639497Z","caller":"traceutil/trace.go:171","msg":"trace[615177573] transaction","detail":"{read_only:false; response_revision:1954; number_of_response:1; }","duration":"120.631051ms","start":"2026-04-10T01:10:53.51883Z","end":"2026-04-10T01:10:53.639461Z","steps":["trace[615177573] 'process raft request' (duration: 120.327643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:19.71996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.08504ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T01:11:19.720202Z","caller":"traceutil/trace.go:171","msg":"trace[1834447246] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"209.133821ms","start":"2026-04-10T01:11:19.511031Z","end":"2026-04-10T01:11:19.720165Z","steps":["trace[1834447246] 'process raft request' (duration: 105.724102ms)","trace[1834447246] 'compare' (duration: 102.943016ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:11:19.720234Z","caller":"traceutil/trace.go:171","msg":"trace[1332186510] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"206.688313ms","start":"2026-04-10T01:11:19.513523Z","end":"2026-04-10T01:11:19.720212Z","steps":["trace[1332186510] 'process raft request' (duration: 206.55602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:25.452404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.543865ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:11:25.452584Z","caller":"traceutil/trace.go:171","msg":"trace[2107229431] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2140; }","duration":"137.757292ms","start":"2026-04-10T01:11:25.314802Z","end":"2026-04-10T01:11:25.452559Z","steps":["trace[2107229431] 'range keys from in-memory index tree' (duration: 137.508344ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:25.452853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.637682ms","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-04-10T01:11:25.45297Z","caller":"traceutil/trace.go:171","msg":"trace[1796870701] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2140; }","duration":"147.824227ms","start":"2026-04-10T01:11:25.305121Z","end":"2026-04-10T01:11:25.452945Z","steps":["trace[1796870701] 'range keys from in-memory index tree' (duration: 147.367215ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:11:31.401799Z","caller":"traceutil/trace.go:171","msg":"trace[1283446402] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"112.2282ms","start":"2026-04-10T01:11:31.289535Z","end":"2026-04-10T01:11:31.401763Z","steps":["trace[1283446402] 'process raft request' (duration: 111.819409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:11:31.662973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.679256ms","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-04-10T01:11:31.663088Z","caller":"traceutil/trace.go:171","msg":"trace[1149292668] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2173; }","duration":"162.896061ms","start":"2026-04-10T01:11:31.500162Z","end":"2026-04-10T01:11:31.663058Z","steps":["trace[1149292668] 'range keys from in-memory index tree' (duration: 162.404558ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:11:31.796859Z","caller":"traceutil/trace.go:171","msg":"trace[1347870032] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"123.645484ms","start":"2026-04-10T01:11:31.673181Z","end":"2026-04-10T01:11:31.796826Z","steps":["trace[1347870032] 'process raft request' (duration: 123.450119ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:11:31.920852Z","caller":"traceutil/trace.go:171","msg":"trace[1169742213] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"117.770373ms","start":"2026-04-10T01:11:31.803055Z","end":"2026-04-10T01:11:31.920825Z","steps":["trace[1169742213] 'process raft request' (duration: 113.67799ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:11:31.922058Z","caller":"traceutil/trace.go:171","msg":"trace[1101844953] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"118.874283ms","start":"2026-04-10T01:11:31.803156Z","end":"2026-04-10T01:11:31.92203Z","steps":["trace[1101844953] 'process raft request' (duration: 118.658117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:00.172388Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813094116753667,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T01:12:00.673533Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813094116753667,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T01:12:01.173993Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813094116753667,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T01:12:01.674821Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813094116753667,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-10T01:12:02.092909Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.578674952s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-10T01:12:02.093096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.329979624s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:12:02.093181Z","caller":"traceutil/trace.go:171","msg":"trace[323986722] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2329; }","duration":"3.330102327s","start":"2026-04-10T01:11:58.763059Z","end":"2026-04-10T01:12:02.093161Z","steps":["trace[323986722] 'range keys from in-memory index tree' (duration: 3.329918202s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:02.09321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:58.763044Z","time spent":"3.330160378s","remote":"127.0.0.1:35912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T01:12:02.094664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.191608756s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"warn","ts":"2026-04-10T01:12:02.094737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.178524837s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-10T01:12:02.094739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.201771555s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5428"} {"level":"info","ts":"2026-04-10T01:12:02.094793Z","caller":"traceutil/trace.go:171","msg":"trace[1710677705] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2329; }","duration":"3.1917745s","start":"2026-04-10T01:11:58.902987Z","end":"2026-04-10T01:12:02.094762Z","steps":["trace[1710677705] 'range keys from in-memory index tree' (duration: 3.19139735s)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:02.09481Z","caller":"traceutil/trace.go:171","msg":"trace[1563474389] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2329; }","duration":"3.178664551s","start":"2026-04-10T01:11:58.916129Z","end":"2026-04-10T01:12:02.094793Z","steps":["trace[1563474389] 'range keys from in-memory index tree' (duration: 3.178322591s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:02.094839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:58.902977Z","time spent":"3.191850743s","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":583,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-04-10T01:12:02.09485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:58.916096Z","time spent":"3.178746023s","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-10T01:12:02.094846Z","caller":"traceutil/trace.go:171","msg":"trace[1533564787] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2329; }","duration":"3.201908798s","start":"2026-04-10T01:11:58.892895Z","end":"2026-04-10T01:12:02.094804Z","steps":["trace[1533564787] 'range keys from in-memory index tree' (duration: 3.201531058s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:02.094924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:58.892883Z","time spent":"3.202017992s","remote":"127.0.0.1:49352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5452,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-10T01:12:02.094831Z","caller":"traceutil/trace.go:171","msg":"trace[1729386620] transaction","detail":"{read_only:false; response_revision:2330; number_of_response:1; }","duration":"2.580723498s","start":"2026-04-10T01:11:59.514095Z","end":"2026-04-10T01:12:02.094818Z","steps":["trace[1729386620] 'process raft request' (duration: 2.579469113s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:02.096331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:59.514057Z","time spent":"2.582214709s","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:12:02.098822Z","caller":"traceutil/trace.go:171","msg":"trace[898821798] transaction","detail":"{read_only:false; response_revision:2331; number_of_response:1; }","duration":"2.583281788s","start":"2026-04-10T01:11:59.515508Z","end":"2026-04-10T01:12:02.09879Z","steps":["trace[898821798] 'process raft request' (duration: 2.583098143s)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:02.098849Z","caller":"traceutil/trace.go:171","msg":"trace[506557069] linearizableReadLoop","detail":"{readStateIndex:2426; appliedIndex:2420; }","duration":"2.42706715s","start":"2026-04-10T01:11:59.671763Z","end":"2026-04-10T01:12:02.09883Z","steps":["trace[506557069] 'read index received' (duration: 2.42160949s)","trace[506557069] 'applied index is now lower than readState.Index' (duration: 5.45685ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:12:02.098953Z","caller":"traceutil/trace.go:171","msg":"trace[664719632] transaction","detail":"{read_only:false; response_revision:2334; number_of_response:1; }","duration":"933.694649ms","start":"2026-04-10T01:12:01.165249Z","end":"2026-04-10T01:12:02.098943Z","steps":["trace[664719632] 'process raft request' (duration: 933.520564ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:02.098945Z","caller":"traceutil/trace.go:171","msg":"trace[359879744] transaction","detail":"{read_only:false; response_revision:2332; number_of_response:1; }","duration":"2.070744649s","start":"2026-04-10T01:12:00.028178Z","end":"2026-04-10T01:12:02.098922Z","steps":["trace[359879744] 'process raft request' (duration: 2.070533764s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:02.099009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:00.028157Z","time spent":"2.070820812s","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:12:02.099038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:01.165211Z","time spent":"933.766131ms","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:12:02.099119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.427355929s","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-04-10T01:12:02.099146Z","caller":"traceutil/trace.go:171","msg":"trace[546188540] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2335; }","duration":"2.42743076s","start":"2026-04-10T01:11:59.671706Z","end":"2026-04-10T01:12:02.099136Z","steps":["trace[546188540] 'agreement among raft nodes before linearized reading' (duration: 2.427377369s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:02.099165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:59.671679Z","time spent":"2.427481222s","remote":"127.0.0.1:51012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-10T01:12:02.099215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.155538347s","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-04-10T01:12:02.099238Z","caller":"traceutil/trace.go:171","msg":"trace[1469493860] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2335; }","duration":"2.155608319s","start":"2026-04-10T01:11:59.943623Z","end":"2026-04-10T01:12:02.099231Z","steps":["trace[1469493860] 'agreement among raft nodes before linearized reading' (duration: 2.155504026s)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:02.099281Z","caller":"traceutil/trace.go:171","msg":"trace[1703647624] transaction","detail":"{read_only:false; response_revision:2335; number_of_response:1; }","duration":"878.816582ms","start":"2026-04-10T01:12:01.220457Z","end":"2026-04-10T01:12:02.099273Z","steps":["trace[1703647624] 'process raft request' (duration: 878.344479ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:02.099287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:59.943598Z","time spent":"2.155655709s","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-10T01:12:02.099319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:01.220422Z","time spent":"878.874814ms","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:12:02.099387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.335700533s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:12:02.099405Z","caller":"traceutil/trace.go:171","msg":"trace[2048115051] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2335; }","duration":"1.335770285s","start":"2026-04-10T01:12:00.763629Z","end":"2026-04-10T01:12:02.099399Z","steps":["trace[2048115051] 'agreement among raft nodes before linearized reading' (duration: 1.335739055s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:02.099425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:00.7636Z","time spent":"1.335818586s","remote":"127.0.0.1:35920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T01:12:02.099624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.035664436s","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-04-10T01:12:02.099644Z","caller":"traceutil/trace.go:171","msg":"trace[1148808338] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2335; }","duration":"2.035710398s","start":"2026-04-10T01:12:00.063927Z","end":"2026-04-10T01:12:02.099638Z","steps":["trace[1148808338] 'agreement among raft nodes before linearized reading' (duration: 2.035646666s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:02.099668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:00.063913Z","time spent":"2.035749609s","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-10T01:12:02.099667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.664097497s","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":"warn","ts":"2026-04-10T01:12:02.099624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.029156698s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-10T01:12:02.09975Z","caller":"traceutil/trace.go:171","msg":"trace[1291810781] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2335; }","duration":"2.029320912s","start":"2026-04-10T01:12:00.070399Z","end":"2026-04-10T01:12:02.099719Z","steps":["trace[1291810781] 'agreement among raft nodes before linearized reading' (duration: 2.029016094s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:02.099812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:00.070384Z","time spent":"2.029412965s","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-10T01:12:02.099691Z","caller":"traceutil/trace.go:171","msg":"trace[636526891] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2335; }","duration":"1.664173779s","start":"2026-04-10T01:12:00.435511Z","end":"2026-04-10T01:12:02.099685Z","steps":["trace[636526891] 'agreement among raft nodes before linearized reading' (duration: 1.664129708s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:02.09987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:00.435493Z","time spent":"1.664364054s","remote":"127.0.0.1:51028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-10T01:12:02.099685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.044256742s","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-04-10T01:12:02.099996Z","caller":"traceutil/trace.go:171","msg":"trace[1575535743] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2335; }","duration":"2.044591472s","start":"2026-04-10T01:12:00.055395Z","end":"2026-04-10T01:12:02.099987Z","steps":["trace[1575535743] 'agreement among raft nodes before linearized reading' (duration: 2.044196421s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:02.100024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:00.055383Z","time spent":"2.044633832s","remote":"127.0.0.1:36190","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":"warn","ts":"2026-04-10T01:12:02.099859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:11:59.515471Z","time spent":"2.583393171s","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:12:02.099059Z","caller":"traceutil/trace.go:171","msg":"trace[664619621] transaction","detail":"{read_only:false; response_revision:2333; number_of_response:1; }","duration":"1.674428171s","start":"2026-04-10T01:12:00.424584Z","end":"2026-04-10T01:12:02.099012Z","steps":["trace[664619621] 'process raft request' (duration: 1.674157913s)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:02.101338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:00.424548Z","time spent":"1.676683213s","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:12:12.963303Z","caller":"traceutil/trace.go:171","msg":"trace[1908858061] transaction","detail":"{read_only:false; response_revision:2407; number_of_response:1; }","duration":"383.437724ms","start":"2026-04-10T01:12:12.579834Z","end":"2026-04-10T01:12:12.963272Z","steps":["trace[1908858061] 'process raft request' (duration: 383.29137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:12.963481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:12.579808Z","time spent":"383.602109ms","remote":"127.0.0.1:57868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":917,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-10T01:12:48.297478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.340253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-10T01:12:48.297591Z","caller":"traceutil/trace.go:171","msg":"trace[694617719] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2768; }","duration":"112.532679ms","start":"2026-04-10T01:12:48.185033Z","end":"2026-04-10T01:12:48.297566Z","steps":["trace[694617719] 'range keys from in-memory index tree' (duration: 111.621234ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:52.223659Z","caller":"traceutil/trace.go:171","msg":"trace[2006903150] transaction","detail":"{read_only:false; response_revision:2789; number_of_response:1; }","duration":"544.537046ms","start":"2026-04-10T01:12:51.679081Z","end":"2026-04-10T01:12:52.223619Z","steps":["trace[2006903150] 'process raft request' (duration: 544.219858ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:52.22384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:12:51.679048Z","time spent":"544.70978ms","remote":"127.0.0.1:36012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":753,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-10T01:12:52.692658Z","caller":"traceutil/trace.go:171","msg":"trace[975859629] linearizableReadLoop","detail":"{readStateIndex:2898; appliedIndex:2897; }","duration":"140.063395ms","start":"2026-04-10T01:12:52.552563Z","end":"2026-04-10T01:12:52.692626Z","steps":["trace[975859629] 'read index received' (duration: 138.839021ms)","trace[975859629] 'applied index is now lower than readState.Index' (duration: 1.223073ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:12:52.693014Z","caller":"traceutil/trace.go:171","msg":"trace[662425421] transaction","detail":"{read_only:false; response_revision:2791; number_of_response:1; }","duration":"150.413109ms","start":"2026-04-10T01:12:52.542579Z","end":"2026-04-10T01:12:52.692993Z","steps":["trace[662425421] 'process raft request' (duration: 148.807244ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:52.693328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.733244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-10T01:12:52.693426Z","caller":"traceutil/trace.go:171","msg":"trace[457238903] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2791; }","duration":"140.862267ms","start":"2026-04-10T01:12:52.552548Z","end":"2026-04-10T01:12:52.69341Z","steps":["trace[457238903] 'agreement among raft nodes before linearized reading' (duration: 140.59541ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:52.695814Z","caller":"traceutil/trace.go:171","msg":"trace[585902614] transaction","detail":"{read_only:false; response_revision:2792; number_of_response:1; }","duration":"140.154737ms","start":"2026-04-10T01:12:52.555635Z","end":"2026-04-10T01:12:52.69579Z","steps":["trace[585902614] 'process raft request' (duration: 139.86691ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:52.695905Z","caller":"traceutil/trace.go:171","msg":"trace[1482904152] transaction","detail":"{read_only:false; response_revision:2794; number_of_response:1; }","duration":"134.489642ms","start":"2026-04-10T01:12:52.561393Z","end":"2026-04-10T01:12:52.695883Z","steps":["trace[1482904152] 'process raft request' (duration: 134.288166ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:12:52.69607Z","caller":"traceutil/trace.go:171","msg":"trace[231916729] transaction","detail":"{read_only:false; response_revision:2793; number_of_response:1; }","duration":"137.741291ms","start":"2026-04-10T01:12:52.558312Z","end":"2026-04-10T01:12:52.696053Z","steps":["trace[231916729] 'process raft request' (duration: 137.316189ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:12:53.819466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.498242ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-10T01:14:03.963189Z","caller":"traceutil/trace.go:171","msg":"trace[334344796] transaction","detail":"{read_only:false; response_revision:3182; number_of_response:1; }","duration":"101.900797ms","start":"2026-04-10T01:14:03.861266Z","end":"2026-04-10T01:14:03.963167Z","steps":["trace[334344796] 'process raft request' (duration: 101.725082ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:15:24.264055Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813094116757257,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-10T01:15:24.523286Z","caller":"traceutil/trace.go:171","msg":"trace[756043663] linearizableReadLoop","detail":"{readStateIndex:3934; appliedIndex:3933; }","duration":"759.616201ms","start":"2026-04-10T01:15:23.763632Z","end":"2026-04-10T01:15:24.523248Z","steps":["trace[756043663] 'read index received' (duration: 759.355104ms)","trace[756043663] 'applied index is now lower than readState.Index' (duration: 259.727µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:15:24.52362Z","caller":"traceutil/trace.go:171","msg":"trace[617525838] transaction","detail":"{read_only:false; response_revision:3790; number_of_response:1; }","duration":"910.226967ms","start":"2026-04-10T01:15:23.613359Z","end":"2026-04-10T01:15:24.523586Z","steps":["trace[617525838] 'process raft request' (duration: 909.653462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:15:24.523741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.016502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:15:24.52379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:15:23.61333Z","time spent":"910.368561ms","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:15:24.523858Z","caller":"traceutil/trace.go:171","msg":"trace[334353410] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3790; }","duration":"760.229018ms","start":"2026-04-10T01:15:23.763578Z","end":"2026-04-10T01:15:24.523807Z","steps":["trace[334353410] 'agreement among raft nodes before linearized reading' (duration: 760.027863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:15:24.5239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.891734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-04-10T01:15:24.523999Z","caller":"traceutil/trace.go:171","msg":"trace[24939746] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3790; }","duration":"728.062949ms","start":"2026-04-10T01:15:23.795916Z","end":"2026-04-10T01:15:24.523979Z","steps":["trace[24939746] 'agreement among raft nodes before linearized reading' (duration: 727.758971ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:15:24.524026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:15:23.795889Z","time spent":"728.131161ms","remote":"127.0.0.1:36120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-10T01:15:24.523931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:15:23.76355Z","time spent":"760.367171ms","remote":"127.0.0.1:35912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-10T01:15:24.524219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.198081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-grafana-client-secret\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:15:24.524355Z","caller":"traceutil/trace.go:171","msg":"trace[199168595] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-grafana-client-secret; range_end:; response_count:0; response_revision:3790; }","duration":"601.416588ms","start":"2026-04-10T01:15:23.922909Z","end":"2026-04-10T01:15:24.524325Z","steps":["trace[199168595] 'agreement among raft nodes before linearized reading' (duration: 601.010516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:15:24.524555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:15:23.922879Z","time spent":"601.654094ms","remote":"127.0.0.1:51732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-grafana-client-secret\" "} {"level":"warn","ts":"2026-04-10T01:17:02.104523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.282393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-04-10T01:17:02.104619Z","caller":"traceutil/trace.go:171","msg":"trace[461201233] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4850; }","duration":"122.427786ms","start":"2026-04-10T01:17:01.982172Z","end":"2026-04-10T01:17:02.1046Z","steps":["trace[461201233] 'range keys from in-memory index tree' (duration: 122.110398ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:17:08.318601Z","caller":"traceutil/trace.go:171","msg":"trace[725174240] linearizableReadLoop","detail":"{readStateIndex:5257; appliedIndex:5256; }","duration":"155.656328ms","start":"2026-04-10T01:17:08.162925Z","end":"2026-04-10T01:17:08.318581Z","steps":["trace[725174240] 'read index received' (duration: 155.454492ms)","trace[725174240] 'applied index is now lower than readState.Index' (duration: 200.946µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:17:08.318904Z","caller":"traceutil/trace.go:171","msg":"trace[39851367] transaction","detail":"{read_only:false; response_revision:5065; number_of_response:1; }","duration":"157.420346ms","start":"2026-04-10T01:17:08.161469Z","end":"2026-04-10T01:17:08.31889Z","steps":["trace[39851367] 'process raft request' (duration: 156.968364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:17:08.319008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.041568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/vector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:17:08.31912Z","caller":"traceutil/trace.go:171","msg":"trace[1561157963] range","detail":"{range_begin:/registry/clusterroles/vector; range_end:; response_count:0; response_revision:5065; }","duration":"156.195783ms","start":"2026-04-10T01:17:08.162902Z","end":"2026-04-10T01:17:08.319098Z","steps":["trace[1561157963] 'agreement among raft nodes before linearized reading' (duration: 155.980577ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:17:08.453487Z","caller":"traceutil/trace.go:171","msg":"trace[1977596956] linearizableReadLoop","detail":"{readStateIndex:5258; appliedIndex:5257; }","duration":"134.759625ms","start":"2026-04-10T01:17:08.31869Z","end":"2026-04-10T01:17:08.453449Z","steps":["trace[1977596956] 'read index received' (duration: 90.83086ms)","trace[1977596956] 'applied index is now lower than readState.Index' (duration: 43.927045ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:17:08.453734Z","caller":"traceutil/trace.go:171","msg":"trace[522350888] transaction","detail":"{read_only:false; response_revision:5066; number_of_response:1; }","duration":"196.795716ms","start":"2026-04-10T01:17:08.256905Z","end":"2026-04-10T01:17:08.453701Z","steps":["trace[522350888] 'process raft request' (duration: 152.612744ms)","trace[522350888] 'compare' (duration: 43.616296ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:17:08.453729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.406689ms","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-04-10T01:17:08.453824Z","caller":"traceutil/trace.go:171","msg":"trace[30700416] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5066; }","duration":"276.547812ms","start":"2026-04-10T01:17:08.177251Z","end":"2026-04-10T01:17:08.453799Z","steps":["trace[30700416] 'agreement among raft nodes before linearized reading' (duration: 276.305896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:17:08.453804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.146586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/vector\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:17:08.45391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.358445ms","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-04-10T01:17:08.453921Z","caller":"traceutil/trace.go:171","msg":"trace[486793442] range","detail":"{range_begin:/registry/clusterrolebindings/vector; range_end:; response_count:0; response_revision:5066; }","duration":"131.323601ms","start":"2026-04-10T01:17:08.322566Z","end":"2026-04-10T01:17:08.45389Z","steps":["trace[486793442] 'agreement among raft nodes before linearized reading' (duration: 131.141306ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:17:08.453948Z","caller":"traceutil/trace.go:171","msg":"trace[234651570] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5066; }","duration":"277.413116ms","start":"2026-04-10T01:17:08.176521Z","end":"2026-04-10T01:17:08.453935Z","steps":["trace[234651570] 'agreement among raft nodes before linearized reading' (duration: 277.113208ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:17:08.453852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.368053ms","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-04-10T01:17:08.454051Z","caller":"traceutil/trace.go:171","msg":"trace[889192292] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5066; }","duration":"278.546068ms","start":"2026-04-10T01:17:08.175476Z","end":"2026-04-10T01:17:08.454022Z","steps":["trace[889192292] 'agreement among raft nodes before linearized reading' (duration: 278.237679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:17:08.45373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.696503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d1651f5b-a8bb-4f9b-8cbf-4120ab751605\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-10T01:17:08.454213Z","caller":"traceutil/trace.go:171","msg":"trace[631509065] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d1651f5b-a8bb-4f9b-8cbf-4120ab751605; range_end:; response_count:1; response_revision:5066; }","duration":"147.173445ms","start":"2026-04-10T01:17:08.306981Z","end":"2026-04-10T01:17:08.454155Z","steps":["trace[631509065] 'agreement among raft nodes before linearized reading' (duration: 146.532518ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:17:08.741408Z","caller":"traceutil/trace.go:171","msg":"trace[527963523] transaction","detail":"{read_only:false; response_revision:5076; number_of_response:1; }","duration":"101.063762ms","start":"2026-04-10T01:17:08.640317Z","end":"2026-04-10T01:17:08.741381Z","steps":["trace[527963523] 'process raft request' (duration: 100.954049ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:17:08.782052Z","caller":"traceutil/trace.go:171","msg":"trace[1674683888] transaction","detail":"{read_only:false; response_revision:5078; number_of_response:1; }","duration":"140.218685ms","start":"2026-04-10T01:17:08.6418Z","end":"2026-04-10T01:17:08.782019Z","steps":["trace[1674683888] 'process raft request' (duration: 140.165013ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:17:08.782094Z","caller":"traceutil/trace.go:171","msg":"trace[1989476045] transaction","detail":"{read_only:false; response_revision:5077; number_of_response:1; }","duration":"141.365887ms","start":"2026-04-10T01:17:08.640685Z","end":"2026-04-10T01:17:08.78205Z","steps":["trace[1989476045] 'process raft request' (duration: 141.10358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:17:16.25013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.534153ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T01:17:16.250556Z","caller":"traceutil/trace.go:171","msg":"trace[113505174] transaction","detail":"{read_only:false; response_revision:5234; number_of_response:1; }","duration":"150.815397ms","start":"2026-04-10T01:17:16.099714Z","end":"2026-04-10T01:17:16.25053Z","steps":["trace[113505174] 'process raft request' (duration: 150.605081ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:17:16.250557Z","caller":"traceutil/trace.go:171","msg":"trace[1529550264] transaction","detail":"{read_only:false; response_revision:5233; number_of_response:1; }","duration":"150.893989ms","start":"2026-04-10T01:17:16.099492Z","end":"2026-04-10T01:17:16.250386Z","steps":["trace[1529550264] 'process raft request' (duration: 43.967956ms)","trace[1529550264] 'compare' (duration: 106.334007ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:17:16.250687Z","caller":"traceutil/trace.go:171","msg":"trace[1558521453] transaction","detail":"{read_only:false; response_revision:5235; number_of_response:1; }","duration":"150.496038ms","start":"2026-04-10T01:17:16.100158Z","end":"2026-04-10T01:17:16.250654Z","steps":["trace[1558521453] 'process raft request' (duration: 150.317814ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:17:19.848769Z","caller":"traceutil/trace.go:171","msg":"trace[234837426] transaction","detail":"{read_only:false; response_revision:5304; number_of_response:1; }","duration":"105.764342ms","start":"2026-04-10T01:17:19.742963Z","end":"2026-04-10T01:17:19.848727Z","steps":["trace[234837426] 'process raft request' (duration: 21.980373ms)","trace[234837426] 'compare' (duration: 83.520851ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:17:19.8488Z","caller":"traceutil/trace.go:171","msg":"trace[1381554661] transaction","detail":"{read_only:false; response_revision:5305; number_of_response:1; }","duration":"105.533695ms","start":"2026-04-10T01:17:19.743247Z","end":"2026-04-10T01:17:19.848781Z","steps":["trace[1381554661] 'process raft request' (duration: 105.421252ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:17:20.028869Z","caller":"traceutil/trace.go:171","msg":"trace[906895380] transaction","detail":"{read_only:false; response_revision:5307; number_of_response:1; }","duration":"208.582472ms","start":"2026-04-10T01:17:19.820256Z","end":"2026-04-10T01:17:20.028838Z","steps":["trace[906895380] 'process raft request' (duration: 196.361027ms)","trace[906895380] 'compare' (duration: 12.03486ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:17:20.029127Z","caller":"traceutil/trace.go:171","msg":"trace[940255150] linearizableReadLoop","detail":"{readStateIndex:5508; appliedIndex:5505; }","duration":"180.367548ms","start":"2026-04-10T01:17:19.848734Z","end":"2026-04-10T01:17:20.029102Z","steps":["trace[940255150] 'read index received' (duration: 44.735517ms)","trace[940255150] 'applied index is now lower than readState.Index' (duration: 135.631341ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:17:20.029177Z","caller":"traceutil/trace.go:171","msg":"trace[1288238182] transaction","detail":"{read_only:false; response_revision:5308; number_of_response:1; }","duration":"205.512608ms","start":"2026-04-10T01:17:19.823557Z","end":"2026-04-10T01:17:20.029069Z","steps":["trace[1288238182] 'process raft request' (duration: 205.23348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:17:20.029499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.485052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:17088"} {"level":"info","ts":"2026-04-10T01:17:20.029575Z","caller":"traceutil/trace.go:171","msg":"trace[461152254] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5309; }","duration":"242.591405ms","start":"2026-04-10T01:17:19.786966Z","end":"2026-04-10T01:17:20.029557Z","steps":["trace[461152254] 'agreement among raft nodes before linearized reading' (duration: 242.146203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:17:20.029771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.063666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" ","response":"range_response_count:12 size:4407"} {"level":"info","ts":"2026-04-10T01:17:20.029823Z","caller":"traceutil/trace.go:171","msg":"trace[1604675358] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:12; response_revision:5309; }","duration":"244.171918ms","start":"2026-04-10T01:17:19.785639Z","end":"2026-04-10T01:17:20.029811Z","steps":["trace[1604675358] 'agreement among raft nodes before linearized reading' (duration: 243.552461ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:17:28.757467Z","caller":"traceutil/trace.go:171","msg":"trace[635340607] linearizableReadLoop","detail":"{readStateIndex:5677; appliedIndex:5676; }","duration":"181.310124ms","start":"2026-04-10T01:17:28.576122Z","end":"2026-04-10T01:17:28.757432Z","steps":["trace[635340607] 'read index received' (duration: 181.087098ms)","trace[635340607] 'applied index is now lower than readState.Index' (duration: 221.206µs)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:17:28.757551Z","caller":"traceutil/trace.go:171","msg":"trace[1145216579] transaction","detail":"{read_only:false; response_revision:5474; number_of_response:1; }","duration":"181.837439ms","start":"2026-04-10T01:17:28.575661Z","end":"2026-04-10T01:17:28.757498Z","steps":["trace[1145216579] 'process raft request' (duration: 181.549311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:17:28.757869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.713025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-10T01:17:28.757998Z","caller":"traceutil/trace.go:171","msg":"trace[1414739695] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5474; }","duration":"181.89918ms","start":"2026-04-10T01:17:28.576071Z","end":"2026-04-10T01:17:28.75797Z","steps":["trace[1414739695] 'agreement among raft nodes before linearized reading' (duration: 181.50408ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:17:28.902962Z","caller":"traceutil/trace.go:171","msg":"trace[1744921631] linearizableReadLoop","detail":"{readStateIndex:5678; appliedIndex:5677; }","duration":"139.5776ms","start":"2026-04-10T01:17:28.763349Z","end":"2026-04-10T01:17:28.902926Z","steps":["trace[1744921631] 'read index received' (duration: 136.964108ms)","trace[1744921631] 'applied index is now lower than readState.Index' (duration: 2.611972ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:17:28.903018Z","caller":"traceutil/trace.go:171","msg":"trace[2027364782] transaction","detail":"{read_only:false; response_revision:5475; number_of_response:1; }","duration":"324.004719ms","start":"2026-04-10T01:17:28.578973Z","end":"2026-04-10T01:17:28.902978Z","steps":["trace[2027364782] 'process raft request' (duration: 321.320995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:17:28.903152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:17:28.578945Z","time spent":"324.142563ms","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:17:28.903297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.900238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:17:28.903456Z","caller":"traceutil/trace.go:171","msg":"trace[818723348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5475; }","duration":"140.091204ms","start":"2026-04-10T01:17:28.763304Z","end":"2026-04-10T01:17:28.903395Z","steps":["trace[818723348] 'agreement among raft nodes before linearized reading' (duration: 139.762764ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:17:28.90786Z","caller":"traceutil/trace.go:171","msg":"trace[409223743] transaction","detail":"{read_only:false; response_revision:5476; number_of_response:1; }","duration":"143.163137ms","start":"2026-04-10T01:17:28.764674Z","end":"2026-04-10T01:17:28.907837Z","steps":["trace[409223743] 'process raft request' (duration: 142.965192ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:18:24.789505Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2967} {"level":"info","ts":"2026-04-10T01:18:24.867366Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2967,"took":"75.888374ms","hash":1801387581,"current-db-size-bytes":58105856,"current-db-size":"58 MB","current-db-size-in-use-bytes":33415168,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-10T01:18:24.867446Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1801387581,"revision":2967,"compact-revision":-1} {"level":"warn","ts":"2026-04-10T01:19:47.000758Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976813094116763803,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-10T01:19:47.083Z","caller":"traceutil/trace.go:171","msg":"trace[420588425] transaction","detail":"{read_only:false; response_revision:6557; number_of_response:1; }","duration":"602.137893ms","start":"2026-04-10T01:19:46.480826Z","end":"2026-04-10T01:19:47.082964Z","steps":["trace[420588425] 'process raft request' (duration: 601.895847ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:19:47.083242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:19:46.480803Z","time spent":"602.308858ms","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:19:47.093065Z","caller":"traceutil/trace.go:171","msg":"trace[755838399] transaction","detail":"{read_only:false; response_revision:6559; number_of_response:1; }","duration":"394.443891ms","start":"2026-04-10T01:19:46.698589Z","end":"2026-04-10T01:19:47.093033Z","steps":["trace[755838399] 'process raft request' (duration: 394.336838ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:19:47.093135Z","caller":"traceutil/trace.go:171","msg":"trace[525272390] transaction","detail":"{read_only:false; response_revision:6558; number_of_response:1; }","duration":"514.097466ms","start":"2026-04-10T01:19:46.578977Z","end":"2026-04-10T01:19:47.093074Z","steps":["trace[525272390] 'process raft request' (duration: 513.764257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:19:47.093272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:19:46.698518Z","time spent":"394.641336ms","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:19:47.09351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:19:46.578933Z","time spent":"514.369523ms","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:19:47.093493Z","caller":"traceutil/trace.go:171","msg":"trace[778838166] transaction","detail":"{read_only:false; response_revision:6560; number_of_response:1; }","duration":"391.366656ms","start":"2026-04-10T01:19:46.702084Z","end":"2026-04-10T01:19:47.09345Z","steps":["trace[778838166] 'process raft request' (duration: 390.891443ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:19:47.093703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:19:46.702046Z","time spent":"391.552861ms","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-10T01:19:47.094085Z","caller":"traceutil/trace.go:171","msg":"trace[480843358] linearizableReadLoop","detail":"{readStateIndex:6799; appliedIndex:6794; }","duration":"593.586269ms","start":"2026-04-10T01:19:46.500482Z","end":"2026-04-10T01:19:47.094069Z","steps":["trace[480843358] 'read index received' (duration: 582.219847ms)","trace[480843358] 'applied index is now lower than readState.Index' (duration: 11.365242ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:19:47.094174Z","caller":"traceutil/trace.go:171","msg":"trace[2041104428] transaction","detail":"{read_only:false; response_revision:6561; number_of_response:1; }","duration":"384.886718ms","start":"2026-04-10T01:19:46.709236Z","end":"2026-04-10T01:19:47.094123Z","steps":["trace[2041104428] 'process raft request' (duration: 384.674282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:19:47.094418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:19:46.709207Z","time spent":"385.061803ms","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:19:47.094416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.930538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-nlsc4\" ","response":"range_response_count:1 size:6531"} {"level":"warn","ts":"2026-04-10T01:19:47.094427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.688517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T01:19:47.094477Z","caller":"traceutil/trace.go:171","msg":"trace[555325975] range","detail":"{range_begin:/registry/pods/openstack/keepalived-nlsc4; range_end:; response_count:1; response_revision:6561; }","duration":"594.043611ms","start":"2026-04-10T01:19:46.500417Z","end":"2026-04-10T01:19:47.09446Z","steps":["trace[555325975] 'agreement among raft nodes before linearized reading' (duration: 593.773564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:19:47.094554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.687831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:19:47.094611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:19:46.500393Z","time spent":"594.201086ms","remote":"127.0.0.1:36120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6555,"request content":"key:\"/registry/pods/openstack/keepalived-nlsc4\" "} {"level":"info","ts":"2026-04-10T01:19:47.094626Z","caller":"traceutil/trace.go:171","msg":"trace[1924929886] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:6561; }","duration":"137.804624ms","start":"2026-04-10T01:19:46.9568Z","end":"2026-04-10T01:19:47.094604Z","steps":["trace[1924929886] 'agreement among raft nodes before linearized reading' (duration: 137.6581ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:19:47.09458Z","caller":"traceutil/trace.go:171","msg":"trace[64704007] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6561; }","duration":"422.803589ms","start":"2026-04-10T01:19:46.671664Z","end":"2026-04-10T01:19:47.094468Z","steps":["trace[64704007] 'agreement among raft nodes before linearized reading' (duration: 422.648015ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:19:47.094736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.965525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-10T01:19:47.094748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:19:46.671634Z","time spent":"423.091307ms","remote":"127.0.0.1:49352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-04-10T01:19:47.094778Z","caller":"traceutil/trace.go:171","msg":"trace[327263085] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6561; }","duration":"332.070969ms","start":"2026-04-10T01:19:46.762698Z","end":"2026-04-10T01:19:47.094769Z","steps":["trace[327263085] 'agreement among raft nodes before linearized reading' (duration: 331.976526ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:19:47.094805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:19:46.762674Z","time spent":"332.125649ms","remote":"127.0.0.1:35912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-10T01:23:24.796783Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6009} {"level":"info","ts":"2026-04-10T01:23:24.890438Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6009,"took":"91.63817ms","hash":2187997293,"current-db-size-bytes":58105856,"current-db-size":"58 MB","current-db-size-in-use-bytes":21827584,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-10T01:23:24.890518Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2187997293,"revision":6009,"compact-revision":2967} {"level":"info","ts":"2026-04-10T01:23:38.237287Z","caller":"traceutil/trace.go:171","msg":"trace[1131322684] transaction","detail":"{read_only:false; response_revision:8321; number_of_response:1; }","duration":"239.12597ms","start":"2026-04-10T01:23:37.998122Z","end":"2026-04-10T01:23:38.237248Z","steps":["trace[1131322684] 'process raft request' (duration: 238.871583ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:23:38.276914Z","caller":"traceutil/trace.go:171","msg":"trace[566007318] transaction","detail":"{read_only:false; response_revision:8323; number_of_response:1; }","duration":"185.44138ms","start":"2026-04-10T01:23:38.091434Z","end":"2026-04-10T01:23:38.276876Z","steps":["trace[566007318] 'process raft request' (duration: 185.312216ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:23:38.277108Z","caller":"traceutil/trace.go:171","msg":"trace[399349041] linearizableReadLoop","detail":"{readStateIndex:8617; appliedIndex:8615; }","duration":"217.107217ms","start":"2026-04-10T01:23:38.059942Z","end":"2026-04-10T01:23:38.277049Z","steps":["trace[399349041] 'read index received' (duration: 177.109511ms)","trace[399349041] 'applied index is now lower than readState.Index' (duration: 39.995356ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:23:38.276916Z","caller":"traceutil/trace.go:171","msg":"trace[418435936] transaction","detail":"{read_only:false; response_revision:8322; number_of_response:1; }","duration":"232.101008ms","start":"2026-04-10T01:23:38.044775Z","end":"2026-04-10T01:23:38.276876Z","steps":["trace[418435936] 'process raft request' (duration: 231.756078ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:23:38.277232Z","caller":"traceutil/trace.go:171","msg":"trace[184207039] transaction","detail":"{read_only:false; response_revision:8324; number_of_response:1; }","duration":"176.949667ms","start":"2026-04-10T01:23:38.100225Z","end":"2026-04-10T01:23:38.277175Z","steps":["trace[184207039] 'process raft request' (duration: 176.583837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:23:38.277342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.375604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.204\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-10T01:23:38.277403Z","caller":"traceutil/trace.go:171","msg":"trace[1855860080] range","detail":"{range_begin:/registry/masterleases/162.253.55.204; range_end:; response_count:1; response_revision:8324; }","duration":"217.505878ms","start":"2026-04-10T01:23:38.059876Z","end":"2026-04-10T01:23:38.277382Z","steps":["trace[1855860080] 'agreement among raft nodes before linearized reading' (duration: 217.270831ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:23:50.851569Z","caller":"traceutil/trace.go:171","msg":"trace[456619857] transaction","detail":"{read_only:false; response_revision:8389; number_of_response:1; }","duration":"106.329453ms","start":"2026-04-10T01:23:50.745189Z","end":"2026-04-10T01:23:50.851518Z","steps":["trace[456619857] 'process raft request' (duration: 105.967453ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:24:19.506636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.547765ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-10T01:24:19.506754Z","caller":"traceutil/trace.go:171","msg":"trace[613654568] linearizableReadLoop","detail":"{readStateIndex:8904; appliedIndex:8903; }","duration":"203.006281ms","start":"2026-04-10T01:24:19.303731Z","end":"2026-04-10T01:24:19.506737Z","steps":["trace[613654568] 'read index received' (duration: 63.841µs)","trace[613654568] 'applied index is now lower than readState.Index' (duration: 202.94103ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:24:19.506862Z","caller":"traceutil/trace.go:171","msg":"trace[1033960857] transaction","detail":"{read_only:false; response_revision:8598; number_of_response:1; }","duration":"467.792834ms","start":"2026-04-10T01:24:19.039052Z","end":"2026-04-10T01:24:19.506844Z","steps":["trace[1033960857] 'process raft request' (duration: 86.945551ms)","trace[1033960857] 'compare' (duration: 380.204465ms)"],"step_count":2} {"level":"warn","ts":"2026-04-10T01:24:19.506939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-10T01:24:19.039027Z","time spent":"467.878336ms","remote":"127.0.0.1:36190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-10T01:24:19.507147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.424323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-10T01:24:19.507184Z","caller":"traceutil/trace.go:171","msg":"trace[1812162844] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:8598; }","duration":"203.463314ms","start":"2026-04-10T01:24:19.303711Z","end":"2026-04-10T01:24:19.507174Z","steps":["trace[1812162844] 'agreement among raft nodes before linearized reading' (duration: 203.350661ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:24:23.865322Z","caller":"traceutil/trace.go:171","msg":"trace[1709038176] transaction","detail":"{read_only:false; response_revision:8618; number_of_response:1; }","duration":"258.81957ms","start":"2026-04-10T01:24:23.606472Z","end":"2026-04-10T01:24:23.865292Z","steps":["trace[1709038176] 'process raft request' (duration: 246.565044ms)","trace[1709038176] 'compare' (duration: 12.02164ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:24:23.865598Z","caller":"traceutil/trace.go:171","msg":"trace[773843026] linearizableReadLoop","detail":"{readStateIndex:8926; appliedIndex:8924; }","duration":"225.026605ms","start":"2026-04-10T01:24:23.640532Z","end":"2026-04-10T01:24:23.865559Z","steps":["trace[773843026] 'read index received' (duration: 212.539082ms)","trace[773843026] 'applied index is now lower than readState.Index' (duration: 12.485483ms)"],"step_count":2} {"level":"info","ts":"2026-04-10T01:24:23.865993Z","caller":"traceutil/trace.go:171","msg":"trace[991106239] transaction","detail":"{read_only:false; response_revision:8619; number_of_response:1; }","duration":"259.208841ms","start":"2026-04-10T01:24:23.606757Z","end":"2026-04-10T01:24:23.865966Z","steps":["trace[991106239] 'process raft request' (duration: 258.495321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-10T01:24:23.866055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.501267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-10T01:24:23.866061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.475237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-10T01:24:23.866119Z","caller":"traceutil/trace.go:171","msg":"trace[2035069639] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8619; }","duration":"225.634122ms","start":"2026-04-10T01:24:23.640469Z","end":"2026-04-10T01:24:23.866103Z","steps":["trace[2035069639] 'agreement among raft nodes before linearized reading' (duration: 225.495258ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:24:23.866178Z","caller":"traceutil/trace.go:171","msg":"trace[549596204] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8619; }","duration":"102.645302ms","start":"2026-04-10T01:24:23.763508Z","end":"2026-04-10T01:24:23.866153Z","steps":["trace[549596204] 'agreement among raft nodes before linearized reading' (duration: 102.460317ms)"],"step_count":1} {"level":"info","ts":"2026-04-10T01:24:48.873084Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023d3.wal"} {"level":"info","ts":"2026-04-10T01:26:16.987931Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a11c20306510c1f7","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-10T01:26:16.994406Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-10T01:26:16.994545Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-10T01:28:24.802781Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8115} {"level":"info","ts":"2026-04-10T01:28:24.868782Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8115,"took":"63.628387ms","hash":2152007349,"current-db-size-bytes":58105856,"current-db-size":"58 MB","current-db-size-in-use-bytes":29179904,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-10T01:28:24.868852Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2152007349,"revision":8115,"compact-revision":6009} {"level":"info","ts":"2026-04-10T01:33:24.812477Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10632} {"level":"info","ts":"2026-04-10T01:33:24.895248Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10632,"took":"78.577677ms","hash":1219808005,"current-db-size-bytes":58105856,"current-db-size":"58 MB","current-db-size-in-use-bytes":21270528,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-10T01:33:24.89531Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1219808005,"revision":10632,"compact-revision":8115}