{"level":"warn","ts":"2026-04-29T01:27:54.587893Z","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-29T01:27:54.588053Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.153: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.153:2380","--initial-cluster=instance=https://199.204.45.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.153: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-29T01:27:54.588312Z","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-29T01:27:54.588342Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-04-29T01:27:54.588406Z","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-29T01:27:54.589705Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"]} {"level":"info","ts":"2026-04-29T01:27:54.589853Z","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.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.153: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-29T01:27:54.597867Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.520737ms"} {"level":"info","ts":"2026-04-29T01:27:54.605239Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"355195d5aae85944","cluster-id":"e424441517bc0b32"} {"level":"info","ts":"2026-04-29T01:27:54.605332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=()"} {"level":"info","ts":"2026-04-29T01:27:54.605357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 0"} {"level":"info","ts":"2026-04-29T01:27:54.605376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 355195d5aae85944 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-29T01:27:54.605383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 1"} {"level":"info","ts":"2026-04-29T01:27:54.60542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"warn","ts":"2026-04-29T01:27:54.612248Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-29T01:27:54.613647Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-29T01:27:54.614728Z","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-29T01:27:54.616459Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"355195d5aae85944","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-29T01:27:54.616576Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"355195d5aae85944","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-29T01:27:54.616693Z","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-29T01:27:54.617412Z","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-29T01:27:54.617427Z","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-29T01:27:54.6178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"info","ts":"2026-04-29T01:27:54.619574Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","added-peer-id":"355195d5aae85944","added-peer-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-04-29T01:27:54.623799Z","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-29T01:27:54.625336Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"355195d5aae85944","initial-advertise-peer-urls":["https://199.204.45.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-29T01:27:54.625385Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-29T01:27:54.625562Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-04-29T01:27:54.625585Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-04-29T01:27:55.405566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 is starting a new election at term 1"} {"level":"info","ts":"2026-04-29T01:27:55.40563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-29T01:27:55.405668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgPreVoteResp from 355195d5aae85944 at term 1"} {"level":"info","ts":"2026-04-29T01:27:55.405708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became candidate at term 2"} {"level":"info","ts":"2026-04-29T01:27:55.40572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgVoteResp from 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-04-29T01:27:55.405754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became leader at term 2"} {"level":"info","ts":"2026-04-29T01:27:55.405774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 355195d5aae85944 elected leader 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-04-29T01:27:55.530713Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-29T01:27:55.531276Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-29T01:27:55.531272Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"355195d5aae85944","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.153:2379]}","request-path":"/0/members/355195d5aae85944/attributes","cluster-id":"e424441517bc0b32","publish-timeout":"7s"} {"level":"info","ts":"2026-04-29T01:27:55.531302Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-29T01:27:55.531665Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-29T01:27:55.531735Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-29T01:27:55.535166Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-29T01:27:55.53675Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.153:2379"} {"level":"info","ts":"2026-04-29T01:27:55.695241Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","cluster-version":"3.5"} {"level":"info","ts":"2026-04-29T01:27:55.695745Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-29T01:27:55.695921Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-29T01:27:55.696241Z","caller":"traceutil/trace.go:171","msg":"trace[125810538] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"113.209744ms","start":"2026-04-29T01:27:55.583Z","end":"2026-04-29T01:27:55.696209Z","steps":["trace[125810538] 'read index received' (duration: 112.215877ms)","trace[125810538] 'applied index is now lower than readState.Index' (duration: 990.797µs)"],"step_count":2} {"level":"warn","ts":"2026-04-29T01:27:55.696425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.378629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-29T01:27:55.696506Z","caller":"traceutil/trace.go:171","msg":"trace[1346603233] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"113.495262ms","start":"2026-04-29T01:27:55.582993Z","end":"2026-04-29T01:27:55.696488Z","steps":["trace[1346603233] 'agreement among raft nodes before linearized reading' (duration: 113.300227ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:27:55.696746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.533853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-29T01:27:55.697024Z","caller":"traceutil/trace.go:171","msg":"trace[448521913] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"113.810201ms","start":"2026-04-29T01:27:55.583068Z","end":"2026-04-29T01:27:55.696878Z","steps":["trace[448521913] 'agreement among raft nodes before linearized reading' (duration: 113.513113ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:27:55.954132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.849413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-29T01:27:55.95422Z","caller":"traceutil/trace.go:171","msg":"trace[1990991903] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"160.007677ms","start":"2026-04-29T01:27:55.794194Z","end":"2026-04-29T01:27:55.954202Z","steps":["trace[1990991903] 'range keys from in-memory index tree' (duration: 159.72059ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:27:55.954376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.619412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-29T01:27:55.954428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.099876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-29T01:27:55.95445Z","caller":"traceutil/trace.go:171","msg":"trace[2086180671] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"239.133657ms","start":"2026-04-29T01:27:55.71531Z","end":"2026-04-29T01:27:55.954443Z","steps":["trace[2086180671] 'range keys from in-memory index tree' (duration: 239.062735ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T01:27:55.954443Z","caller":"traceutil/trace.go:171","msg":"trace[2141722162] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"149.699735ms","start":"2026-04-29T01:27:55.804728Z","end":"2026-04-29T01:27:55.954428Z","steps":["trace[2141722162] 'range keys from in-memory index tree' (duration: 149.550981ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:27:55.954559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.178218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-29T01:27:55.954574Z","caller":"traceutil/trace.go:171","msg":"trace[902412263] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"239.229929ms","start":"2026-04-29T01:27:55.715339Z","end":"2026-04-29T01:27:55.954569Z","steps":["trace[902412263] 'count revisions from in-memory index tree' (duration: 239.127467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:27:55.954574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.643423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-29T01:27:55.954597Z","caller":"traceutil/trace.go:171","msg":"trace[502697232] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"149.667324ms","start":"2026-04-29T01:27:55.804923Z","end":"2026-04-29T01:27:55.95459Z","steps":["trace[502697232] 'count revisions from in-memory index tree' (duration: 149.613872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:27:55.954647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.338791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-29T01:27:55.954664Z","caller":"traceutil/trace.go:171","msg":"trace[1509243321] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"228.374722ms","start":"2026-04-29T01:27:55.726285Z","end":"2026-04-29T01:27:55.954659Z","steps":["trace[1509243321] 'range keys from in-memory index tree' (duration: 228.30562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:27:55.954689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.307985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-29T01:27:55.954717Z","caller":"traceutil/trace.go:171","msg":"trace[261617835] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"137.378137ms","start":"2026-04-29T01:27:55.817331Z","end":"2026-04-29T01:27:55.954709Z","steps":["trace[261617835] 'count revisions from in-memory index tree' (duration: 137.210292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:27:55.95476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.525276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-29T01:27:55.954783Z","caller":"traceutil/trace.go:171","msg":"trace[1535021406] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"228.562137ms","start":"2026-04-29T01:27:55.726209Z","end":"2026-04-29T01:27:55.954771Z","steps":["trace[1535021406] 'count revisions from in-memory index tree' (duration: 228.403572ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:27:55.95483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.284624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-29T01:27:55.95487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.978085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-29T01:27:55.954886Z","caller":"traceutil/trace.go:171","msg":"trace[1244462140] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"215.023436ms","start":"2026-04-29T01:27:55.739857Z","end":"2026-04-29T01:27:55.954881Z","steps":["trace[1244462140] 'count revisions from in-memory index tree' (duration: 214.953783ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T01:27:55.954877Z","caller":"traceutil/trace.go:171","msg":"trace[1817754633] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"137.349597ms","start":"2026-04-29T01:27:55.817517Z","end":"2026-04-29T01:27:55.954867Z","steps":["trace[1817754633] 'range keys from in-memory index tree' (duration: 137.250924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:27:55.954983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.878584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-29T01:27:55.955Z","caller":"traceutil/trace.go:171","msg":"trace[108626942] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"198.937395ms","start":"2026-04-29T01:27:55.756059Z","end":"2026-04-29T01:27:55.954996Z","steps":["trace[108626942] 'range keys from in-memory index tree' (duration: 198.76037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:27:55.955055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.678138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-29T01:27:55.954854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.076947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-29T01:27:55.955114Z","caller":"traceutil/trace.go:171","msg":"trace[1676932952] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"163.7623ms","start":"2026-04-29T01:27:55.791339Z","end":"2026-04-29T01:27:55.955101Z","steps":["trace[1676932952] 'count revisions from in-memory index tree' (duration: 162.64485ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T01:27:55.955148Z","caller":"traceutil/trace.go:171","msg":"trace[1821435985] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"215.363606ms","start":"2026-04-29T01:27:55.739758Z","end":"2026-04-29T01:27:55.955121Z","steps":["trace[1821435985] 'range keys from in-memory index tree' (duration: 215.021026ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:27:55.955265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.63558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-29T01:27:55.955314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.388399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-29T01:27:55.955315Z","caller":"traceutil/trace.go:171","msg":"trace[1250667923] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"189.719542ms","start":"2026-04-29T01:27:55.765582Z","end":"2026-04-29T01:27:55.955302Z","steps":["trace[1250667923] 'count revisions from in-memory index tree' (duration: 189.591579ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T01:27:55.955338Z","caller":"traceutil/trace.go:171","msg":"trace[1100921107] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"179.42741ms","start":"2026-04-29T01:27:55.7759Z","end":"2026-04-29T01:27:55.955328Z","steps":["trace[1100921107] 'range keys from in-memory index tree' (duration: 179.311666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:27:55.955285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.688638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-29T01:27:55.955414Z","caller":"traceutil/trace.go:171","msg":"trace[683739133] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"179.839111ms","start":"2026-04-29T01:27:55.775567Z","end":"2026-04-29T01:27:55.955406Z","steps":["trace[683739133] 'count revisions from in-memory index tree' (duration: 179.628005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:27:55.955437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.966619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-29T01:27:55.955481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.215882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-29T01:27:55.955505Z","caller":"traceutil/trace.go:171","msg":"trace[2025126981] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"199.280544ms","start":"2026-04-29T01:27:55.756217Z","end":"2026-04-29T01:27:55.955498Z","steps":["trace[2025126981] 'count revisions from in-memory index tree' (duration: 199.12278ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T01:27:55.955509Z","caller":"traceutil/trace.go:171","msg":"trace[138631159] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"190.072062ms","start":"2026-04-29T01:27:55.76542Z","end":"2026-04-29T01:27:55.955492Z","steps":["trace[138631159] 'range keys from in-memory index tree' (duration: 189.901657ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T01:28:24.195568Z","caller":"traceutil/trace.go:171","msg":"trace[1372284212] linearizableReadLoop","detail":"{readStateIndex:503; appliedIndex:501; }","duration":"101.06812ms","start":"2026-04-29T01:28:24.094454Z","end":"2026-04-29T01:28:24.195522Z","steps":["trace[1372284212] 'read index received' (duration: 67.111412ms)","trace[1372284212] 'applied index is now lower than readState.Index' (duration: 33.955808ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T01:28:24.195768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.282066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1013"} {"level":"info","ts":"2026-04-29T01:28:24.195804Z","caller":"traceutil/trace.go:171","msg":"trace[219483686] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:490; }","duration":"101.353038ms","start":"2026-04-29T01:28:24.094434Z","end":"2026-04-29T01:28:24.195787Z","steps":["trace[219483686] 'agreement among raft nodes before linearized reading' (duration: 101.200244ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T01:28:30.333209Z","caller":"traceutil/trace.go:171","msg":"trace[323342312] linearizableReadLoop","detail":"{readStateIndex:589; appliedIndex:588; }","duration":"315.840428ms","start":"2026-04-29T01:28:30.017295Z","end":"2026-04-29T01:28:30.333135Z","steps":["trace[323342312] 'read index received' (duration: 311.983242ms)","trace[323342312] 'applied index is now lower than readState.Index' (duration: 3.848516ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T01:28:30.333585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.25078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-29T01:28:30.333184Z","caller":"traceutil/trace.go:171","msg":"trace[1542140045] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"383.816005ms","start":"2026-04-29T01:28:29.949327Z","end":"2026-04-29T01:28:30.333143Z","steps":["trace[1542140045] 'process raft request' (duration: 380.169924ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T01:28:30.333714Z","caller":"traceutil/trace.go:171","msg":"trace[817782511] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:572; }","duration":"316.433146ms","start":"2026-04-29T01:28:30.017245Z","end":"2026-04-29T01:28:30.333678Z","steps":["trace[817782511] 'agreement among raft nodes before linearized reading' (duration: 316.024314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:28:30.333833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:28:30.017226Z","time spent":"316.571429ms","remote":"127.0.0.1:49448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-29T01:28:30.335739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:28:29.949304Z","time spent":"384.469433ms","remote":"127.0.0.1:49276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T01:28:30.786124Z","caller":"traceutil/trace.go:171","msg":"trace[1085073193] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:590; }","duration":"247.04867ms","start":"2026-04-29T01:28:30.539053Z","end":"2026-04-29T01:28:30.786102Z","steps":["trace[1085073193] 'read index received' (duration: 246.873175ms)","trace[1085073193] 'applied index is now lower than readState.Index' (duration: 174.585µs)"],"step_count":2} {"level":"info","ts":"2026-04-29T01:28:30.786279Z","caller":"traceutil/trace.go:171","msg":"trace[2022206212] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"392.499834ms","start":"2026-04-29T01:28:30.393738Z","end":"2026-04-29T01:28:30.786238Z","steps":["trace[2022206212] 'process raft request' (duration: 392.245557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:28:30.786383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.306917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-29T01:28:30.786429Z","caller":"traceutil/trace.go:171","msg":"trace[1946066095] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:574; }","duration":"247.416249ms","start":"2026-04-29T01:28:30.539002Z","end":"2026-04-29T01:28:30.786418Z","steps":["trace[1946066095] 'agreement among raft nodes before linearized reading' (duration: 247.218054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:28:30.7864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.69949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jrchp\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-04-29T01:28:30.786438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T01:28:30.39371Z","time spent":"392.652209ms","remote":"127.0.0.1:49686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-29T01:28:30.786485Z","caller":"traceutil/trace.go:171","msg":"trace[1675895145] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jrchp; range_end:; response_count:1; response_revision:574; }","duration":"246.807413ms","start":"2026-04-29T01:28:30.539662Z","end":"2026-04-29T01:28:30.786469Z","steps":["trace[1675895145] 'agreement among raft nodes before linearized reading' (duration: 246.592597ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:28:46.273562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.605403ms","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-29T01:28:46.273628Z","caller":"traceutil/trace.go:171","msg":"trace[1355891365] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:733; }","duration":"198.715656ms","start":"2026-04-29T01:28:46.074891Z","end":"2026-04-29T01:28:46.273607Z","steps":["trace[1355891365] 'range keys from in-memory index tree' (duration: 198.408657ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T01:29:20.564422Z","caller":"traceutil/trace.go:171","msg":"trace[390714960] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"102.306454ms","start":"2026-04-29T01:29:20.462078Z","end":"2026-04-29T01:29:20.564384Z","steps":["trace[390714960] 'process raft request' (duration: 102.040587ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T01:29:49.348986Z","caller":"traceutil/trace.go:171","msg":"trace[1299337437] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"122.710185ms","start":"2026-04-29T01:29:49.226238Z","end":"2026-04-29T01:29:49.348948Z","steps":["trace[1299337437] 'process raft request' (duration: 115.200078ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T01:30:01.889131Z","caller":"traceutil/trace.go:171","msg":"trace[2077090471] linearizableReadLoop","detail":"{readStateIndex:1176; appliedIndex:1175; }","duration":"187.797826ms","start":"2026-04-29T01:30:01.701305Z","end":"2026-04-29T01:30:01.889103Z","steps":["trace[2077090471] 'read index received' (duration: 187.529948ms)","trace[2077090471] 'applied index is now lower than readState.Index' (duration: 266.698µs)"],"step_count":2} {"level":"info","ts":"2026-04-29T01:30:01.889192Z","caller":"traceutil/trace.go:171","msg":"trace[464138800] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"271.189589ms","start":"2026-04-29T01:30:01.617978Z","end":"2026-04-29T01:30:01.889167Z","steps":["trace[464138800] 'process raft request' (duration: 270.930002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T01:30:01.889327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.002611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-29T01:30:01.889365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.183705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T01:30:01.889389Z","caller":"traceutil/trace.go:171","msg":"trace[1535220170] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1137; }","duration":"100.257927ms","start":"2026-04-29T01:30:01.789124Z","end":"2026-04-29T01:30:01.889382Z","steps":["trace[1535220170] 'agreement among raft nodes before linearized reading' (duration: 100.193905ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T01:30:01.889387Z","caller":"traceutil/trace.go:171","msg":"trace[837743890] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1137; }","duration":"188.105194ms","start":"2026-04-29T01:30:01.701268Z","end":"2026-04-29T01:30:01.889373Z","steps":["trace[837743890] 'agreement among raft nodes before linearized reading' (duration: 187.97074ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T01:30:01.996874Z","caller":"traceutil/trace.go:171","msg":"trace[383760660] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"103.318111ms","start":"2026-04-29T01:30:01.89353Z","end":"2026-04-29T01:30:01.996848Z","steps":["trace[383760660] 'process raft request' (duration: 102.478928ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T01:30:18.164453Z","caller":"traceutil/trace.go:171","msg":"trace[1410849218] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"121.08323ms","start":"2026-04-29T01:30:18.042794Z","end":"2026-04-29T01:30:18.163877Z","steps":["trace[1410849218] 'process raft request' (duration: 88.654568ms)","trace[1410849218] 'compare' (duration: 32.235377ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T01:30:18.177211Z","caller":"traceutil/trace.go:171","msg":"trace[183212126] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"131.509037ms","start":"2026-04-29T01:30:18.045685Z","end":"2026-04-29T01:30:18.177194Z","steps":["trace[183212126] 'process raft request' (duration: 131.386634ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T01:30:18.177501Z","caller":"traceutil/trace.go:171","msg":"trace[813245018] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"129.505302ms","start":"2026-04-29T01:30:18.04797Z","end":"2026-04-29T01:30:18.177476Z","steps":["trace[813245018] 'process raft request' (duration: 129.183543ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T01:30:18.177643Z","caller":"traceutil/trace.go:171","msg":"trace[729955330] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"127.318102ms","start":"2026-04-29T01:30:18.050307Z","end":"2026-04-29T01:30:18.177625Z","steps":["trace[729955330] 'process raft request' (duration: 127.072795ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T01:30:31.214232Z","caller":"traceutil/trace.go:171","msg":"trace[408895594] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"165.466357ms","start":"2026-04-29T01:30:31.048736Z","end":"2026-04-29T01:30:31.214203Z","steps":["trace[408895594] 'process raft request' (duration: 165.241411ms)"],"step_count":1}