{"level":"warn","ts":"2026-04-07T01:24:20.7007Z","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-07T01:24:20.700801Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.235: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.235:2380","--initial-cluster=instance=https://199.204.45.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.235: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-07T01:24:20.700879Z","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-07T01:24:20.700894Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-04-07T01:24:20.700922Z","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-07T01:24:20.70168Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"]} {"level":"info","ts":"2026-04-07T01:24:20.701765Z","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://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.235: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-07T01:24:20.706226Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.179718ms"} {"level":"info","ts":"2026-04-07T01:24:20.719797Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"} {"level":"info","ts":"2026-04-07T01:24:20.719937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T01:24:20.719963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"} {"level":"info","ts":"2026-04-07T01:24:20.719985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft aab6040abcf11 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T01:24:20.720006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"} {"level":"info","ts":"2026-04-07T01:24:20.720082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"warn","ts":"2026-04-07T01:24:20.725466Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T01:24:20.727607Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T01:24:20.730683Z","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-07T01:24:20.732699Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"aab6040abcf11","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T01:24:20.733041Z","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-07T01:24:20.733047Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"aab6040abcf11","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T01:24:20.733173Z","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-07T01:24:20.73322Z","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-07T01:24:20.734905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"info","ts":"2026-04-07T01:24:20.735175Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","added-peer-id":"aab6040abcf11","added-peer-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-04-07T01:24:20.738257Z","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-07T01:24:20.738442Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-04-07T01:24:20.738492Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-04-07T01:24:20.738722Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"aab6040abcf11","initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T01:24:20.738776Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T01:24:21.021157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T01:24:21.021258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T01:24:21.021285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"} {"level":"info","ts":"2026-04-07T01:24:21.021312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"} {"level":"info","ts":"2026-04-07T01:24:21.021322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"} {"level":"info","ts":"2026-04-07T01:24:21.021338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"} {"level":"info","ts":"2026-04-07T01:24:21.021353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"} {"level":"info","ts":"2026-04-07T01:24:21.023179Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:24:21.023945Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"aab6040abcf11","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.235:2379]}","request-path":"/0/members/aab6040abcf11/attributes","cluster-id":"2bae7d3d8857c059","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T01:24:21.023999Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:24:21.02421Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:24:21.024472Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:24:21.024652Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:24:21.024668Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T01:24:21.024699Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T01:24:21.024704Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:24:21.027005Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T01:24:21.028117Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"} {"level":"warn","ts":"2026-04-07T01:24:41.318633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.979987ms","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-07T01:24:41.318737Z","caller":"traceutil/trace.go:171","msg":"trace[1686024967] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:450; }","duration":"150.1422ms","start":"2026-04-07T01:24:41.168579Z","end":"2026-04-07T01:24:41.318721Z","steps":["trace[1686024967] 'range keys from in-memory index tree' (duration: 149.845924ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:46.610205Z","caller":"traceutil/trace.go:171","msg":"trace[696645415] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"118.673782ms","start":"2026-04-07T01:24:46.491502Z","end":"2026-04-07T01:24:46.610176Z","steps":["trace[696645415] 'process raft request' (duration: 118.522979ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:57.555645Z","caller":"traceutil/trace.go:171","msg":"trace[421146358] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"153.650865ms","start":"2026-04-07T01:24:57.401951Z","end":"2026-04-07T01:24:57.555602Z","steps":["trace[421146358] 'read index received' (duration: 152.434493ms)","trace[421146358] 'applied index is now lower than readState.Index' (duration: 1.215012ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:24:57.555733Z","caller":"traceutil/trace.go:171","msg":"trace[283638290] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"277.046095ms","start":"2026-04-07T01:24:57.278632Z","end":"2026-04-07T01:24:57.555678Z","steps":["trace[283638290] 'process raft request' (duration: 276.093987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:57.556053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.035022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-07T01:24:57.556149Z","caller":"traceutil/trace.go:171","msg":"trace[1466615968] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:616; }","duration":"154.235466ms","start":"2026-04-07T01:24:57.401892Z","end":"2026-04-07T01:24:57.556127Z","steps":["trace[1466615968] 'agreement among raft nodes before linearized reading' (duration: 153.867229ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:58.006152Z","caller":"traceutil/trace.go:171","msg":"trace[1668563560] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"291.299121ms","start":"2026-04-07T01:24:57.714821Z","end":"2026-04-07T01:24:58.00612Z","steps":["trace[1668563560] 'read index received' (duration: 291.202149ms)","trace[1668563560] 'applied index is now lower than readState.Index' (duration: 95.702µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:24:58.006476Z","caller":"traceutil/trace.go:171","msg":"trace[673853343] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"389.434578ms","start":"2026-04-07T01:24:57.616852Z","end":"2026-04-07T01:24:58.006287Z","steps":["trace[673853343] 'process raft request' (duration: 389.111792ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:58.006531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.69416ms","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-07T01:24:58.006789Z","caller":"traceutil/trace.go:171","msg":"trace[461569552] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:618; }","duration":"291.820302ms","start":"2026-04-07T01:24:57.714749Z","end":"2026-04-07T01:24:58.006569Z","steps":["trace[461569552] 'agreement among raft nodes before linearized reading' (duration: 291.529496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:58.007183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:24:57.616829Z","time spent":"389.728044ms","remote":"127.0.0.1:40338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T01:26:26.368394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.109049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:26:26.368416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.986956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-07T01:26:26.368493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.679727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:26.368516Z","caller":"traceutil/trace.go:171","msg":"trace[1627243059] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1837; }","duration":"184.159568ms","start":"2026-04-07T01:26:26.184348Z","end":"2026-04-07T01:26:26.368508Z","steps":["trace[1627243059] 'count revisions from in-memory index tree' (duration: 183.857924ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:26.368568Z","caller":"traceutil/trace.go:171","msg":"trace[1235691442] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1837; }","duration":"147.282862ms","start":"2026-04-07T01:26:26.221195Z","end":"2026-04-07T01:26:26.368478Z","steps":["trace[1235691442] 'range keys from in-memory index tree' (duration: 147.021038ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:26:26.368499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.444158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:26:26.368666Z","caller":"traceutil/trace.go:171","msg":"trace[581028752] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1837; }","duration":"200.690233ms","start":"2026-04-07T01:26:26.16795Z","end":"2026-04-07T01:26:26.36864Z","steps":["trace[581028752] 'count revisions from in-memory index tree' (duration: 200.317466ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:26.368589Z","caller":"traceutil/trace.go:171","msg":"trace[2099051957] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1837; }","duration":"148.84194ms","start":"2026-04-07T01:26:26.219727Z","end":"2026-04-07T01:26:26.368569Z","steps":["trace[2099051957] 'count revisions from in-memory index tree' (duration: 148.572056ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:26.824986Z","caller":"traceutil/trace.go:171","msg":"trace[623379394] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"155.690937ms","start":"2026-04-07T01:26:26.66926Z","end":"2026-04-07T01:26:26.824951Z","steps":["trace[623379394] 'process raft request' (duration: 155.364771ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:11.575854Z","caller":"traceutil/trace.go:171","msg":"trace[746265137] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"104.161542ms","start":"2026-04-07T01:27:11.471638Z","end":"2026-04-07T01:27:11.575799Z","steps":["trace[746265137] 'process raft request' (duration: 103.903648ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:12.117439Z","caller":"traceutil/trace.go:171","msg":"trace[1997854875] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"117.637361ms","start":"2026-04-07T01:27:11.999774Z","end":"2026-04-07T01:27:12.117411Z","steps":["trace[1997854875] 'process raft request' (duration: 115.373319ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:17.36911Z","caller":"traceutil/trace.go:171","msg":"trace[1205147595] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"100.148129ms","start":"2026-04-07T01:27:17.268935Z","end":"2026-04-07T01:27:17.369084Z","steps":["trace[1205147595] 'process raft request' (duration: 100.020847ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:31:15.719647Z","caller":"traceutil/trace.go:171","msg":"trace[1051054769] transaction","detail":"{read_only:false; response_revision:3670; number_of_response:1; }","duration":"111.173046ms","start":"2026-04-07T01:31:15.608443Z","end":"2026-04-07T01:31:15.719616Z","steps":["trace[1051054769] 'process raft request' (duration: 110.994323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:31:15.91106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.723618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:31:15.911199Z","caller":"traceutil/trace.go:171","msg":"trace[1119622137] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:3670; }","duration":"119.941632ms","start":"2026-04-07T01:31:15.791223Z","end":"2026-04-07T01:31:15.911165Z","steps":["trace[1119622137] 'count revisions from in-memory index tree' (duration: 119.523184ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:39.636941Z","caller":"traceutil/trace.go:171","msg":"trace[2070736600] transaction","detail":"{read_only:false; response_revision:4818; number_of_response:1; }","duration":"112.447719ms","start":"2026-04-07T01:32:39.524465Z","end":"2026-04-07T01:32:39.636913Z","steps":["trace[2070736600] 'process raft request' (duration: 112.279426ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:32:39.957437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.109389ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:26"} {"level":"warn","ts":"2026-04-07T01:32:51.101206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.989943ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:32:51.101564Z","caller":"traceutil/trace.go:171","msg":"trace[1893027591] transaction","detail":"{read_only:false; response_revision:5039; number_of_response:1; }","duration":"177.451954ms","start":"2026-04-07T01:32:50.924083Z","end":"2026-04-07T01:32:51.101535Z","steps":["trace[1893027591] 'process raft request' (duration: 177.30944ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:51.10167Z","caller":"traceutil/trace.go:171","msg":"trace[1174684748] transaction","detail":"{read_only:false; response_revision:5038; number_of_response:1; }","duration":"220.1022ms","start":"2026-04-07T01:32:50.881522Z","end":"2026-04-07T01:32:51.101624Z","steps":["trace[1174684748] 'process raft request' (duration: 33.582307ms)","trace[1174684748] 'compare' (duration: 185.610276ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:32:51.457409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.031071ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:32:51.457871Z","caller":"traceutil/trace.go:171","msg":"trace[1086000006] transaction","detail":"{read_only:false; response_revision:5042; number_of_response:1; }","duration":"350.118006ms","start":"2026-04-07T01:32:51.107726Z","end":"2026-04-07T01:32:51.457844Z","steps":["trace[1086000006] 'process raft request' (duration: 349.839721ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:51.457905Z","caller":"traceutil/trace.go:171","msg":"trace[1092090949] linearizableReadLoop","detail":"{readStateIndex:5230; appliedIndex:5227; }","duration":"236.75322ms","start":"2026-04-07T01:32:51.221133Z","end":"2026-04-07T01:32:51.457886Z","steps":["trace[1092090949] 'read index received' (duration: 4.030365ms)","trace[1092090949] 'applied index is now lower than readState.Index' (duration: 232.721765ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:32:51.457897Z","caller":"traceutil/trace.go:171","msg":"trace[1267762299] transaction","detail":"{read_only:false; response_revision:5040; number_of_response:1; }","duration":"354.720072ms","start":"2026-04-07T01:32:51.103114Z","end":"2026-04-07T01:32:51.457834Z","steps":["trace[1267762299] 'process raft request' (duration: 121.989747ms)","trace[1267762299] 'compare' (duration: 231.733986ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:32:51.457979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:32:51.107704Z","time spent":"350.229159ms","remote":"127.0.0.1:39972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":524,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:32:51.457969Z","caller":"traceutil/trace.go:171","msg":"trace[1505271386] transaction","detail":"{read_only:false; response_revision:5041; number_of_response:1; }","duration":"350.248739ms","start":"2026-04-07T01:32:51.107683Z","end":"2026-04-07T01:32:51.457932Z","steps":["trace[1505271386] 'process raft request' (duration: 349.829911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:32:51.458073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.479096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:32:51.458117Z","caller":"traceutil/trace.go:171","msg":"trace[411116075] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:5043; }","duration":"205.563728ms","start":"2026-04-07T01:32:51.252542Z","end":"2026-04-07T01:32:51.458106Z","steps":["trace[411116075] 'agreement among raft nodes before linearized reading' (duration: 205.498507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:32:51.458129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:32:51.107658Z","time spent":"350.404141ms","remote":"127.0.0.1:40088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1005,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T01:32:51.458154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:32:51.103081Z","time spent":"354.936646ms","remote":"127.0.0.1:40076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:32:51.458016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.886442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:32:51.458225Z","caller":"traceutil/trace.go:171","msg":"trace[515301574] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5043; }","duration":"237.140767ms","start":"2026-04-07T01:32:51.221073Z","end":"2026-04-07T01:32:51.458213Z","steps":["trace[515301574] 'agreement among raft nodes before linearized reading' (duration: 236.911953ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:51.460037Z","caller":"traceutil/trace.go:171","msg":"trace[97115100] transaction","detail":"{read_only:false; response_revision:5043; number_of_response:1; }","duration":"217.581123ms","start":"2026-04-07T01:32:51.240077Z","end":"2026-04-07T01:32:51.457658Z","steps":["trace[97115100] 'process raft request' (duration: 217.530222ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:51.7314Z","caller":"traceutil/trace.go:171","msg":"trace[397671952] transaction","detail":"{read_only:false; response_revision:5046; number_of_response:1; }","duration":"105.604141ms","start":"2026-04-07T01:32:51.625764Z","end":"2026-04-07T01:32:51.731368Z","steps":["trace[397671952] 'process raft request' (duration: 105.377257ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:51.872898Z","caller":"traceutil/trace.go:171","msg":"trace[970205237] transaction","detail":"{read_only:false; response_revision:5048; number_of_response:1; }","duration":"133.663135ms","start":"2026-04-07T01:32:51.739197Z","end":"2026-04-07T01:32:51.872861Z","steps":["trace[970205237] 'process raft request' (duration: 104.334927ms)","trace[970205237] 'compare' (duration: 29.114134ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:32:51.873217Z","caller":"traceutil/trace.go:171","msg":"trace[899107870] transaction","detail":"{read_only:false; response_revision:5049; number_of_response:1; }","duration":"133.90027ms","start":"2026-04-07T01:32:51.739286Z","end":"2026-04-07T01:32:51.873186Z","steps":["trace[899107870] 'process raft request' (duration: 133.515363ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:51.873436Z","caller":"traceutil/trace.go:171","msg":"trace[2085969433] transaction","detail":"{read_only:false; response_revision:5050; number_of_response:1; }","duration":"133.954291ms","start":"2026-04-07T01:32:51.7394Z","end":"2026-04-07T01:32:51.873354Z","steps":["trace[2085969433] 'process raft request' (duration: 133.673636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:32:52.235502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.081988ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:32:52.235687Z","caller":"traceutil/trace.go:171","msg":"trace[843135121] transaction","detail":"{read_only:false; response_revision:5052; number_of_response:1; }","duration":"205.442055ms","start":"2026-04-07T01:32:52.030169Z","end":"2026-04-07T01:32:52.235611Z","steps":["trace[843135121] 'process raft request' (duration: 97.176364ms)","trace[843135121] 'compare' (duration: 107.948335ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:32:58.885372Z","caller":"traceutil/trace.go:171","msg":"trace[972894423] transaction","detail":"{read_only:false; response_revision:5209; number_of_response:1; }","duration":"115.927934ms","start":"2026-04-07T01:32:58.769409Z","end":"2026-04-07T01:32:58.885337Z","steps":["trace[972894423] 'process raft request' (duration: 115.68684ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:59.241371Z","caller":"traceutil/trace.go:171","msg":"trace[191858400] transaction","detail":"{read_only:false; response_revision:5210; number_of_response:1; }","duration":"343.915092ms","start":"2026-04-07T01:32:58.897426Z","end":"2026-04-07T01:32:59.241341Z","steps":["trace[191858400] 'process raft request' (duration: 305.677868ms)","trace[191858400] 'compare' (duration: 38.122502ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:32:59.24152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:32:58.897395Z","time spent":"344.050784ms","remote":"127.0.0.1:39990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4986,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:32:59.276701Z","caller":"traceutil/trace.go:171","msg":"trace[1972549912] transaction","detail":"{read_only:false; response_revision:5211; number_of_response:1; }","duration":"312.442933ms","start":"2026-04-07T01:32:58.964232Z","end":"2026-04-07T01:32:59.276675Z","steps":["trace[1972549912] 'process raft request' (duration: 312.27838ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:32:59.276852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:32:58.96421Z","time spent":"312.562025ms","remote":"127.0.0.1:40076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:32:59.276929Z","caller":"traceutil/trace.go:171","msg":"trace[833619839] transaction","detail":"{read_only:false; response_revision:5212; number_of_response:1; }","duration":"152.685991ms","start":"2026-04-07T01:32:59.124215Z","end":"2026-04-07T01:32:59.276901Z","steps":["trace[833619839] 'process raft request' (duration: 152.416625ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:34:21.295384Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2878} {"level":"info","ts":"2026-04-07T01:34:21.366461Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2878,"took":"68.966388ms","hash":3152185722,"current-db-size-bytes":58093568,"current-db-size":"58 MB","current-db-size-in-use-bytes":32960512,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-07T01:34:21.366524Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3152185722,"revision":2878,"compact-revision":-1} {"level":"warn","ts":"2026-04-07T01:39:01.868739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.4825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-07T01:39:01.868833Z","caller":"traceutil/trace.go:171","msg":"trace[1586912471] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8030; }","duration":"237.622173ms","start":"2026-04-07T01:39:01.631188Z","end":"2026-04-07T01:39:01.868811Z","steps":["trace[1586912471] 'range keys from in-memory index tree' (duration: 237.320606ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:02.026035Z","caller":"traceutil/trace.go:171","msg":"trace[59035015] transaction","detail":"{read_only:false; response_revision:8031; number_of_response:1; }","duration":"152.30194ms","start":"2026-04-07T01:39:01.873671Z","end":"2026-04-07T01:39:02.025973Z","steps":["trace[59035015] 'process raft request' (duration: 151.974795ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:12.684878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.346387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-07T01:39:12.684976Z","caller":"traceutil/trace.go:171","msg":"trace[2110900457] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8089; }","duration":"301.47364ms","start":"2026-04-07T01:39:12.383474Z","end":"2026-04-07T01:39:12.684948Z","steps":["trace[2110900457] 'range keys from in-memory index tree' (duration: 301.193544ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:12.685034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:12.383455Z","time spent":"301.569201ms","remote":"127.0.0.1:40076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-07T01:39:12.685143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.682717ms","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-07T01:39:12.685267Z","caller":"traceutil/trace.go:171","msg":"trace[1351029693] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8089; }","duration":"292.842169ms","start":"2026-04-07T01:39:12.392397Z","end":"2026-04-07T01:39:12.685239Z","steps":["trace[1351029693] 'range keys from in-memory index tree' (duration: 292.261559ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:13.715964Z","caller":"traceutil/trace.go:171","msg":"trace[629527034] transaction","detail":"{read_only:false; response_revision:8094; number_of_response:1; }","duration":"116.55591ms","start":"2026-04-07T01:39:13.599376Z","end":"2026-04-07T01:39:13.715931Z","steps":["trace[629527034] 'process raft request' (duration: 116.376786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:14.979278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.40808ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:39:14.979529Z","caller":"traceutil/trace.go:171","msg":"trace[455473484] transaction","detail":"{read_only:false; response_revision:8103; number_of_response:1; }","duration":"111.951853ms","start":"2026-04-07T01:39:14.867556Z","end":"2026-04-07T01:39:14.979508Z","steps":["trace[455473484] 'process raft request' (duration: 111.889102ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:14.979805Z","caller":"traceutil/trace.go:171","msg":"trace[22517817] transaction","detail":"{read_only:false; response_revision:8102; number_of_response:1; }","duration":"273.817474ms","start":"2026-04-07T01:39:14.705954Z","end":"2026-04-07T01:39:14.979772Z","steps":["trace[22517817] 'process raft request' (duration: 152.825623ms)","trace[22517817] 'compare' (duration: 120.289138ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:39:14.979938Z","caller":"traceutil/trace.go:171","msg":"trace[191161069] linearizableReadLoop","detail":"{readStateIndex:8384; appliedIndex:8383; }","duration":"263.427541ms","start":"2026-04-07T01:39:14.716245Z","end":"2026-04-07T01:39:14.979672Z","steps":["trace[191161069] 'read index received' (duration: 142.541942ms)","trace[191161069] 'applied index is now lower than readState.Index' (duration: 120.882269ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:39:14.980147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.766578ms","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-07T01:39:14.980195Z","caller":"traceutil/trace.go:171","msg":"trace[1259904797] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8103; }","duration":"263.87249ms","start":"2026-04-07T01:39:14.716308Z","end":"2026-04-07T01:39:14.980181Z","steps":["trace[1259904797] 'agreement among raft nodes before linearized reading' (duration: 263.735147ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:14.980247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.980142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-07T01:39:14.980345Z","caller":"traceutil/trace.go:171","msg":"trace[537365267] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8103; }","duration":"264.117835ms","start":"2026-04-07T01:39:14.716201Z","end":"2026-04-07T01:39:14.980319Z","steps":["trace[537365267] 'agreement among raft nodes before linearized reading' (duration: 263.817578ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:15.14959Z","caller":"traceutil/trace.go:171","msg":"trace[113777772] linearizableReadLoop","detail":"{readStateIndex:8387; appliedIndex:8386; }","duration":"149.952961ms","start":"2026-04-07T01:39:14.999612Z","end":"2026-04-07T01:39:15.149565Z","steps":["trace[113777772] 'read index received' (duration: 149.726826ms)","trace[113777772] 'applied index is now lower than readState.Index' (duration: 225.255µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:39:15.149678Z","caller":"traceutil/trace.go:171","msg":"trace[91526754] transaction","detail":"{read_only:false; response_revision:8105; number_of_response:1; }","duration":"163.810048ms","start":"2026-04-07T01:39:14.985834Z","end":"2026-04-07T01:39:15.149644Z","steps":["trace[91526754] 'process raft request' (duration: 163.586563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:15.149765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.127474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:39:15.149812Z","caller":"traceutil/trace.go:171","msg":"trace[662813919] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:8105; }","duration":"150.231076ms","start":"2026-04-07T01:39:14.999569Z","end":"2026-04-07T01:39:15.1498Z","steps":["trace[662813919] 'agreement among raft nodes before linearized reading' (duration: 150.126964ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:21.301158Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5965} {"level":"info","ts":"2026-04-07T01:39:21.380014Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5965,"took":"76.749107ms","hash":3484168294,"current-db-size-bytes":58093568,"current-db-size":"58 MB","current-db-size-in-use-bytes":25886720,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-07T01:39:21.380079Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3484168294,"revision":5965,"compact-revision":2878} {"level":"info","ts":"2026-04-07T01:39:42.652796Z","caller":"traceutil/trace.go:171","msg":"trace[172721466] linearizableReadLoop","detail":"{readStateIndex:8591; appliedIndex:8590; }","duration":"179.259935ms","start":"2026-04-07T01:39:42.47351Z","end":"2026-04-07T01:39:42.65277Z","steps":["trace[172721466] 'read index received' (duration: 179.041921ms)","trace[172721466] 'applied index is now lower than readState.Index' (duration: 216.934µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:39:42.65294Z","caller":"traceutil/trace.go:171","msg":"trace[1861548091] transaction","detail":"{read_only:false; response_revision:8302; number_of_response:1; }","duration":"250.072573ms","start":"2026-04-07T01:39:42.402852Z","end":"2026-04-07T01:39:42.652925Z","steps":["trace[1861548091] 'process raft request' (duration: 249.769448ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:42.65324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.717063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T01:39:42.653284Z","caller":"traceutil/trace.go:171","msg":"trace[681223382] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8302; }","duration":"179.827855ms","start":"2026-04-07T01:39:42.473445Z","end":"2026-04-07T01:39:42.653273Z","steps":["trace[681223382] 'agreement among raft nodes before linearized reading' (duration: 179.707623ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:42.853126Z","caller":"traceutil/trace.go:171","msg":"trace[128643348] transaction","detail":"{read_only:false; response_revision:8303; number_of_response:1; }","duration":"195.959766ms","start":"2026-04-07T01:39:42.657145Z","end":"2026-04-07T01:39:42.853104Z","steps":["trace[128643348] 'process raft request' (duration: 195.845964ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:42.854827Z","caller":"traceutil/trace.go:171","msg":"trace[554590234] transaction","detail":"{read_only:false; response_revision:8304; number_of_response:1; }","duration":"197.413403ms","start":"2026-04-07T01:39:42.657372Z","end":"2026-04-07T01:39:42.854786Z","steps":["trace[554590234] 'process raft request' (duration: 197.079347ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:55.18341Z","caller":"traceutil/trace.go:171","msg":"trace[1720930113] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8412; }","duration":"101.541488ms","start":"2026-04-07T01:39:55.081826Z","end":"2026-04-07T01:39:55.183368Z","steps":["trace[1720930113] 'process raft request' (duration: 90.096096ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:56.239247Z","caller":"traceutil/trace.go:171","msg":"trace[2110089333] transaction","detail":"{read_only:false; response_revision:8419; number_of_response:1; }","duration":"234.856509ms","start":"2026-04-07T01:39:56.00434Z","end":"2026-04-07T01:39:56.239197Z","steps":["trace[2110089333] 'process raft request' (duration: 234.697376ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:56.415665Z","caller":"traceutil/trace.go:171","msg":"trace[10630211] linearizableReadLoop","detail":"{readStateIndex:8714; appliedIndex:8712; }","duration":"220.780578ms","start":"2026-04-07T01:39:56.194856Z","end":"2026-04-07T01:39:56.415637Z","steps":["trace[10630211] 'read index received' (duration: 44.236483ms)","trace[10630211] 'applied index is now lower than readState.Index' (duration: 176.542365ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:39:56.415738Z","caller":"traceutil/trace.go:171","msg":"trace[873101635] transaction","detail":"{read_only:false; response_revision:8420; number_of_response:1; }","duration":"351.860208ms","start":"2026-04-07T01:39:56.06384Z","end":"2026-04-07T01:39:56.4157Z","steps":["trace[873101635] 'process raft request' (duration: 307.021403ms)","trace[873101635] 'compare' (duration: 44.664421ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:39:56.415836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.959032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:39:56.415869Z","caller":"traceutil/trace.go:171","msg":"trace[47395710] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:8420; }","duration":"221.030883ms","start":"2026-04-07T01:39:56.19483Z","end":"2026-04-07T01:39:56.415861Z","steps":["trace[47395710] 'agreement among raft nodes before linearized reading' (duration: 220.957741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:56.415901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:56.063813Z","time spent":"351.98946ms","remote":"127.0.0.1:40042","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3037,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:39:56.632344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.810494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:39:56.63245Z","caller":"traceutil/trace.go:171","msg":"trace[118461371] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8422; }","duration":"115.956468ms","start":"2026-04-07T01:39:56.51646Z","end":"2026-04-07T01:39:56.632416Z","steps":["trace[118461371] 'range keys from in-memory index tree' (duration: 115.728663ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:57.569901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.104283ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:39:57.570088Z","caller":"traceutil/trace.go:171","msg":"trace[1215789553] linearizableReadLoop","detail":"{readStateIndex:8723; appliedIndex:8722; }","duration":"304.994105ms","start":"2026-04-07T01:39:57.265027Z","end":"2026-04-07T01:39:57.570022Z","steps":["trace[1215789553] 'read index received' (duration: 68.587976ms)","trace[1215789553] 'applied index is now lower than readState.Index' (duration: 236.404429ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:39:57.570104Z","caller":"traceutil/trace.go:171","msg":"trace[481616562] transaction","detail":"{read_only:false; response_revision:8429; number_of_response:1; }","duration":"344.681523ms","start":"2026-04-07T01:39:57.225386Z","end":"2026-04-07T01:39:57.570068Z","steps":["trace[481616562] 'process raft request' (duration: 108.291905ms)","trace[481616562] 'compare' (duration: 235.94351ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:39:57.570272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:57.225359Z","time spent":"344.818975ms","remote":"127.0.0.1:40076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:39:57.570644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.695028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:39:57.570703Z","caller":"traceutil/trace.go:171","msg":"trace[58741777] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8429; }","duration":"304.80036ms","start":"2026-04-07T01:39:57.265881Z","end":"2026-04-07T01:39:57.570681Z","steps":["trace[58741777] 'agreement among raft nodes before linearized reading' (duration: 304.698649ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:57.571229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:57.265865Z","time spent":"305.041525ms","remote":"127.0.0.1:39826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T01:39:57.57124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.952974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-cvd7h\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-07T01:39:57.571327Z","caller":"traceutil/trace.go:171","msg":"trace[1409931428] range","detail":"{range_begin:/registry/pods/openstack/keepalived-cvd7h; range_end:; response_count:1; response_revision:8429; }","duration":"147.481054ms","start":"2026-04-07T01:39:57.423811Z","end":"2026-04-07T01:39:57.571292Z","steps":["trace[1409931428] 'agreement among raft nodes before linearized reading' (duration: 146.830232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:57.571423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.762939ms","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-07T01:39:57.571407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.96768ms","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-07T01:39:57.571534Z","caller":"traceutil/trace.go:171","msg":"trace[904958385] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8429; }","duration":"334.81134ms","start":"2026-04-07T01:39:57.236664Z","end":"2026-04-07T01:39:57.571475Z","steps":["trace[904958385] 'agreement among raft nodes before linearized reading' (duration: 333.591877ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:39:57.571538Z","caller":"traceutil/trace.go:171","msg":"trace[1120700021] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8429; }","duration":"157.169514ms","start":"2026-04-07T01:39:57.414336Z","end":"2026-04-07T01:39:57.571505Z","steps":["trace[1120700021] 'agreement among raft nodes before linearized reading' (duration: 156.729206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:39:57.571637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:39:57.236649Z","time spent":"334.968562ms","remote":"127.0.0.1:40076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-07T01:39:57.57429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.29061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2366191"} {"level":"info","ts":"2026-04-07T01:39:57.574395Z","caller":"traceutil/trace.go:171","msg":"trace[625140440] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:8429; }","duration":"276.419832ms","start":"2026-04-07T01:39:57.29795Z","end":"2026-04-07T01:39:57.57437Z","steps":["trace[625140440] 'agreement among raft nodes before linearized reading' (duration: 273.126051ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:40:43.577564Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002408.wal"} {"level":"info","ts":"2026-04-07T01:41:02.106185Z","caller":"traceutil/trace.go:171","msg":"trace[1566898365] transaction","detail":"{read_only:false; response_revision:9047; number_of_response:1; }","duration":"179.697288ms","start":"2026-04-07T01:41:01.926456Z","end":"2026-04-07T01:41:02.106154Z","steps":["trace[1566898365] 'process raft request' (duration: 87.948518ms)","trace[1566898365] 'compare' (duration: 91.512596ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:41:02.106173Z","caller":"traceutil/trace.go:171","msg":"trace[1811367302] linearizableReadLoop","detail":"{readStateIndex:9359; appliedIndex:9357; }","duration":"159.021584ms","start":"2026-04-07T01:41:01.94711Z","end":"2026-04-07T01:41:02.106131Z","steps":["trace[1811367302] 'read index received' (duration: 25.527576ms)","trace[1811367302] 'applied index is now lower than readState.Index' (duration: 133.491767ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:41:02.106353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.236287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:356"} {"level":"info","ts":"2026-04-07T01:41:02.106421Z","caller":"traceutil/trace.go:171","msg":"trace[1760009728] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:9047; }","duration":"159.330818ms","start":"2026-04-07T01:41:01.947074Z","end":"2026-04-07T01:41:02.106405Z","steps":["trace[1760009728] 'agreement among raft nodes before linearized reading' (duration: 159.156185ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:42:16.06772Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"aab6040abcf11","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-07T01:42:16.072538Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-07T01:42:16.072672Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-07T01:44:21.307826Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8142} {"level":"info","ts":"2026-04-07T01:44:21.368788Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8142,"took":"58.569472ms","hash":3642409222,"current-db-size-bytes":58093568,"current-db-size":"58 MB","current-db-size-in-use-bytes":29511680,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-07T01:44:21.368849Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3642409222,"revision":8142,"compact-revision":5965} {"level":"info","ts":"2026-04-07T01:49:21.314981Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10570} {"level":"info","ts":"2026-04-07T01:49:21.390051Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10570,"took":"72.524218ms","hash":1281341514,"current-db-size-bytes":58093568,"current-db-size":"58 MB","current-db-size-in-use-bytes":20094976,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-07T01:49:21.390106Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1281341514,"revision":10570,"compact-revision":8142}