{"level":"warn","ts":"2026-04-17T00:23:11.98301Z","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-17T00:23:11.983099Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.95:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.95:2380","--initial-cluster=instance=https://199.204.45.95:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.95:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.95: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-17T00:23:11.98317Z","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-17T00:23:11.98318Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-04-17T00:23:11.983208Z","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-17T00:23:11.983963Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"]} {"level":"info","ts":"2026-04-17T00:23:11.984049Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.95: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-17T00:23:11.988794Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.531746ms"} {"level":"info","ts":"2026-04-17T00:23:11.994859Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"be773dfc027af3eb","cluster-id":"9ba5fbd7288fd5af"} {"level":"info","ts":"2026-04-17T00:23:11.994952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=()"} {"level":"info","ts":"2026-04-17T00:23:11.994989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 0"} {"level":"info","ts":"2026-04-17T00:23:11.995004Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft be773dfc027af3eb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-17T00:23:11.995014Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 1"} {"level":"info","ts":"2026-04-17T00:23:11.995086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"warn","ts":"2026-04-17T00:23:11.999962Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-17T00:23:12.001567Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-17T00:23:12.002597Z","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-17T00:23:12.005013Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"be773dfc027af3eb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-17T00:23:12.005174Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"be773dfc027af3eb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-17T00:23:12.005335Z","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-17T00:23:12.005391Z","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-17T00:23:12.005421Z","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-17T00:23:12.005955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"info","ts":"2026-04-17T00:23:12.006118Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","added-peer-id":"be773dfc027af3eb","added-peer-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-04-17T00:23:12.009355Z","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-17T00:23:12.009635Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-04-17T00:23:12.009683Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-04-17T00:23:12.010156Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"be773dfc027af3eb","initial-advertise-peer-urls":["https://199.204.45.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-17T00:23:12.010198Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-17T00:23:12.29633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb is starting a new election at term 1"} {"level":"info","ts":"2026-04-17T00:23:12.296391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became pre-candidate at term 1"} {"level":"info","ts":"2026-04-17T00:23:12.296434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgPreVoteResp from be773dfc027af3eb at term 1"} {"level":"info","ts":"2026-04-17T00:23:12.296455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became candidate at term 2"} {"level":"info","ts":"2026-04-17T00:23:12.296467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgVoteResp from be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-04-17T00:23:12.296483Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became leader at term 2"} {"level":"info","ts":"2026-04-17T00:23:12.296497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: be773dfc027af3eb elected leader be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-04-17T00:23:12.297438Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"be773dfc027af3eb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.95:2379]}","request-path":"/0/members/be773dfc027af3eb/attributes","cluster-id":"9ba5fbd7288fd5af","publish-timeout":"7s"} {"level":"info","ts":"2026-04-17T00:23:12.297545Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T00:23:12.297883Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-17T00:23:12.297918Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-17T00:23:12.297596Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T00:23:12.297642Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:23:12.300335Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.95:2379"} {"level":"info","ts":"2026-04-17T00:23:12.301206Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-17T00:23:12.301558Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:23:12.301632Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T00:23:12.301657Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-17T00:23:18.009717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.701683ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:23:18.009913Z","caller":"traceutil/trace.go:171","msg":"trace[779252238] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"295.370698ms","start":"2026-04-17T00:23:17.714493Z","end":"2026-04-17T00:23:18.009864Z","steps":["trace[779252238] 'process raft request' (duration: 127.875101ms)","trace[779252238] 'compare' (duration: 166.20456ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:23:18.009958Z","caller":"traceutil/trace.go:171","msg":"trace[2076013043] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"293.59719ms","start":"2026-04-17T00:23:17.716339Z","end":"2026-04-17T00:23:18.009936Z","steps":["trace[2076013043] 'process raft request' (duration: 293.512906ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:23:18.010015Z","caller":"traceutil/trace.go:171","msg":"trace[1621201027] linearizableReadLoop","detail":"{readStateIndex:296; appliedIndex:295; }","duration":"293.756436ms","start":"2026-04-17T00:23:17.716217Z","end":"2026-04-17T00:23:18.009974Z","steps":["trace[1621201027] 'read index received' (duration: 126.166025ms)","trace[1621201027] 'applied index is now lower than readState.Index' (duration: 167.588091ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:23:18.01021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.877222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:23:18.010261Z","caller":"traceutil/trace.go:171","msg":"trace[118510282] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:289; }","duration":"293.968475ms","start":"2026-04-17T00:23:17.716279Z","end":"2026-04-17T00:23:18.010247Z","steps":["trace[118510282] 'agreement among raft nodes before linearized reading' (duration: 293.84929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:23:18.010253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.009307ms","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-17T00:23:18.010348Z","caller":"traceutil/trace.go:171","msg":"trace[952344871] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:289; }","duration":"294.134882ms","start":"2026-04-17T00:23:17.716191Z","end":"2026-04-17T00:23:18.010326Z","steps":["trace[952344871] 'agreement among raft nodes before linearized reading' (duration: 293.908813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:23:18.010362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.740895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:23:18.010408Z","caller":"traceutil/trace.go:171","msg":"trace[2020631365] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:289; }","duration":"164.833989ms","start":"2026-04-17T00:23:17.845561Z","end":"2026-04-17T00:23:18.010395Z","steps":["trace[2020631365] 'agreement among raft nodes before linearized reading' (duration: 164.746216ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:23:18.232781Z","caller":"traceutil/trace.go:171","msg":"trace[2135444448] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"217.597409ms","start":"2026-04-17T00:23:18.015156Z","end":"2026-04-17T00:23:18.232753Z","steps":["trace[2135444448] 'process raft request' (duration: 217.169721ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:23:18.277311Z","caller":"traceutil/trace.go:171","msg":"trace[2136623438] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"262.122503ms","start":"2026-04-17T00:23:18.015155Z","end":"2026-04-17T00:23:18.277278Z","steps":["trace[2136623438] 'process raft request' (duration: 261.993198ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:23:18.277341Z","caller":"traceutil/trace.go:171","msg":"trace[262344681] linearizableReadLoop","detail":"{readStateIndex:299; appliedIndex:297; }","duration":"255.64025ms","start":"2026-04-17T00:23:18.021683Z","end":"2026-04-17T00:23:18.277323Z","steps":["trace[262344681] 'read index received' (duration: 210.655816ms)","trace[262344681] 'applied index is now lower than readState.Index' (duration: 44.983554ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:23:18.277409Z","caller":"traceutil/trace.go:171","msg":"trace[205717483] transaction","detail":"{read_only:false; number_of_response:0; response_revision:291; }","duration":"116.919423ms","start":"2026-04-17T00:23:18.160473Z","end":"2026-04-17T00:23:18.277392Z","steps":["trace[205717483] 'process raft request' (duration: 116.751606ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:23:18.277453Z","caller":"traceutil/trace.go:171","msg":"trace[2136748181] transaction","detail":"{read_only:false; number_of_response:0; response_revision:291; }","duration":"115.751373ms","start":"2026-04-17T00:23:18.16169Z","end":"2026-04-17T00:23:18.277441Z","steps":["trace[2136748181] 'process raft request' (duration: 115.614137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:23:18.27768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.977945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T00:23:18.277354Z","caller":"traceutil/trace.go:171","msg":"trace[963161979] transaction","detail":"{read_only:false; number_of_response:0; response_revision:291; }","duration":"115.857458ms","start":"2026-04-17T00:23:18.16148Z","end":"2026-04-17T00:23:18.277338Z","steps":["trace[963161979] 'process raft request' (duration: 115.779094ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:23:18.277754Z","caller":"traceutil/trace.go:171","msg":"trace[16315279] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/expand-controller; range_end:; response_count:0; response_revision:291; }","duration":"256.07657ms","start":"2026-04-17T00:23:18.021662Z","end":"2026-04-17T00:23:18.277739Z","steps":["trace[16315279] 'agreement among raft nodes before linearized reading' (duration: 255.892501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:23:18.277785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.157935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3974"} {"level":"info","ts":"2026-04-17T00:23:18.277848Z","caller":"traceutil/trace.go:171","msg":"trace[1294594341] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:291; }","duration":"117.266149ms","start":"2026-04-17T00:23:18.160567Z","end":"2026-04-17T00:23:18.277833Z","steps":["trace[1294594341] 'agreement among raft nodes before linearized reading' (duration: 117.131832ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:23:36.33708Z","caller":"traceutil/trace.go:171","msg":"trace[499422578] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"122.041996ms","start":"2026-04-17T00:23:36.215023Z","end":"2026-04-17T00:23:36.337065Z","steps":["trace[499422578] 'process raft request' (duration: 121.956073ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:23:36.337121Z","caller":"traceutil/trace.go:171","msg":"trace[153658560] transaction","detail":"{read_only:false; number_of_response:1; response_revision:543; }","duration":"128.208635ms","start":"2026-04-17T00:23:36.208883Z","end":"2026-04-17T00:23:36.337092Z","steps":["trace[153658560] 'process raft request' (duration: 78.032036ms)","trace[153658560] 'compare' (duration: 49.964632ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:23:42.269104Z","caller":"traceutil/trace.go:171","msg":"trace[601111566] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"178.97439ms","start":"2026-04-17T00:23:42.090113Z","end":"2026-04-17T00:23:42.269087Z","steps":["trace[601111566] 'process raft request' (duration: 148.671374ms)","trace[601111566] 'compare' (duration: 30.098428ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:23:42.269363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.719045ms","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-17T00:23:42.269423Z","caller":"traceutil/trace.go:171","msg":"trace[1456866783] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:603; }","duration":"110.812128ms","start":"2026-04-17T00:23:42.158597Z","end":"2026-04-17T00:23:42.269409Z","steps":["trace[1456866783] 'agreement among raft nodes before linearized reading' (duration: 110.663874ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:23:42.269029Z","caller":"traceutil/trace.go:171","msg":"trace[1813461454] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"110.374863ms","start":"2026-04-17T00:23:42.158631Z","end":"2026-04-17T00:23:42.269006Z","steps":["trace[1813461454] 'read index received' (duration: 80.094619ms)","trace[1813461454] 'applied index is now lower than readState.Index' (duration: 30.279344ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:23:42.556649Z","caller":"traceutil/trace.go:171","msg":"trace[497912375] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"282.036111ms","start":"2026-04-17T00:23:42.274589Z","end":"2026-04-17T00:23:42.556625Z","steps":["trace[497912375] 'process raft request' (duration: 281.310057ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:23:42.742136Z","caller":"traceutil/trace.go:171","msg":"trace[986581409] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"467.109502ms","start":"2026-04-17T00:23:42.275001Z","end":"2026-04-17T00:23:42.74211Z","steps":["trace[986581409] 'process raft request' (duration: 450.825302ms)","trace[986581409] 'compare' (duration: 16.004551ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:23:42.742622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:23:42.274991Z","time spent":"467.531686ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:23:42.744705Z","caller":"traceutil/trace.go:171","msg":"trace[1520034017] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"469.820382ms","start":"2026-04-17T00:23:42.274844Z","end":"2026-04-17T00:23:42.744664Z","steps":["trace[1520034017] 'process raft request' (duration: 467.153673ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:23:42.7448Z","caller":"traceutil/trace.go:171","msg":"trace[266095944] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"469.673527ms","start":"2026-04-17T00:23:42.275114Z","end":"2026-04-17T00:23:42.744788Z","steps":["trace[266095944] 'process raft request' (duration: 469.225232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:23:42.744854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:23:42.274787Z","time spent":"469.988577ms","remote":"127.0.0.1:57542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:23:42.744873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:23:42.275098Z","time spent":"469.732289ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T00:23:42.745334Z","caller":"traceutil/trace.go:171","msg":"trace[1917748660] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:624; }","duration":"360.115972ms","start":"2026-04-17T00:23:42.385205Z","end":"2026-04-17T00:23:42.745321Z","steps":["trace[1917748660] 'read index received' (duration: 170.649704ms)","trace[1917748660] 'applied index is now lower than readState.Index' (duration: 189.465398ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:23:42.745527Z","caller":"traceutil/trace.go:171","msg":"trace[844070211] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"468.898383ms","start":"2026-04-17T00:23:42.27662Z","end":"2026-04-17T00:23:42.745518Z","steps":["trace[844070211] 'process raft request' (duration: 468.141117ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:23:42.74575Z","caller":"traceutil/trace.go:171","msg":"trace[1973016941] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"460.702941ms","start":"2026-04-17T00:23:42.284976Z","end":"2026-04-17T00:23:42.745679Z","steps":["trace[1973016941] 'process raft request' (duration: 460.274806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:23:42.745809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:23:42.284961Z","time spent":"460.821734ms","remote":"127.0.0.1:57476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:23:42.746151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.944339ms","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-17T00:23:42.746212Z","caller":"traceutil/trace.go:171","msg":"trace[722724776] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:609; }","duration":"361.044673ms","start":"2026-04-17T00:23:42.385153Z","end":"2026-04-17T00:23:42.746198Z","steps":["trace[722724776] 'agreement among raft nodes before linearized reading' (duration: 360.94337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:23:42.746245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:23:42.385133Z","time spent":"361.105054ms","remote":"127.0.0.1:57542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T00:23:42.745617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:23:42.27661Z","time spent":"468.961924ms","remote":"127.0.0.1:57476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T00:23:42.748603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.802728ms","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-17T00:23:42.748659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.515253ms","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-17T00:23:42.748688Z","caller":"traceutil/trace.go:171","msg":"trace[295452104] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:609; }","duration":"358.959993ms","start":"2026-04-17T00:23:42.38971Z","end":"2026-04-17T00:23:42.74867Z","steps":["trace[295452104] 'agreement among raft nodes before linearized reading' (duration: 358.804968ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:23:42.748702Z","caller":"traceutil/trace.go:171","msg":"trace[1343182332] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:609; }","duration":"259.582305ms","start":"2026-04-17T00:23:42.48911Z","end":"2026-04-17T00:23:42.748692Z","steps":["trace[1343182332] 'agreement among raft nodes before linearized reading' (duration: 259.462721ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:23:42.748723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:23:42.389693Z","time spent":"359.023356ms","remote":"127.0.0.1:57542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-17T00:25:55.467902Z","caller":"traceutil/trace.go:171","msg":"trace[656090628] transaction","detail":"{read_only:false; response_revision:1433; number_of_response:1; }","duration":"130.173039ms","start":"2026-04-17T00:25:55.337677Z","end":"2026-04-17T00:25:55.46785Z","steps":["trace[656090628] 'process raft request' (duration: 129.204186ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:25:55.468048Z","caller":"traceutil/trace.go:171","msg":"trace[1174364294] transaction","detail":"{read_only:false; response_revision:1435; number_of_response:1; }","duration":"110.772782ms","start":"2026-04-17T00:25:55.357257Z","end":"2026-04-17T00:25:55.46803Z","steps":["trace[1174364294] 'process raft request' (duration: 110.581339ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:25:55.468184Z","caller":"traceutil/trace.go:171","msg":"trace[393202332] transaction","detail":"{read_only:false; response_revision:1434; number_of_response:1; }","duration":"126.267467ms","start":"2026-04-17T00:25:55.34171Z","end":"2026-04-17T00:25:55.467977Z","steps":["trace[393202332] 'process raft request' (duration: 126.054284ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:25:55.468445Z","caller":"traceutil/trace.go:171","msg":"trace[1602059733] transaction","detail":"{read_only:false; response_revision:1436; number_of_response:1; }","duration":"109.916222ms","start":"2026-04-17T00:25:55.358508Z","end":"2026-04-17T00:25:55.468424Z","steps":["trace[1602059733] 'process raft request' (duration: 109.419395ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:25:55.468993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.554258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/cert-manager/cert-manager-cainjector-64b59ddb75\" ","response":"range_response_count:1 size:3611"} {"level":"info","ts":"2026-04-17T00:25:55.469072Z","caller":"traceutil/trace.go:171","msg":"trace[1404824632] range","detail":"{range_begin:/registry/replicasets/cert-manager/cert-manager-cainjector-64b59ddb75; range_end:; response_count:1; response_revision:1437; }","duration":"125.658299ms","start":"2026-04-17T00:25:55.343395Z","end":"2026-04-17T00:25:55.469053Z","steps":["trace[1404824632] 'agreement among raft nodes before linearized reading' (duration: 125.405156ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:25:55.468709Z","caller":"traceutil/trace.go:171","msg":"trace[1663692954] linearizableReadLoop","detail":"{readStateIndex:1487; appliedIndex:1485; }","duration":"125.258394ms","start":"2026-04-17T00:25:55.34341Z","end":"2026-04-17T00:25:55.468669Z","steps":["trace[1663692954] 'read index received' (duration: 72.386816ms)","trace[1663692954] 'applied index is now lower than readState.Index' (duration: 52.869038ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:25:55.769692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.874833ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:25:55.77002Z","caller":"traceutil/trace.go:171","msg":"trace[1787094146] linearizableReadLoop","detail":"{readStateIndex:1501; appliedIndex:1498; }","duration":"175.813221ms","start":"2026-04-17T00:25:55.594186Z","end":"2026-04-17T00:25:55.77Z","steps":["trace[1787094146] 'read index received' (duration: 39.679755ms)","trace[1787094146] 'applied index is now lower than readState.Index' (duration: 136.132326ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:25:55.77006Z","caller":"traceutil/trace.go:171","msg":"trace[1311850781] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"266.62527ms","start":"2026-04-17T00:25:55.5034Z","end":"2026-04-17T00:25:55.770025Z","steps":["trace[1311850781] 'process raft request' (duration: 266.385837ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:25:55.770362Z","caller":"traceutil/trace.go:171","msg":"trace[1957185298] transaction","detail":"{read_only:false; response_revision:1448; number_of_response:1; }","duration":"257.918055ms","start":"2026-04-17T00:25:55.512412Z","end":"2026-04-17T00:25:55.77033Z","steps":["trace[1957185298] 'process raft request' (duration: 257.464749ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:25:55.770329Z","caller":"traceutil/trace.go:171","msg":"trace[1308022511] transaction","detail":"{read_only:false; response_revision:1446; number_of_response:1; }","duration":"272.472057ms","start":"2026-04-17T00:25:55.497808Z","end":"2026-04-17T00:25:55.77028Z","steps":["trace[1308022511] 'process raft request' (duration: 135.940505ms)","trace[1308022511] 'compare' (duration: 135.750762ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:25:55.770475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.066324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-webhook\" ","response":"range_response_count:1 size:971"} {"level":"info","ts":"2026-04-17T00:25:55.770575Z","caller":"traceutil/trace.go:171","msg":"trace[1417309917] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager-webhook; range_end:; response_count:1; response_revision:1448; }","duration":"176.160875ms","start":"2026-04-17T00:25:55.594361Z","end":"2026-04-17T00:25:55.770521Z","steps":["trace[1417309917] 'agreement among raft nodes before linearized reading' (duration: 175.952112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:25:55.770453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.253287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-cainjector\" ","response":"range_response_count:1 size:986"} {"level":"info","ts":"2026-04-17T00:25:55.77075Z","caller":"traceutil/trace.go:171","msg":"trace[306962285] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager-cainjector; range_end:; response_count:1; response_revision:1448; }","duration":"176.599111ms","start":"2026-04-17T00:25:55.594129Z","end":"2026-04-17T00:25:55.770728Z","steps":["trace[306962285] 'agreement among raft nodes before linearized reading' (duration: 176.089214ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:25:55.770658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.223566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager\" ","response":"range_response_count:1 size:968"} {"level":"info","ts":"2026-04-17T00:25:55.770867Z","caller":"traceutil/trace.go:171","msg":"trace[895479217] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager; range_end:; response_count:1; response_revision:1448; }","duration":"176.5282ms","start":"2026-04-17T00:25:55.594322Z","end":"2026-04-17T00:25:55.77085Z","steps":["trace[895479217] 'agreement among raft nodes before linearized reading' (duration: 175.986383ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:26:37.868669Z","caller":"traceutil/trace.go:171","msg":"trace[1594635305] transaction","detail":"{read_only:false; response_revision:2236; number_of_response:1; }","duration":"322.241717ms","start":"2026-04-17T00:26:37.546401Z","end":"2026-04-17T00:26:37.868643Z","steps":["trace[1594635305] 'process raft request' (duration: 322.071695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:26:37.868836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T00:26:37.546389Z","time spent":"322.363778ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":967,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T00:26:37.888941Z","caller":"traceutil/trace.go:171","msg":"trace[2147454235] transaction","detail":"{read_only:false; response_revision:2237; number_of_response:1; }","duration":"164.365245ms","start":"2026-04-17T00:26:37.724548Z","end":"2026-04-17T00:26:37.888914Z","steps":["trace[2147454235] 'process raft request' (duration: 164.180883ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:26:40.068083Z","caller":"traceutil/trace.go:171","msg":"trace[115209946] transaction","detail":"{read_only:false; response_revision:2277; number_of_response:1; }","duration":"100.241662ms","start":"2026-04-17T00:26:39.967508Z","end":"2026-04-17T00:26:40.067749Z","steps":["trace[115209946] 'process raft request' (duration: 99.787027ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:26:56.237994Z","caller":"traceutil/trace.go:171","msg":"trace[273303691] linearizableReadLoop","detail":"{readStateIndex:2513; appliedIndex:2512; }","duration":"193.346227ms","start":"2026-04-17T00:26:56.044626Z","end":"2026-04-17T00:26:56.237973Z","steps":["trace[273303691] 'read index received' (duration: 193.227515ms)","trace[273303691] 'applied index is now lower than readState.Index' (duration: 117.832µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:26:56.238136Z","caller":"traceutil/trace.go:171","msg":"trace[1201306385] transaction","detail":"{read_only:false; response_revision:2417; number_of_response:1; }","duration":"196.363903ms","start":"2026-04-17T00:26:56.041759Z","end":"2026-04-17T00:26:56.238123Z","steps":["trace[1201306385] 'process raft request' (duration: 196.090069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:26:56.238299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.588511ms","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-17T00:26:56.238349Z","caller":"traceutil/trace.go:171","msg":"trace[890976418] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2417; }","duration":"193.665331ms","start":"2026-04-17T00:26:56.044669Z","end":"2026-04-17T00:26:56.238335Z","steps":["trace[890976418] 'agreement among raft nodes before linearized reading' (duration: 193.52916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:26:56.238486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.854393ms","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-17T00:26:56.238527Z","caller":"traceutil/trace.go:171","msg":"trace[1262048859] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2417; }","duration":"193.912284ms","start":"2026-04-17T00:26:56.044601Z","end":"2026-04-17T00:26:56.238513Z","steps":["trace[1262048859] 'agreement among raft nodes before linearized reading' (duration: 193.821723ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:27:10.457443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.35522ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:27:10.457724Z","caller":"traceutil/trace.go:171","msg":"trace[541437078] transaction","detail":"{read_only:false; response_revision:2520; number_of_response:1; }","duration":"147.968916ms","start":"2026-04-17T00:27:10.309728Z","end":"2026-04-17T00:27:10.457697Z","steps":["trace[541437078] 'process raft request' (duration: 22.271411ms)","trace[541437078] 'compare' (duration: 125.235539ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:27:10.458151Z","caller":"traceutil/trace.go:171","msg":"trace[618550549] linearizableReadLoop","detail":"{readStateIndex:2619; appliedIndex:2617; }","duration":"141.078389ms","start":"2026-04-17T00:27:10.31706Z","end":"2026-04-17T00:27:10.458139Z","steps":["trace[618550549] 'read index received' (duration: 14.945369ms)","trace[618550549] 'applied index is now lower than readState.Index' (duration: 126.13187ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:27:10.458302Z","caller":"traceutil/trace.go:171","msg":"trace[1893806017] transaction","detail":"{read_only:false; response_revision:2521; number_of_response:1; }","duration":"146.023994ms","start":"2026-04-17T00:27:10.312235Z","end":"2026-04-17T00:27:10.458259Z","steps":["trace[1893806017] 'process raft request' (duration: 145.316646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:27:10.458619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.532944ms","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-17T00:27:10.458739Z","caller":"traceutil/trace.go:171","msg":"trace[515191000] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2521; }","duration":"141.687535ms","start":"2026-04-17T00:27:10.317026Z","end":"2026-04-17T00:27:10.458714Z","steps":["trace[515191000] 'agreement among raft nodes before linearized reading' (duration: 141.390852ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:27:11.421368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.424369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a6fd50b83b8dfb\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-04-17T00:27:11.421452Z","caller":"traceutil/trace.go:171","msg":"trace[1048844637] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18a6fd50b83b8dfb; range_end:; response_count:1; response_revision:2526; }","duration":"108.543701ms","start":"2026-04-17T00:27:11.312888Z","end":"2026-04-17T00:27:11.421432Z","steps":["trace[1048844637] 'range keys from in-memory index tree' (duration: 108.271818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:27:11.921728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.185839ms","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-17T00:27:11.921803Z","caller":"traceutil/trace.go:171","msg":"trace[672765412] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2530; }","duration":"175.32767ms","start":"2026-04-17T00:27:11.746457Z","end":"2026-04-17T00:27:11.921785Z","steps":["trace[672765412] 'range keys from in-memory index tree' (duration: 175.000577ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:27:12.348543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.925017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-17T00:27:12.348588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.733909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11985"} {"level":"info","ts":"2026-04-17T00:27:12.348663Z","caller":"traceutil/trace.go:171","msg":"trace[457972296] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2531; }","duration":"163.860961ms","start":"2026-04-17T00:27:12.184785Z","end":"2026-04-17T00:27:12.348646Z","steps":["trace[457972296] 'range keys from in-memory index tree' (duration: 163.536357ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:27:12.348663Z","caller":"traceutil/trace.go:171","msg":"trace[61486207] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2531; }","duration":"161.08661ms","start":"2026-04-17T00:27:12.187553Z","end":"2026-04-17T00:27:12.34864Z","steps":["trace[61486207] 'range keys from in-memory index tree' (duration: 160.848977ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:29:00.996429Z","caller":"traceutil/trace.go:171","msg":"trace[1398970698] linearizableReadLoop","detail":"{readStateIndex:3292; appliedIndex:3291; }","duration":"114.235309ms","start":"2026-04-17T00:29:00.882174Z","end":"2026-04-17T00:29:00.99641Z","steps":["trace[1398970698] 'read index received' (duration: 114.088896ms)","trace[1398970698] 'applied index is now lower than readState.Index' (duration: 145.803µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T00:29:00.99657Z","caller":"traceutil/trace.go:171","msg":"trace[54015737] transaction","detail":"{read_only:false; response_revision:3170; number_of_response:1; }","duration":"183.009782ms","start":"2026-04-17T00:29:00.813531Z","end":"2026-04-17T00:29:00.996541Z","steps":["trace[54015737] 'process raft request' (duration: 182.776957ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:29:00.996625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.98988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-17T00:29:00.996652Z","caller":"traceutil/trace.go:171","msg":"trace[977679859] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3170; }","duration":"113.049271ms","start":"2026-04-17T00:29:00.883594Z","end":"2026-04-17T00:29:00.996643Z","steps":["trace[977679859] 'agreement among raft nodes before linearized reading' (duration: 112.927468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T00:29:00.996688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.493696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-17T00:29:00.996759Z","caller":"traceutil/trace.go:171","msg":"trace[350992794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3170; }","duration":"114.611758ms","start":"2026-04-17T00:29:00.88213Z","end":"2026-04-17T00:29:00.996742Z","steps":["trace[350992794] 'agreement among raft nodes before linearized reading' (duration: 114.390203ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:33:12.414718Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2865} {"level":"info","ts":"2026-04-17T00:33:12.485356Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2865,"took":"69.388918ms","hash":2455349683,"current-db-size-bytes":47013888,"current-db-size":"47 MB","current-db-size-in-use-bytes":24084480,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-17T00:33:12.485425Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2455349683,"revision":2865,"compact-revision":-1} {"level":"warn","ts":"2026-04-17T00:33:24.059056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.059471ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T00:33:24.059434Z","caller":"traceutil/trace.go:171","msg":"trace[218790080] linearizableReadLoop","detail":"{readStateIndex:5842; appliedIndex:5841; }","duration":"203.367877ms","start":"2026-04-17T00:33:23.856034Z","end":"2026-04-17T00:33:24.059402Z","steps":["trace[218790080] 'read index received' (duration: 27.801798ms)","trace[218790080] 'applied index is now lower than readState.Index' (duration: 175.562749ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T00:33:24.059671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.640021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-04-17T00:33:24.059725Z","caller":"traceutil/trace.go:171","msg":"trace[2028720160] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5635; }","duration":"203.720752ms","start":"2026-04-17T00:33:23.855982Z","end":"2026-04-17T00:33:24.059702Z","steps":["trace[2028720160] 'agreement among raft nodes before linearized reading' (duration: 203.594021ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T00:33:24.059717Z","caller":"traceutil/trace.go:171","msg":"trace[551706505] transaction","detail":"{read_only:false; response_revision:5634; number_of_response:1; }","duration":"267.673292ms","start":"2026-04-17T00:33:23.791952Z","end":"2026-04-17T00:33:24.059625Z","steps":["trace[551706505] 'process raft request' (duration: 91.959761ms)","trace[551706505] 'compare' (duration: 174.930149ms)"],"step_count":2}