{"level":"warn","ts":"2026-06-10T01:17:42.61489Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T01:17:42.615007Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227: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.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227: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-06-10T01:17:42.615094Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T01:17:42.615111Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-06-10T01:17:42.615138Z","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-06-10T01:17:42.615884Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]} {"level":"info","ts":"2026-06-10T01:17:42.615974Z","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.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227: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-06-10T01:17:42.620865Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.652668ms"} {"level":"info","ts":"2026-06-10T01:17:42.634785Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"} {"level":"info","ts":"2026-06-10T01:17:42.634959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"} {"level":"info","ts":"2026-06-10T01:17:42.634991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"} {"level":"info","ts":"2026-06-10T01:17:42.635009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-10T01:17:42.63502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"} {"level":"info","ts":"2026-06-10T01:17:42.635083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"warn","ts":"2026-06-10T01:17:42.641285Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-10T01:17:42.643931Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-10T01:17:42.645264Z","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-06-10T01:17:42.647907Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-10T01:17:42.64815Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-10T01:17:42.648307Z","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-06-10T01:17:42.648445Z","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-06-10T01:17:42.648467Z","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-06-10T01:17:42.65056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"info","ts":"2026-06-10T01:17:42.650796Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-06-10T01:17:42.652488Z","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-06-10T01:17:42.65266Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-06-10T01:17:42.652721Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-06-10T01:17:42.652751Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-10T01:17:42.65278Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-10T01:17:42.835851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"} {"level":"info","ts":"2026-06-10T01:17:42.835943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-10T01:17:42.835974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"} {"level":"info","ts":"2026-06-10T01:17:42.835997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"} {"level":"info","ts":"2026-06-10T01:17:42.836009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-06-10T01:17:42.836025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"} {"level":"info","ts":"2026-06-10T01:17:42.836045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-06-10T01:17:42.83708Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T01:17:42.837403Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"} {"level":"info","ts":"2026-06-10T01:17:42.837426Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T01:17:42.837419Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T01:17:42.837809Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-10T01:17:42.837863Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-10T01:17:42.840005Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"} {"level":"info","ts":"2026-06-10T01:17:42.841105Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-10T01:17:42.845618Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T01:17:42.845718Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T01:17:42.845778Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T01:18:25.033433Z","caller":"traceutil/trace.go:171","msg":"trace[344358746] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"109.628468ms","start":"2026-06-10T01:18:24.923771Z","end":"2026-06-10T01:18:25.0334Z","steps":["trace[344358746] 'process raft request' (duration: 109.470495ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:18:25.231123Z","caller":"traceutil/trace.go:171","msg":"trace[1296125783] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:618; }","duration":"157.719772ms","start":"2026-06-10T01:18:25.073362Z","end":"2026-06-10T01:18:25.231082Z","steps":["trace[1296125783] 'read index received' (duration: 155.074076ms)","trace[1296125783] 'applied index is now lower than readState.Index' (duration: 2.644166ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:18:25.231219Z","caller":"traceutil/trace.go:171","msg":"trace[699829754] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"258.692844ms","start":"2026-06-10T01:18:24.972485Z","end":"2026-06-10T01:18:25.231178Z","steps":["trace[699829754] 'process raft request' (duration: 256.955798ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:18:25.23149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.017068ms","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-06-10T01:18:25.231573Z","caller":"traceutil/trace.go:171","msg":"trace[1545227447] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:593; }","duration":"158.232643ms","start":"2026-06-10T01:18:25.073326Z","end":"2026-06-10T01:18:25.231559Z","steps":["trace[1545227447] 'agreement among raft nodes before linearized reading' (duration: 157.912166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:18:25.649341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.770989ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-10T01:18:25.649649Z","caller":"traceutil/trace.go:171","msg":"trace[1095751442] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:620; }","duration":"145.027912ms","start":"2026-06-10T01:18:25.504601Z","end":"2026-06-10T01:18:25.649629Z","steps":["trace[1095751442] 'read index received' (duration: 82.762µs)","trace[1095751442] 'applied index is now lower than readState.Index' (duration: 144.94365ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T01:18:25.649855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.253577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-10T01:18:25.649833Z","caller":"traceutil/trace.go:171","msg":"trace[1025780838] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"344.648268ms","start":"2026-06-10T01:18:25.305146Z","end":"2026-06-10T01:18:25.649795Z","steps":["trace[1025780838] 'process raft request' (duration: 344.359711ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:18:25.649898Z","caller":"traceutil/trace.go:171","msg":"trace[727808465] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:596; }","duration":"145.347669ms","start":"2026-06-10T01:18:25.504541Z","end":"2026-06-10T01:18:25.649888Z","steps":["trace[727808465] 'agreement among raft nodes before linearized reading' (duration: 145.150895ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:18:25.649871Z","caller":"traceutil/trace.go:171","msg":"trace[1509651357] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"361.63196ms","start":"2026-06-10T01:18:25.2882Z","end":"2026-06-10T01:18:25.649832Z","steps":["trace[1509651357] 'process raft request' (duration: 24.764097ms)","trace[1509651357] 'compare' (duration: 335.405241ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T01:18:25.650032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:18:25.288168Z","time spent":"361.782493ms","remote":"127.0.0.1:55824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T01:18:25.650226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:18:25.30511Z","time spent":"344.802481ms","remote":"127.0.0.1:55576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T01:18:25.78964Z","caller":"traceutil/trace.go:171","msg":"trace[1485068615] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"128.197624ms","start":"2026-06-10T01:18:25.661418Z","end":"2026-06-10T01:18:25.789615Z","steps":["trace[1485068615] 'read index received' (duration: 103.823054ms)","trace[1485068615] 'applied index is now lower than readState.Index' (duration: 24.37143ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:18:25.789675Z","caller":"traceutil/trace.go:171","msg":"trace[778479793] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"134.779454ms","start":"2026-06-10T01:18:25.654872Z","end":"2026-06-10T01:18:25.789651Z","steps":["trace[778479793] 'process raft request' (duration: 110.336533ms)","trace[778479793] 'compare' (duration: 24.293207ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T01:18:25.789766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.342566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T01:18:25.789808Z","caller":"traceutil/trace.go:171","msg":"trace[421419667] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:597; }","duration":"128.436668ms","start":"2026-06-10T01:18:25.661361Z","end":"2026-06-10T01:18:25.789797Z","steps":["trace[421419667] 'agreement among raft nodes before linearized reading' (duration: 128.337736ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:18:41.108217Z","caller":"traceutil/trace.go:171","msg":"trace[143429076] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"105.741974ms","start":"2026-06-10T01:18:41.002444Z","end":"2026-06-10T01:18:41.108186Z","steps":["trace[143429076] 'process raft request' (duration: 105.588061ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:19:29.408752Z","caller":"traceutil/trace.go:171","msg":"trace[1565639178] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"148.500758ms","start":"2026-06-10T01:19:29.260199Z","end":"2026-06-10T01:19:29.4087Z","steps":["trace[1565639178] 'process raft request' (duration: 148.375944ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:19:52.884676Z","caller":"traceutil/trace.go:171","msg":"trace[1536922068] transaction","detail":"{read_only:false; response_revision:1804; number_of_response:1; }","duration":"226.947885ms","start":"2026-06-10T01:19:52.657692Z","end":"2026-06-10T01:19:52.88464Z","steps":["trace[1536922068] 'process raft request' (duration: 226.730011ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:21:32.277925Z","caller":"traceutil/trace.go:171","msg":"trace[1295049223] transaction","detail":"{read_only:false; response_revision:2572; number_of_response:1; }","duration":"158.447297ms","start":"2026-06-10T01:21:32.119446Z","end":"2026-06-10T01:21:32.277894Z","steps":["trace[1295049223] 'process raft request' (duration: 152.341539ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:24:35.451463Z","caller":"traceutil/trace.go:171","msg":"trace[462096137] transaction","detail":"{read_only:false; response_revision:3766; number_of_response:1; }","duration":"123.938709ms","start":"2026-06-10T01:24:35.327498Z","end":"2026-06-10T01:24:35.451436Z","steps":["trace[462096137] 'process raft request' (duration: 123.803886ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:24:35.456634Z","caller":"traceutil/trace.go:171","msg":"trace[1127176753] transaction","detail":"{read_only:false; response_revision:3767; number_of_response:1; }","duration":"115.508614ms","start":"2026-06-10T01:24:35.34109Z","end":"2026-06-10T01:24:35.456598Z","steps":["trace[1127176753] 'process raft request' (duration: 115.29936ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:26:05.772826Z","caller":"traceutil/trace.go:171","msg":"trace[1834658354] transaction","detail":"{read_only:false; response_revision:4853; number_of_response:1; }","duration":"133.04214ms","start":"2026-06-10T01:26:05.639764Z","end":"2026-06-10T01:26:05.772806Z","steps":["trace[1834658354] 'process raft request' (duration: 132.906058ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:26:08.541694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.692466ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T01:26:08.541781Z","caller":"traceutil/trace.go:171","msg":"trace[950622561] transaction","detail":"{read_only:false; response_revision:4976; number_of_response:1; }","duration":"298.6954ms","start":"2026-06-10T01:26:08.243074Z","end":"2026-06-10T01:26:08.54177Z","steps":["trace[950622561] 'process raft request' (duration: 174.861891ms)","trace[950622561] 'compare' (duration: 123.592764ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:26:08.547076Z","caller":"traceutil/trace.go:171","msg":"trace[574870883] transaction","detail":"{read_only:false; response_revision:4978; number_of_response:1; }","duration":"240.692412ms","start":"2026-06-10T01:26:08.306359Z","end":"2026-06-10T01:26:08.547051Z","steps":["trace[574870883] 'process raft request' (duration: 240.5995ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:26:08.547317Z","caller":"traceutil/trace.go:171","msg":"trace[90310774] linearizableReadLoop","detail":"{readStateIndex:5170; appliedIndex:5167; }","duration":"178.771362ms","start":"2026-06-10T01:26:08.368535Z","end":"2026-06-10T01:26:08.547306Z","steps":["trace[90310774] 'read index received' (duration: 49.414269ms)","trace[90310774] 'applied index is now lower than readState.Index' (duration: 129.355993ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T01:26:08.547539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.989017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:16179"} {"level":"info","ts":"2026-06-10T01:26:08.547588Z","caller":"traceutil/trace.go:171","msg":"trace[1264908100] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4979; }","duration":"179.078199ms","start":"2026-06-10T01:26:08.368498Z","end":"2026-06-10T01:26:08.547577Z","steps":["trace[1264908100] 'agreement among raft nodes before linearized reading' (duration: 178.938165ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:26:08.547767Z","caller":"traceutil/trace.go:171","msg":"trace[730151800] transaction","detail":"{read_only:false; response_revision:4979; number_of_response:1; }","duration":"168.788185ms","start":"2026-06-10T01:26:08.378967Z","end":"2026-06-10T01:26:08.547755Z","steps":["trace[730151800] 'process raft request' (duration: 168.044039ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:26:08.54935Z","caller":"traceutil/trace.go:171","msg":"trace[961055565] transaction","detail":"{read_only:false; response_revision:4977; number_of_response:1; }","duration":"303.841407ms","start":"2026-06-10T01:26:08.243393Z","end":"2026-06-10T01:26:08.547235Z","steps":["trace[961055565] 'process raft request' (duration: 303.445109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:26:08.549542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:26:08.243383Z","time spent":"306.045043ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3706,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T01:26:21.557588Z","caller":"traceutil/trace.go:171","msg":"trace[261620615] linearizableReadLoop","detail":"{readStateIndex:5440; appliedIndex:5439; }","duration":"189.108029ms","start":"2026-06-10T01:26:21.368446Z","end":"2026-06-10T01:26:21.557554Z","steps":["trace[261620615] 'read index received' (duration: 106.473057ms)","trace[261620615] 'applied index is now lower than readState.Index' (duration: 82.632912ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:26:21.55761Z","caller":"traceutil/trace.go:171","msg":"trace[1376331364] transaction","detail":"{read_only:false; response_revision:5240; number_of_response:1; }","duration":"177.944906ms","start":"2026-06-10T01:26:21.379637Z","end":"2026-06-10T01:26:21.557582Z","steps":["trace[1376331364] 'process raft request' (duration: 177.759043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:26:21.568374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.893233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/goldpinger-gcz85\" ","response":"range_response_count:1 size:4995"} {"level":"info","ts":"2026-06-10T01:26:21.568523Z","caller":"traceutil/trace.go:171","msg":"trace[2022133702] range","detail":"{range_begin:/registry/pods/monitoring/goldpinger-gcz85; range_end:; response_count:1; response_revision:5240; }","duration":"200.095188ms","start":"2026-06-10T01:26:21.36841Z","end":"2026-06-10T01:26:21.568505Z","steps":["trace[2022133702] 'agreement among raft nodes before linearized reading' (duration: 189.265922ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:26:29.407681Z","caller":"traceutil/trace.go:171","msg":"trace[1618182816] linearizableReadLoop","detail":"{readStateIndex:5629; appliedIndex:5628; }","duration":"125.224778ms","start":"2026-06-10T01:26:29.282428Z","end":"2026-06-10T01:26:29.407652Z","steps":["trace[1618182816] 'read index received' (duration: 77.401612ms)","trace[1618182816] 'applied index is now lower than readState.Index' (duration: 47.821246ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T01:26:29.407961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.485763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-10T01:26:29.407978Z","caller":"traceutil/trace.go:171","msg":"trace[472782827] transaction","detail":"{read_only:false; response_revision:5424; number_of_response:1; }","duration":"141.389624ms","start":"2026-06-10T01:26:29.266533Z","end":"2026-06-10T01:26:29.407923Z","steps":["trace[472782827] 'process raft request' (duration: 135.560482ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:26:29.408012Z","caller":"traceutil/trace.go:171","msg":"trace[1075103723] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5424; }","duration":"125.618156ms","start":"2026-06-10T01:26:29.282383Z","end":"2026-06-10T01:26:29.408001Z","steps":["trace[1075103723] 'agreement among raft nodes before linearized reading' (duration: 125.404862ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:27:42.907457Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2977} {"level":"info","ts":"2026-06-10T01:27:42.976041Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2977,"took":"66.86713ms","hash":2905761115,"current-db-size-bytes":57901056,"current-db-size":"58 MB","current-db-size-in-use-bytes":34086912,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-10T01:27:42.976097Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2905761115,"revision":2977,"compact-revision":-1} {"level":"info","ts":"2026-06-10T01:32:21.013677Z","caller":"traceutil/trace.go:171","msg":"trace[1683710561] transaction","detail":"{read_only:false; response_revision:8153; number_of_response:1; }","duration":"111.933844ms","start":"2026-06-10T01:32:20.901714Z","end":"2026-06-10T01:32:21.013648Z","steps":["trace[1683710561] 'process raft request' (duration: 111.799722ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:32:32.594506Z","caller":"traceutil/trace.go:171","msg":"trace[1036882164] transaction","detail":"{read_only:false; response_revision:8215; number_of_response:1; }","duration":"113.21805ms","start":"2026-06-10T01:32:32.481262Z","end":"2026-06-10T01:32:32.59448Z","steps":["trace[1036882164] 'process raft request' (duration: 113.022726ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:32:33.059374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.373307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T01:32:33.059451Z","caller":"traceutil/trace.go:171","msg":"trace[331158045] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8215; }","duration":"194.499479ms","start":"2026-06-10T01:32:32.864936Z","end":"2026-06-10T01:32:33.059436Z","steps":["trace[331158045] 'range keys from in-memory index tree' (duration: 194.269254ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:32:33.059485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.964016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1986"} {"level":"info","ts":"2026-06-10T01:32:33.059595Z","caller":"traceutil/trace.go:171","msg":"trace[1026398955] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:8215; }","duration":"388.13366ms","start":"2026-06-10T01:32:32.671437Z","end":"2026-06-10T01:32:33.05957Z","steps":["trace[1026398955] 'range keys from in-memory index tree' (duration: 387.753593ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:32:33.059647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:32:32.67141Z","time spent":"388.226362ms","remote":"127.0.0.1:55480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2009,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"info","ts":"2026-06-10T01:32:33.227194Z","caller":"traceutil/trace.go:171","msg":"trace[1722638383] linearizableReadLoop","detail":"{readStateIndex:8509; appliedIndex:8508; }","duration":"166.61995ms","start":"2026-06-10T01:32:33.060544Z","end":"2026-06-10T01:32:33.227164Z","steps":["trace[1722638383] 'read index received' (duration: 166.397425ms)","trace[1722638383] 'applied index is now lower than readState.Index' (duration: 220.935µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:32:33.227337Z","caller":"traceutil/trace.go:171","msg":"trace[2002069062] transaction","detail":"{read_only:false; response_revision:8216; number_of_response:1; }","duration":"170.945619ms","start":"2026-06-10T01:32:33.056339Z","end":"2026-06-10T01:32:33.227284Z","steps":["trace[2002069062] 'process raft request' (duration: 170.580452ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:32:33.227453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.861945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T01:32:33.227527Z","caller":"traceutil/trace.go:171","msg":"trace[519327200] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8216; }","duration":"166.997618ms","start":"2026-06-10T01:32:33.060509Z","end":"2026-06-10T01:32:33.227506Z","steps":["trace[519327200] 'agreement among raft nodes before linearized reading' (duration: 166.846955ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:32:33.364732Z","caller":"traceutil/trace.go:171","msg":"trace[113855484] linearizableReadLoop","detail":"{readStateIndex:8510; appliedIndex:8509; }","duration":"137.401554ms","start":"2026-06-10T01:32:33.227307Z","end":"2026-06-10T01:32:33.364708Z","steps":["trace[113855484] 'read index received' (duration: 137.21784ms)","trace[113855484] 'applied index is now lower than readState.Index' (duration: 182.814µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:32:33.364802Z","caller":"traceutil/trace.go:171","msg":"trace[87142798] transaction","detail":"{read_only:false; response_revision:8217; number_of_response:1; }","duration":"187.260952ms","start":"2026-06-10T01:32:33.177512Z","end":"2026-06-10T01:32:33.364773Z","steps":["trace[87142798] 'process raft request' (duration: 187.044078ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:32:33.364965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.029214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/openstack/key-manager\" ","response":"range_response_count:1 size:710"} {"level":"info","ts":"2026-06-10T01:32:33.365016Z","caller":"traceutil/trace.go:171","msg":"trace[468405522] range","detail":"{range_begin:/registry/ingress/openstack/key-manager; range_end:; response_count:1; response_revision:8217; }","duration":"302.109865ms","start":"2026-06-10T01:32:33.062889Z","end":"2026-06-10T01:32:33.364999Z","steps":["trace[468405522] 'agreement among raft nodes before linearized reading' (duration: 301.917092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:32:33.365032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.409081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-10T01:32:33.365061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.553483ms","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-06-10T01:32:33.365105Z","caller":"traceutil/trace.go:171","msg":"trace[89889235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8217; }","duration":"176.512072ms","start":"2026-06-10T01:32:33.188577Z","end":"2026-06-10T01:32:33.365089Z","steps":["trace[89889235] 'agreement among raft nodes before linearized reading' (duration: 176.204746ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:32:33.365155Z","caller":"traceutil/trace.go:171","msg":"trace[415129882] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8217; }","duration":"176.696206ms","start":"2026-06-10T01:32:33.188437Z","end":"2026-06-10T01:32:33.365133Z","steps":["trace[415129882] 'agreement among raft nodes before linearized reading' (duration: 176.40233ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:32:33.365051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:32:33.062879Z","time spent":"302.163097ms","remote":"127.0.0.1:55598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":733,"request content":"key:\"/registry/ingress/openstack/key-manager\" "} {"level":"info","ts":"2026-06-10T01:32:34.120255Z","caller":"traceutil/trace.go:171","msg":"trace[489407544] transaction","detail":"{read_only:false; response_revision:8226; number_of_response:1; }","duration":"194.013729ms","start":"2026-06-10T01:32:33.926217Z","end":"2026-06-10T01:32:34.120231Z","steps":["trace[489407544] 'process raft request' (duration: 181.138296ms)","trace[489407544] 'compare' (duration: 12.71049ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:32:34.12803Z","caller":"traceutil/trace.go:171","msg":"trace[1339760456] transaction","detail":"{read_only:false; response_revision:8227; number_of_response:1; }","duration":"189.978347ms","start":"2026-06-10T01:32:33.938031Z","end":"2026-06-10T01:32:34.128009Z","steps":["trace[1339760456] 'process raft request' (duration: 189.870615ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:32:35.510438Z","caller":"traceutil/trace.go:171","msg":"trace[194388953] transaction","detail":"{read_only:false; response_revision:8229; number_of_response:1; }","duration":"140.16789ms","start":"2026-06-10T01:32:35.369979Z","end":"2026-06-10T01:32:35.510147Z","steps":["trace[194388953] 'process raft request' (duration: 79.960641ms)","trace[194388953] 'compare' (duration: 59.987925ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:32:42.914229Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6077} {"level":"info","ts":"2026-06-10T01:32:43.014881Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6077,"took":"98.54242ms","hash":3408557544,"current-db-size-bytes":57901056,"current-db-size":"58 MB","current-db-size-in-use-bytes":23797760,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-10T01:32:43.014948Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3408557544,"revision":6077,"compact-revision":2977} {"level":"info","ts":"2026-06-10T01:33:02.248476Z","caller":"traceutil/trace.go:171","msg":"trace[335905406] transaction","detail":"{read_only:false; response_revision:8430; number_of_response:1; }","duration":"173.427039ms","start":"2026-06-10T01:33:02.075021Z","end":"2026-06-10T01:33:02.248448Z","steps":["trace[335905406] 'process raft request' (duration: 173.249986ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:33:02.251058Z","caller":"traceutil/trace.go:171","msg":"trace[1287045367] linearizableReadLoop","detail":"{readStateIndex:8733; appliedIndex:8733; }","duration":"130.660117ms","start":"2026-06-10T01:33:02.120382Z","end":"2026-06-10T01:33:02.251042Z","steps":["trace[1287045367] 'read index received' (duration: 130.655577ms)","trace[1287045367] 'applied index is now lower than readState.Index' (duration: 3.67µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T01:33:02.251231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.841001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-10T01:33:02.251267Z","caller":"traceutil/trace.go:171","msg":"trace[1876855203] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8430; }","duration":"130.931103ms","start":"2026-06-10T01:33:02.120327Z","end":"2026-06-10T01:33:02.251258Z","steps":["trace[1876855203] 'agreement among raft nodes before linearized reading' (duration: 130.77732ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:33:02.468161Z","caller":"traceutil/trace.go:171","msg":"trace[885023810] linearizableReadLoop","detail":"{readStateIndex:8734; appliedIndex:8733; }","duration":"213.960306ms","start":"2026-06-10T01:33:02.254177Z","end":"2026-06-10T01:33:02.468137Z","steps":["trace[885023810] 'read index received' (duration: 213.764242ms)","trace[885023810] 'applied index is now lower than readState.Index' (duration: 195.344µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:33:02.468277Z","caller":"traceutil/trace.go:171","msg":"trace[1907923723] transaction","detail":"{read_only:false; response_revision:8431; number_of_response:1; }","duration":"261.608248ms","start":"2026-06-10T01:33:02.206635Z","end":"2026-06-10T01:33:02.468243Z","steps":["trace[1907923723] 'process raft request' (duration: 261.355033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:33:02.468528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.513097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-06-10T01:33:02.468522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.258812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-10T01:33:02.468584Z","caller":"traceutil/trace.go:171","msg":"trace[410886452] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8431; }","duration":"212.675461ms","start":"2026-06-10T01:33:02.255888Z","end":"2026-06-10T01:33:02.468563Z","steps":["trace[410886452] 'agreement among raft nodes before linearized reading' (duration: 212.441356ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:33:02.468597Z","caller":"traceutil/trace.go:171","msg":"trace[400079616] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8431; }","duration":"214.434295ms","start":"2026-06-10T01:33:02.254143Z","end":"2026-06-10T01:33:02.468578Z","steps":["trace[400079616] 'agreement among raft nodes before linearized reading' (duration: 214.118429ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:33:14.132284Z","caller":"traceutil/trace.go:171","msg":"trace[273892221] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8535; }","duration":"113.812043ms","start":"2026-06-10T01:33:14.018448Z","end":"2026-06-10T01:33:14.13226Z","steps":["trace[273892221] 'process raft request' (duration: 113.641469ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:33:14.132382Z","caller":"traceutil/trace.go:171","msg":"trace[1822409740] transaction","detail":"{read_only:false; response_revision:8534; number_of_response:1; }","duration":"114.19033ms","start":"2026-06-10T01:33:14.018163Z","end":"2026-06-10T01:33:14.132353Z","steps":["trace[1822409740] 'process raft request' (duration: 113.083787ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:33:15.019447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.826471ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T01:33:15.01955Z","caller":"traceutil/trace.go:171","msg":"trace[1289907172] linearizableReadLoop","detail":"{readStateIndex:8848; appliedIndex:8847; }","duration":"182.439664ms","start":"2026-06-10T01:33:14.837095Z","end":"2026-06-10T01:33:15.019535Z","steps":["trace[1289907172] 'read index received' (duration: 75.44098ms)","trace[1289907172] 'applied index is now lower than readState.Index' (duration: 106.997624ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:33:15.019635Z","caller":"traceutil/trace.go:171","msg":"trace[95278508] transaction","detail":"{read_only:false; response_revision:8541; number_of_response:1; }","duration":"256.430224ms","start":"2026-06-10T01:33:14.763194Z","end":"2026-06-10T01:33:15.019624Z","steps":["trace[95278508] 'process raft request' (duration: 149.339948ms)","trace[95278508] 'compare' (duration: 106.689197ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T01:33:15.019794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.672219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T01:33:15.019881Z","caller":"traceutil/trace.go:171","msg":"trace[1946676350] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8541; }","duration":"182.819572ms","start":"2026-06-10T01:33:14.837041Z","end":"2026-06-10T01:33:15.019861Z","steps":["trace[1946676350] 'agreement among raft nodes before linearized reading' (duration: 182.685199ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:33:15.020101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.528344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T01:33:15.02014Z","caller":"traceutil/trace.go:171","msg":"trace[1415071813] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8541; }","duration":"155.599586ms","start":"2026-06-10T01:33:14.864531Z","end":"2026-06-10T01:33:15.020131Z","steps":["trace[1415071813] 'agreement among raft nodes before linearized reading' (duration: 155.136677ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:33:15.667158Z","caller":"traceutil/trace.go:171","msg":"trace[1303530240] transaction","detail":"{read_only:false; response_revision:8545; number_of_response:1; }","duration":"138.018247ms","start":"2026-06-10T01:33:15.529105Z","end":"2026-06-10T01:33:15.667123Z","steps":["trace[1303530240] 'process raft request' (duration: 103.995693ms)","trace[1303530240] 'compare' (duration: 33.857051ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:33:15.970728Z","caller":"traceutil/trace.go:171","msg":"trace[124164054] linearizableReadLoop","detail":"{readStateIndex:8857; appliedIndex:8856; }","duration":"105.473133ms","start":"2026-06-10T01:33:15.865231Z","end":"2026-06-10T01:33:15.970704Z","steps":["trace[124164054] 'read index received' (duration: 105.294019ms)","trace[124164054] 'applied index is now lower than readState.Index' (duration: 177.654µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:33:15.971023Z","caller":"traceutil/trace.go:171","msg":"trace[764103237] transaction","detail":"{read_only:false; response_revision:8550; number_of_response:1; }","duration":"119.202232ms","start":"2026-06-10T01:33:15.851808Z","end":"2026-06-10T01:33:15.97101Z","steps":["trace[764103237] 'process raft request' (duration: 118.736753ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:33:15.971278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.037174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T01:33:15.97132Z","caller":"traceutil/trace.go:171","msg":"trace[2054240132] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8550; }","duration":"106.136646ms","start":"2026-06-10T01:33:15.865174Z","end":"2026-06-10T01:33:15.97131Z","steps":["trace[2054240132] 'agreement among raft nodes before linearized reading' (duration: 106.052644ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:33:38.077453Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023b1.wal"} {"level":"warn","ts":"2026-06-10T01:34:28.330887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.151905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-10T01:34:28.330968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.350959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-10T01:34:28.331024Z","caller":"traceutil/trace.go:171","msg":"trace[1404987084] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9272; }","duration":"244.38977ms","start":"2026-06-10T01:34:28.086613Z","end":"2026-06-10T01:34:28.331003Z","steps":["trace[1404987084] 'range keys from in-memory index tree' (duration: 243.880329ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:34:28.331068Z","caller":"traceutil/trace.go:171","msg":"trace[327192851] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9272; }","duration":"245.533323ms","start":"2026-06-10T01:34:28.085512Z","end":"2026-06-10T01:34:28.331045Z","steps":["trace[327192851] 'range keys from in-memory index tree' (duration: 245.060393ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:34:28.331086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.324918ms","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-06-10T01:34:28.331178Z","caller":"traceutil/trace.go:171","msg":"trace[1077577871] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9272; }","duration":"244.447332ms","start":"2026-06-10T01:34:28.086706Z","end":"2026-06-10T01:34:28.331154Z","steps":["trace[1077577871] 'range keys from in-memory index tree' (duration: 244.094003ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:35:20.634194Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"572db18442eba1c2","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T01:35:20.639251Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-10T01:35:20.63942Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-10T01:37:42.920332Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8275} {"level":"info","ts":"2026-06-10T01:37:42.995907Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8275,"took":"73.101364ms","hash":3316427680,"current-db-size-bytes":57901056,"current-db-size":"58 MB","current-db-size-in-use-bytes":26525696,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-10T01:37:42.996022Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3316427680,"revision":8275,"compact-revision":6077} {"level":"info","ts":"2026-06-10T01:37:51.743687Z","caller":"traceutil/trace.go:171","msg":"trace[1125379824] linearizableReadLoop","detail":"{readStateIndex:11396; appliedIndex:11395; }","duration":"109.177892ms","start":"2026-06-10T01:37:51.634474Z","end":"2026-06-10T01:37:51.743652Z","steps":["trace[1125379824] 'read index received' (duration: 12.343043ms)","trace[1125379824] 'applied index is now lower than readState.Index' (duration: 96.833059ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T01:37:51.744018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.5212ms","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-06-10T01:37:51.744155Z","caller":"traceutil/trace.go:171","msg":"trace[443815268] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:11016; }","duration":"109.696043ms","start":"2026-06-10T01:37:51.634407Z","end":"2026-06-10T01:37:51.744103Z","steps":["trace[443815268] 'agreement among raft nodes before linearized reading' (duration: 109.361055ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:38:09.620279Z","caller":"traceutil/trace.go:171","msg":"trace[1426259337] transaction","detail":"{read_only:false; response_revision:11111; number_of_response:1; }","duration":"102.875803ms","start":"2026-06-10T01:38:09.51734Z","end":"2026-06-10T01:38:09.620216Z","steps":["trace[1426259337] 'process raft request' (duration: 102.598058ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:38:09.65447Z","caller":"traceutil/trace.go:171","msg":"trace[1527830071] transaction","detail":"{read_only:false; response_revision:11112; number_of_response:1; }","duration":"101.991984ms","start":"2026-06-10T01:38:09.552429Z","end":"2026-06-10T01:38:09.654421Z","steps":["trace[1527830071] 'process raft request' (duration: 101.832131ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:38:09.654647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.409204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T01:38:09.654725Z","caller":"traceutil/trace.go:171","msg":"trace[88765581] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:11112; }","duration":"104.534886ms","start":"2026-06-10T01:38:09.550168Z","end":"2026-06-10T01:38:09.654703Z","steps":["trace[88765581] 'agreement among raft nodes before linearized reading' (duration: 104.375323ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:38:09.654779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.676742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-06-10T01:38:09.654839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.70949ms","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-06-10T01:38:09.654906Z","caller":"traceutil/trace.go:171","msg":"trace[1093645682] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11112; }","duration":"110.872686ms","start":"2026-06-10T01:38:09.544003Z","end":"2026-06-10T01:38:09.654876Z","steps":["trace[1093645682] 'agreement among raft nodes before linearized reading' (duration: 110.480688ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:38:09.654952Z","caller":"traceutil/trace.go:171","msg":"trace[478351301] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11112; }","duration":"104.872113ms","start":"2026-06-10T01:38:09.550051Z","end":"2026-06-10T01:38:09.654923Z","steps":["trace[478351301] 'agreement among raft nodes before linearized reading' (duration: 104.496166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:38:09.948787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.066796ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T01:38:09.949224Z","caller":"traceutil/trace.go:171","msg":"trace[426046484] transaction","detail":"{read_only:false; response_revision:11113; number_of_response:1; }","duration":"324.566674ms","start":"2026-06-10T01:38:09.624619Z","end":"2026-06-10T01:38:09.949185Z","steps":["trace[426046484] 'process raft request' (duration: 86.917086ms)","trace[426046484] 'compare' (duration: 236.889973ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:38:09.94924Z","caller":"traceutil/trace.go:171","msg":"trace[1447873428] transaction","detail":"{read_only:false; response_revision:11114; number_of_response:1; }","duration":"289.981427ms","start":"2026-06-10T01:38:09.659204Z","end":"2026-06-10T01:38:09.949186Z","steps":["trace[1447873428] 'process raft request' (duration: 289.735862ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:38:09.94909Z","caller":"traceutil/trace.go:171","msg":"trace[1549963117] linearizableReadLoop","detail":"{readStateIndex:11498; appliedIndex:11495; }","duration":"217.352703ms","start":"2026-06-10T01:38:09.731713Z","end":"2026-06-10T01:38:09.949066Z","steps":["trace[1549963117] 'read index received' (duration: 208.646875ms)","trace[1549963117] 'applied index is now lower than readState.Index' (duration: 8.703788ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T01:38:09.949293Z","caller":"traceutil/trace.go:171","msg":"trace[1478863910] transaction","detail":"{read_only:false; response_revision:11115; number_of_response:1; }","duration":"289.561908ms","start":"2026-06-10T01:38:09.659689Z","end":"2026-06-10T01:38:09.949251Z","steps":["trace[1478863910] 'process raft request' (duration: 289.326184ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:38:09.949421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T01:38:09.624598Z","time spent":"324.713668ms","remote":"127.0.0.1:55576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T01:38:09.949457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.72494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T01:38:09.949505Z","caller":"traceutil/trace.go:171","msg":"trace[427200364] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:11115; }","duration":"217.858602ms","start":"2026-06-10T01:38:09.73163Z","end":"2026-06-10T01:38:09.949488Z","steps":["trace[427200364] 'agreement among raft nodes before linearized reading' (duration: 217.73527ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T01:38:09.950226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.822852ms","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-06-10T01:38:09.95044Z","caller":"traceutil/trace.go:171","msg":"trace[485832006] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:11115; }","duration":"103.028786ms","start":"2026-06-10T01:38:09.847313Z","end":"2026-06-10T01:38:09.950342Z","steps":["trace[485832006] 'agreement among raft nodes before linearized reading' (duration: 102.655758ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T01:42:42.930354Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10942} {"level":"info","ts":"2026-06-10T01:42:43.011238Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10942,"took":"78.257904ms","hash":3209443529,"current-db-size-bytes":57901056,"current-db-size":"58 MB","current-db-size-in-use-bytes":28303360,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-10T01:42:43.011303Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3209443529,"revision":10942,"compact-revision":8275} {"level":"info","ts":"2026-06-10T01:43:55.940645Z","caller":"traceutil/trace.go:171","msg":"trace[1253646477] transaction","detail":"{read_only:false; response_revision:13494; number_of_response:1; }","duration":"134.20835ms","start":"2026-06-10T01:43:55.8064Z","end":"2026-06-10T01:43:55.940608Z","steps":["trace[1253646477] 'process raft request' (duration: 61.975282ms)","trace[1253646477] 'compare' (duration: 72.052175ms)"],"step_count":2}