{"level":"warn","ts":"2026-04-07T01:19:58.768445Z","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:19:58.768542Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.209: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.209:2380","--initial-cluster=instance=https://199.204.45.209:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.209:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.209: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:19:58.768631Z","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:19:58.768652Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.209:2380"]} {"level":"info","ts":"2026-04-07T01:19:58.768686Z","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:19:58.76951Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"]} {"level":"info","ts":"2026-04-07T01:19:58.769626Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.209:2380"],"listen-peer-urls":["https://199.204.45.209:2380"],"advertise-client-urls":["https://199.204.45.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.209: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:19:58.774752Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.800531ms"} {"level":"info","ts":"2026-04-07T01:19:58.780108Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"adfb641115bf6cbd","cluster-id":"3da6b677d4b80c6"} {"level":"info","ts":"2026-04-07T01:19:58.780183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T01:19:58.780205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 0"} {"level":"info","ts":"2026-04-07T01:19:58.780215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft adfb641115bf6cbd [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T01:19:58.780231Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became follower at term 1"} {"level":"info","ts":"2026-04-07T01:19:58.780266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"} {"level":"warn","ts":"2026-04-07T01:19:58.788273Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T01:19:58.79168Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T01:19:58.793995Z","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:19:58.796205Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"adfb641115bf6cbd","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T01:19:58.797514Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"adfb641115bf6cbd","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T01:19:58.797581Z","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:19:58.798175Z","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:19:58.798213Z","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:19:58.798945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd switched to configuration voters=(12536724012257995965)"} {"level":"info","ts":"2026-04-07T01:19:58.799154Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3da6b677d4b80c6","local-member-id":"adfb641115bf6cbd","added-peer-id":"adfb641115bf6cbd","added-peer-peer-urls":["https://199.204.45.209:2380"]} {"level":"info","ts":"2026-04-07T01:19:58.803142Z","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:19:58.803456Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"adfb641115bf6cbd","initial-advertise-peer-urls":["https://199.204.45.209:2380"],"listen-peer-urls":["https://199.204.45.209:2380"],"advertise-client-urls":["https://199.204.45.209:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.209:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T01:19:58.80399Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T01:19:58.804133Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.209:2380"} {"level":"info","ts":"2026-04-07T01:19:58.804178Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.209:2380"} {"level":"info","ts":"2026-04-07T01:19:59.281147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T01:19:59.281213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T01:19:59.281259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgPreVoteResp from adfb641115bf6cbd at term 1"} {"level":"info","ts":"2026-04-07T01:19:59.281285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became candidate at term 2"} {"level":"info","ts":"2026-04-07T01:19:59.281301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd received MsgVoteResp from adfb641115bf6cbd at term 2"} {"level":"info","ts":"2026-04-07T01:19:59.281322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"adfb641115bf6cbd became leader at term 2"} {"level":"info","ts":"2026-04-07T01:19:59.28134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: adfb641115bf6cbd elected leader adfb641115bf6cbd at term 2"} {"level":"info","ts":"2026-04-07T01:19:59.282281Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:19:59.28311Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:19:59.283112Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"adfb641115bf6cbd","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.209:2379]}","request-path":"/0/members/adfb641115bf6cbd/attributes","cluster-id":"3da6b677d4b80c6","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T01:19:59.283175Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:19:59.283458Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T01:19:59.283544Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T01:19:59.286514Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.209:2379"} {"level":"info","ts":"2026-04-07T01:19:59.286724Z","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:19:59.286968Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3da6b677d4b80c6","local-member-id":"adfb641115bf6cbd","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:19:59.287067Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:19:59.287094Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-07T01:20:00.907809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.182341ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-07T01:20:00.908014Z","caller":"traceutil/trace.go:171","msg":"trace[1606827036] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"218.979756ms","start":"2026-04-07T01:20:00.689012Z","end":"2026-04-07T01:20:00.907991Z","steps":["trace[1606827036] 'compare' (duration: 212.026372ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:00.908095Z","caller":"traceutil/trace.go:171","msg":"trace[143231391] linearizableReadLoop","detail":"{readStateIndex:45; appliedIndex:44; }","duration":"218.578121ms","start":"2026-04-07T01:20:00.689474Z","end":"2026-04-07T01:20:00.908052Z","steps":["trace[143231391] 'read index received' (duration: 5.453622ms)","trace[143231391] 'applied index is now lower than readState.Index' (duration: 213.120639ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:20:00.908354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.721114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-04-07T01:20:00.908408Z","caller":"traceutil/trace.go:171","msg":"trace[1007993021] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:42; }","duration":"220.846052ms","start":"2026-04-07T01:20:00.68755Z","end":"2026-04-07T01:20:00.908396Z","steps":["trace[1007993021] 'agreement among raft nodes before linearized reading' (duration: 220.612177ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:00.908433Z","caller":"traceutil/trace.go:171","msg":"trace[1423967190] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"215.05058ms","start":"2026-04-07T01:20:00.693298Z","end":"2026-04-07T01:20:00.908348Z","steps":["trace[1423967190] 'process raft request' (duration: 214.627334ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:00.908837Z","caller":"traceutil/trace.go:171","msg":"trace[1150497044] transaction","detail":"{read_only:false; response_revision:43; number_of_response:1; }","duration":"214.997218ms","start":"2026-04-07T01:20:00.693829Z","end":"2026-04-07T01:20:00.908826Z","steps":["trace[1150497044] 'process raft request' (duration: 214.189096ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:20:01.298564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.848935ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-07T01:20:01.298744Z","caller":"traceutil/trace.go:171","msg":"trace[1272901964] transaction","detail":"{read_only:false; response_revision:44; number_of_response:1; }","duration":"385.354606ms","start":"2026-04-07T01:20:00.913351Z","end":"2026-04-07T01:20:01.298705Z","steps":["trace[1272901964] 'process raft request' (duration: 158.312399ms)","trace[1272901964] 'compare' (duration: 226.733478ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:20:01.298892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:20:00.913304Z","time spent":"385.522257ms","remote":"127.0.0.1:42968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":647,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:20:01.298986Z","caller":"traceutil/trace.go:171","msg":"trace[1283650849] transaction","detail":"{read_only:false; response_revision:45; number_of_response:1; }","duration":"385.608192ms","start":"2026-04-07T01:20:00.913339Z","end":"2026-04-07T01:20:01.298947Z","steps":["trace[1283650849] 'process raft request' (duration: 385.299793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:20:01.299175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:20:00.913321Z","time spent":"385.783993ms","remote":"127.0.0.1:42904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:20:01.299277Z","caller":"traceutil/trace.go:171","msg":"trace[684834558] linearizableReadLoop","detail":"{readStateIndex:50; appliedIndex:47; }","duration":"270.39083ms","start":"2026-04-07T01:20:01.028872Z","end":"2026-04-07T01:20:01.299263Z","steps":["trace[684834558] 'read index received' (duration: 42.768846ms)","trace[684834558] 'applied index is now lower than readState.Index' (duration: 227.621134ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:20:01.29943Z","caller":"traceutil/trace.go:171","msg":"trace[578392892] transaction","detail":"{read_only:false; response_revision:46; number_of_response:1; }","duration":"385.808986ms","start":"2026-04-07T01:20:00.913507Z","end":"2026-04-07T01:20:01.299316Z","steps":["trace[578392892] 'process raft request' (duration: 385.201737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:20:01.299511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.643807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T01:20:01.299624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:20:00.913485Z","time spent":"386.073172ms","remote":"127.0.0.1:42630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":326,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T01:20:01.299708Z","caller":"traceutil/trace.go:171","msg":"trace[1199923043] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:46; }","duration":"270.832418ms","start":"2026-04-07T01:20:01.02883Z","end":"2026-04-07T01:20:01.299662Z","steps":["trace[1199923043] 'agreement among raft nodes before linearized reading' (duration: 270.526239ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:30.860055Z","caller":"traceutil/trace.go:171","msg":"trace[1778735617] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"199.263417ms","start":"2026-04-07T01:20:30.660766Z","end":"2026-04-07T01:20:30.860029Z","steps":["trace[1778735617] 'process raft request' (duration: 175.946501ms)","trace[1778735617] 'compare' (duration: 22.762961ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:20:30.878086Z","caller":"traceutil/trace.go:171","msg":"trace[1103594516] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"177.148549ms","start":"2026-04-07T01:20:30.700885Z","end":"2026-04-07T01:20:30.878034Z","steps":["trace[1103594516] 'process raft request' (duration: 176.872507ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:31.944595Z","caller":"traceutil/trace.go:171","msg":"trace[1906855713] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"148.098394ms","start":"2026-04-07T01:20:31.796457Z","end":"2026-04-07T01:20:31.944555Z","steps":["trace[1906855713] 'process raft request' (duration: 146.682599ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:39.058336Z","caller":"traceutil/trace.go:171","msg":"trace[2074410350] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"114.11055ms","start":"2026-04-07T01:20:38.9442Z","end":"2026-04-07T01:20:39.05831Z","steps":["trace[2074410350] 'read index received' (duration: 113.918104ms)","trace[2074410350] 'applied index is now lower than readState.Index' (duration: 191.256µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:20:39.058403Z","caller":"traceutil/trace.go:171","msg":"trace[1510289907] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"116.422801ms","start":"2026-04-07T01:20:38.941951Z","end":"2026-04-07T01:20:39.058374Z","steps":["trace[1510289907] 'process raft request' (duration: 116.222594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:20:39.05858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.351619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-07T01:20:39.058624Z","caller":"traceutil/trace.go:171","msg":"trace[65170249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:642; }","duration":"114.429636ms","start":"2026-04-07T01:20:38.944184Z","end":"2026-04-07T01:20:39.058614Z","steps":["trace[65170249] 'agreement among raft nodes before linearized reading' (duration: 114.273093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:22:18.769646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.606251ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:22:18.769787Z","caller":"traceutil/trace.go:171","msg":"trace[1984604750] linearizableReadLoop","detail":"{readStateIndex:1920; appliedIndex:1919; }","duration":"278.644051ms","start":"2026-04-07T01:22:18.491121Z","end":"2026-04-07T01:22:18.769765Z","steps":["trace[1984604750] 'read index received' (duration: 163.977826ms)","trace[1984604750] 'applied index is now lower than readState.Index' (duration: 114.664415ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:22:18.770016Z","caller":"traceutil/trace.go:171","msg":"trace[827883164] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"347.576185ms","start":"2026-04-07T01:22:18.422418Z","end":"2026-04-07T01:22:18.769994Z","steps":["trace[827883164] 'process raft request' (duration: 232.766756ms)","trace[827883164] 'compare' (duration: 113.396364ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:22:18.77016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.945085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-07T01:22:18.770252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:22:18.422401Z","time spent":"347.665008ms","remote":"127.0.0.1:42708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:22:18.770321Z","caller":"traceutil/trace.go:171","msg":"trace[586613732] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1844; }","duration":"180.141111ms","start":"2026-04-07T01:22:18.590157Z","end":"2026-04-07T01:22:18.770298Z","steps":["trace[586613732] 'agreement among raft nodes before linearized reading' (duration: 179.863913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:22:18.771032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.896659ms","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":"info","ts":"2026-04-07T01:22:18.771109Z","caller":"traceutil/trace.go:171","msg":"trace[428404736] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1844; }","duration":"279.999693ms","start":"2026-04-07T01:22:18.491085Z","end":"2026-04-07T01:22:18.771085Z","steps":["trace[428404736] 'agreement among raft nodes before linearized reading' (duration: 279.558049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:22:35.090035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.588497ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:22:35.090194Z","caller":"traceutil/trace.go:171","msg":"trace[1726958053] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1982; }","duration":"117.988715ms","start":"2026-04-07T01:22:34.972187Z","end":"2026-04-07T01:22:35.090176Z","steps":["trace[1726958053] 'range keys from in-memory index tree' (duration: 117.572637ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:22:35.091347Z","caller":"traceutil/trace.go:171","msg":"trace[1736405767] transaction","detail":"{read_only:false; response_revision:1983; number_of_response:1; }","duration":"165.2751ms","start":"2026-04-07T01:22:34.926036Z","end":"2026-04-07T01:22:35.091311Z","steps":["trace[1736405767] 'process raft request' (duration: 165.0308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:22:58.193907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.702725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-07T01:22:58.194515Z","caller":"traceutil/trace.go:171","msg":"trace[161031974] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2114; }","duration":"255.355549ms","start":"2026-04-07T01:22:57.939135Z","end":"2026-04-07T01:22:58.19449Z","steps":["trace[161031974] 'range keys from in-memory index tree' (duration: 254.39416ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:22:58.833249Z","caller":"traceutil/trace.go:171","msg":"trace[701621749] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"280.118753ms","start":"2026-04-07T01:22:58.5531Z","end":"2026-04-07T01:22:58.833219Z","steps":["trace[701621749] 'process raft request' (duration: 279.945864ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:23:47.466583Z","caller":"traceutil/trace.go:171","msg":"trace[1084158825] transaction","detail":"{read_only:false; response_revision:2485; number_of_response:1; }","duration":"174.217801ms","start":"2026-04-07T01:23:47.292343Z","end":"2026-04-07T01:23:47.466561Z","steps":["trace[1084158825] 'process raft request' (duration: 174.066301ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:20.464142Z","caller":"traceutil/trace.go:171","msg":"trace[1685199730] transaction","detail":"{read_only:false; response_revision:2668; number_of_response:1; }","duration":"152.175758ms","start":"2026-04-07T01:24:20.311944Z","end":"2026-04-07T01:24:20.46412Z","steps":["trace[1685199730] 'process raft request' (duration: 145.293822ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:20.464405Z","caller":"traceutil/trace.go:171","msg":"trace[1215821919] transaction","detail":"{read_only:false; response_revision:2669; number_of_response:1; }","duration":"151.435116ms","start":"2026-04-07T01:24:20.312938Z","end":"2026-04-07T01:24:20.464373Z","steps":["trace[1215821919] 'process raft request' (duration: 151.127785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:24:20.771213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.839966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-07T01:24:20.771293Z","caller":"traceutil/trace.go:171","msg":"trace[1377483294] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2669; }","duration":"185.962285ms","start":"2026-04-07T01:24:20.585313Z","end":"2026-04-07T01:24:20.771275Z","steps":["trace[1377483294] 'range keys from in-memory index tree' (duration: 185.644254ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:12.446697Z","caller":"traceutil/trace.go:171","msg":"trace[1804175115] linearizableReadLoop","detail":"{readStateIndex:4806; appliedIndex:4805; }","duration":"140.21755ms","start":"2026-04-07T01:28:12.306453Z","end":"2026-04-07T01:28:12.446671Z","steps":["trace[1804175115] 'read index received' (duration: 111.685548ms)","trace[1804175115] 'applied index is now lower than readState.Index' (duration: 28.530792ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:28:12.446799Z","caller":"traceutil/trace.go:171","msg":"trace[1115432104] transaction","detail":"{read_only:false; response_revision:4627; number_of_response:1; }","duration":"140.680868ms","start":"2026-04-07T01:28:12.306082Z","end":"2026-04-07T01:28:12.446763Z","steps":["trace[1115432104] 'process raft request' (duration: 111.967709ms)","trace[1115432104] 'compare' (duration: 28.47701ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:28:12.446971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.48958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-07T01:28:12.447009Z","caller":"traceutil/trace.go:171","msg":"trace[320432656] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:4627; }","duration":"140.584624ms","start":"2026-04-07T01:28:12.306415Z","end":"2026-04-07T01:28:12.447Z","steps":["trace[320432656] 'agreement among raft nodes before linearized reading' (duration: 140.355115ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:12.465976Z","caller":"traceutil/trace.go:171","msg":"trace[1340380591] transaction","detail":"{read_only:false; response_revision:4628; number_of_response:1; }","duration":"159.213954ms","start":"2026-04-07T01:28:12.306735Z","end":"2026-04-07T01:28:12.465949Z","steps":["trace[1340380591] 'process raft request' (duration: 158.973265ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:12.466241Z","caller":"traceutil/trace.go:171","msg":"trace[1328667162] transaction","detail":"{read_only:false; response_revision:4629; number_of_response:1; }","duration":"159.410472ms","start":"2026-04-07T01:28:12.306812Z","end":"2026-04-07T01:28:12.466222Z","steps":["trace[1328667162] 'process raft request' (duration: 159.08886ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:12.466501Z","caller":"traceutil/trace.go:171","msg":"trace[1186092206] transaction","detail":"{read_only:false; response_revision:4630; number_of_response:1; }","duration":"159.615059ms","start":"2026-04-07T01:28:12.306876Z","end":"2026-04-07T01:28:12.466492Z","steps":["trace[1186092206] 'process raft request' (duration: 159.285377ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:12.629972Z","caller":"traceutil/trace.go:171","msg":"trace[1433368923] transaction","detail":"{read_only:false; response_revision:4631; number_of_response:1; }","duration":"115.033544ms","start":"2026-04-07T01:28:12.514896Z","end":"2026-04-07T01:28:12.629929Z","steps":["trace[1433368923] 'process raft request' (duration: 69.938388ms)","trace[1433368923] 'compare' (duration: 44.564975ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:28:13.148912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.131676ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:28:13.149382Z","caller":"traceutil/trace.go:171","msg":"trace[1930665247] transaction","detail":"{read_only:false; response_revision:4641; number_of_response:1; }","duration":"128.047649ms","start":"2026-04-07T01:28:13.021316Z","end":"2026-04-07T01:28:13.149364Z","steps":["trace[1930665247] 'process raft request' (duration: 127.992297ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:13.14933Z","caller":"traceutil/trace.go:171","msg":"trace[1382324144] transaction","detail":"{read_only:false; response_revision:4638; number_of_response:1; }","duration":"271.452753ms","start":"2026-04-07T01:28:12.877844Z","end":"2026-04-07T01:28:13.149297Z","steps":["trace[1382324144] 'process raft request' (duration: 143.842909ms)","trace[1382324144] 'compare' (duration: 126.868386ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:28:13.149619Z","caller":"traceutil/trace.go:171","msg":"trace[2104683452] transaction","detail":"{read_only:false; response_revision:4640; number_of_response:1; }","duration":"240.281552ms","start":"2026-04-07T01:28:12.909313Z","end":"2026-04-07T01:28:13.149595Z","steps":["trace[2104683452] 'process raft request' (duration: 239.875007ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:13.149699Z","caller":"traceutil/trace.go:171","msg":"trace[686784804] transaction","detail":"{read_only:false; response_revision:4639; number_of_response:1; }","duration":"270.792128ms","start":"2026-04-07T01:28:12.878896Z","end":"2026-04-07T01:28:13.149689Z","steps":["trace[686784804] 'process raft request' (duration: 270.142694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:24.832622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.16836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:10561"} {"level":"info","ts":"2026-04-07T01:28:24.832754Z","caller":"traceutil/trace.go:171","msg":"trace[1695737252] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4868; }","duration":"109.294116ms","start":"2026-04-07T01:28:24.723405Z","end":"2026-04-07T01:28:24.832699Z","steps":["trace[1695737252] 'range keys from in-memory index tree' (duration: 109.001483ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:59.30892Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2873} {"level":"info","ts":"2026-04-07T01:29:59.415537Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2873,"took":"105.018229ms","hash":258332134,"current-db-size-bytes":54415360,"current-db-size":"54 MB","current-db-size-in-use-bytes":29564928,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-07T01:29:59.415604Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":258332134,"revision":2873,"compact-revision":-1} {"level":"info","ts":"2026-04-07T01:34:59.316463Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5612} {"level":"info","ts":"2026-04-07T01:34:59.40413Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5612,"took":"86.248427ms","hash":21720687,"current-db-size-bytes":54415360,"current-db-size":"54 MB","current-db-size-in-use-bytes":18317312,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-07T01:34:59.404262Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":21720687,"revision":5612,"compact-revision":2873}