{"level":"warn","ts":"2026-07-16T06:51:26.559865Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-16T06:51:26.560595Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.63: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.19.213.63:2380","--initial-cluster=instance=https://199.19.213.63:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.63:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.63: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-07-16T06:51:26.560814Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-16T06:51:26.560841Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.63:2380"]} {"level":"info","ts":"2026-07-16T06:51:26.560872Z","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-07-16T06:51:26.562336Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.63:2379"]} {"level":"info","ts":"2026-07-16T06:51:26.562524Z","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.19.213.63:2380"],"listen-peer-urls":["https://199.19.213.63:2380"],"advertise-client-urls":["https://199.19.213.63:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.63:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.63: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-07-16T06:51:26.568106Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.677342ms"} {"level":"info","ts":"2026-07-16T06:51:26.574186Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d75c480e593e7aed","cluster-id":"24fce67309ccbdc"} {"level":"info","ts":"2026-07-16T06:51:26.57441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed switched to configuration voters=()"} {"level":"info","ts":"2026-07-16T06:51:26.574448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed became follower at term 0"} {"level":"info","ts":"2026-07-16T06:51:26.574488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d75c480e593e7aed [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-16T06:51:26.574503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed became follower at term 1"} {"level":"info","ts":"2026-07-16T06:51:26.574585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed switched to configuration voters=(15518357642475895533)"} {"level":"warn","ts":"2026-07-16T06:51:26.583621Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-16T06:51:26.585296Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-16T06:51:26.586342Z","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-07-16T06:51:26.588711Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d75c480e593e7aed","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-16T06:51:26.589469Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d75c480e593e7aed","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-16T06:51:26.589846Z","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-07-16T06:51:26.589959Z","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-07-16T06:51:26.589976Z","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-07-16T06:51:26.590712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed switched to configuration voters=(15518357642475895533)"} {"level":"info","ts":"2026-07-16T06:51:26.59086Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"24fce67309ccbdc","local-member-id":"d75c480e593e7aed","added-peer-id":"d75c480e593e7aed","added-peer-peer-urls":["https://199.19.213.63:2380"]} {"level":"info","ts":"2026-07-16T06:51:26.593529Z","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-07-16T06:51:26.593803Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d75c480e593e7aed","initial-advertise-peer-urls":["https://199.19.213.63:2380"],"listen-peer-urls":["https://199.19.213.63:2380"],"advertise-client-urls":["https://199.19.213.63:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.63:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-16T06:51:26.593836Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-16T06:51:26.59392Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.63:2380"} {"level":"info","ts":"2026-07-16T06:51:26.593935Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.63:2380"} {"level":"info","ts":"2026-07-16T06:51:26.9754Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed is starting a new election at term 1"} {"level":"info","ts":"2026-07-16T06:51:26.975536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed became pre-candidate at term 1"} {"level":"info","ts":"2026-07-16T06:51:26.975597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed received MsgPreVoteResp from d75c480e593e7aed at term 1"} {"level":"info","ts":"2026-07-16T06:51:26.975621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed became candidate at term 2"} {"level":"info","ts":"2026-07-16T06:51:26.975635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed received MsgVoteResp from d75c480e593e7aed at term 2"} {"level":"info","ts":"2026-07-16T06:51:26.975652Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d75c480e593e7aed became leader at term 2"} {"level":"info","ts":"2026-07-16T06:51:26.975674Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d75c480e593e7aed elected leader d75c480e593e7aed at term 2"} {"level":"info","ts":"2026-07-16T06:51:26.977803Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d75c480e593e7aed","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.63:2379]}","request-path":"/0/members/d75c480e593e7aed/attributes","cluster-id":"24fce67309ccbdc","publish-timeout":"7s"} {"level":"info","ts":"2026-07-16T06:51:26.977851Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-16T06:51:26.977941Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-16T06:51:26.978111Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-16T06:51:26.978173Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-16T06:51:26.978265Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T06:51:26.981772Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-16T06:51:26.982202Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"24fce67309ccbdc","local-member-id":"d75c480e593e7aed","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T06:51:26.982351Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.63:2379"} {"level":"info","ts":"2026-07-16T06:51:26.987019Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T06:51:27.003653Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-16T06:51:28.570143Z","caller":"traceutil/trace.go:171","msg":"trace[215243017] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"179.974373ms","start":"2026-07-16T06:51:28.390138Z","end":"2026-07-16T06:51:28.570113Z","steps":["trace[215243017] 'process raft request' (duration: 179.418092ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:51:28.570312Z","caller":"traceutil/trace.go:171","msg":"trace[127078896] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"112.79386ms","start":"2026-07-16T06:51:28.457492Z","end":"2026-07-16T06:51:28.570286Z","steps":["trace[127078896] 'process raft request' (duration: 112.387642ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:51:28.570883Z","caller":"traceutil/trace.go:171","msg":"trace[1291789499] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"112.953693ms","start":"2026-07-16T06:51:28.457907Z","end":"2026-07-16T06:51:28.570861Z","steps":["trace[1291789499] 'process raft request' (duration: 112.075116ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:51:28.570981Z","caller":"traceutil/trace.go:171","msg":"trace[1742081830] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"176.76715ms","start":"2026-07-16T06:51:28.394195Z","end":"2026-07-16T06:51:28.570962Z","steps":["trace[1742081830] 'read index received' (duration: 69.124231ms)","trace[1742081830] 'applied index is now lower than readState.Index' (duration: 107.642009ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:51:28.57128Z","caller":"traceutil/trace.go:171","msg":"trace[898860835] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"113.163898ms","start":"2026-07-16T06:51:28.458Z","end":"2026-07-16T06:51:28.571163Z","steps":["trace[898860835] 'process raft request' (duration: 112.806391ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:51:28.571365Z","caller":"traceutil/trace.go:171","msg":"trace[480159123] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"113.378741ms","start":"2026-07-16T06:51:28.457971Z","end":"2026-07-16T06:51:28.57135Z","steps":["trace[480159123] 'process raft request' (duration: 112.79713ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:51:28.571366Z","caller":"traceutil/trace.go:171","msg":"trace[975653805] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"113.298899ms","start":"2026-07-16T06:51:28.458054Z","end":"2026-07-16T06:51:28.571353Z","steps":["trace[975653805] 'process raft request' (duration: 112.83996ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:51:28.571462Z","caller":"traceutil/trace.go:171","msg":"trace[610795479] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"113.253569ms","start":"2026-07-16T06:51:28.458194Z","end":"2026-07-16T06:51:28.571448Z","steps":["trace[610795479] 'process raft request' (duration: 112.729619ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:51:28.571624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.399652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-16T06:51:28.572386Z","caller":"traceutil/trace.go:171","msg":"trace[267185691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:9; }","duration":"178.112786ms","start":"2026-07-16T06:51:28.394179Z","end":"2026-07-16T06:51:28.572292Z","steps":["trace[267185691] 'agreement among raft nodes before linearized reading' (duration: 177.338461ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:51:28.572658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.307901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-16T06:51:28.572851Z","caller":"traceutil/trace.go:171","msg":"trace[1489644758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:11; }","duration":"178.469994ms","start":"2026-07-16T06:51:28.394298Z","end":"2026-07-16T06:51:28.572768Z","steps":["trace[1489644758] 'agreement among raft nodes before linearized reading' (duration: 178.230319ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:51:28.573278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.858045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-16T06:51:28.573494Z","caller":"traceutil/trace.go:171","msg":"trace[232476056] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"132.05844ms","start":"2026-07-16T06:51:28.441325Z","end":"2026-07-16T06:51:28.573383Z","steps":["trace[232476056] 'agreement among raft nodes before linearized reading' (duration: 131.860686ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:51:28.57361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.165887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-16T06:51:28.573307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.655439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-16T06:51:28.573653Z","caller":"traceutil/trace.go:171","msg":"trace[543349104] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"117.274249ms","start":"2026-07-16T06:51:28.456367Z","end":"2026-07-16T06:51:28.573642Z","steps":["trace[543349104] 'agreement among raft nodes before linearized reading' (duration: 117.222868ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:51:28.573667Z","caller":"traceutil/trace.go:171","msg":"trace[1429908188] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"171.058017ms","start":"2026-07-16T06:51:28.402599Z","end":"2026-07-16T06:51:28.573657Z","steps":["trace[1429908188] 'agreement among raft nodes before linearized reading' (duration: 170.68989ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:51:28.573528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.146847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-16T06:51:28.573873Z","caller":"traceutil/trace.go:171","msg":"trace[573117796] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"115.534404ms","start":"2026-07-16T06:51:28.45831Z","end":"2026-07-16T06:51:28.573845Z","steps":["trace[573117796] 'agreement among raft nodes before linearized reading' (duration: 115.176648ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:52:12.924442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.298198ms","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-07-16T06:52:12.924512Z","caller":"traceutil/trace.go:171","msg":"trace[239963607] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:596; }","duration":"123.43445ms","start":"2026-07-16T06:52:12.801062Z","end":"2026-07-16T06:52:12.924497Z","steps":["trace[239963607] 'range keys from in-memory index tree' (duration: 123.109485ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:52:13.156908Z","caller":"traceutil/trace.go:171","msg":"trace[357241307] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"201.020832ms","start":"2026-07-16T06:52:12.955852Z","end":"2026-07-16T06:52:13.156873Z","steps":["trace[357241307] 'read index received' (duration: 200.811408ms)","trace[357241307] 'applied index is now lower than readState.Index' (duration: 208.264µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:52:13.156948Z","caller":"traceutil/trace.go:171","msg":"trace[2118477587] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"217.25479ms","start":"2026-07-16T06:52:12.939645Z","end":"2026-07-16T06:52:13.1569Z","steps":["trace[2118477587] 'process raft request' (duration: 216.908064ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:52:13.157275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.004231ms","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-07-16T06:52:13.157339Z","caller":"traceutil/trace.go:171","msg":"trace[1675771527] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:598; }","duration":"228.111572ms","start":"2026-07-16T06:52:12.92921Z","end":"2026-07-16T06:52:13.157321Z","steps":["trace[1675771527] 'agreement among raft nodes before linearized reading' (duration: 227.813167ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:52:13.361948Z","caller":"traceutil/trace.go:171","msg":"trace[1194490614] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"401.302129ms","start":"2026-07-16T06:52:12.960601Z","end":"2026-07-16T06:52:13.361904Z","steps":["trace[1194490614] 'process raft request' (duration: 400.166567ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:52:13.362687Z","caller":"traceutil/trace.go:171","msg":"trace[1416058548] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:620; }","duration":"205.59392ms","start":"2026-07-16T06:52:13.157071Z","end":"2026-07-16T06:52:13.362665Z","steps":["trace[1416058548] 'read index received' (duration: 203.764855ms)","trace[1416058548] 'applied index is now lower than readState.Index' (duration: 1.827945ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:52:13.362915Z","caller":"traceutil/trace.go:171","msg":"trace[500618972] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"259.307523ms","start":"2026-07-16T06:52:13.103559Z","end":"2026-07-16T06:52:13.362866Z","steps":["trace[500618972] 'process raft request' (duration: 257.864195ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:52:13.363199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.156863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-16T06:52:13.363279Z","caller":"traceutil/trace.go:171","msg":"trace[100483060] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:600; }","duration":"381.296506ms","start":"2026-07-16T06:52:12.981944Z","end":"2026-07-16T06:52:13.36324Z","steps":["trace[100483060] 'agreement among raft nodes before linearized reading' (duration: 380.99704ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:52:13.363399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:52:12.981917Z","time spent":"381.47098ms","remote":"127.0.0.1:42496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-16T06:52:13.363974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:52:12.960575Z","time spent":"401.473321ms","remote":"127.0.0.1:42496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-16T06:52:13.393228Z","caller":"traceutil/trace.go:171","msg":"trace[2050509193] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"229.372377ms","start":"2026-07-16T06:52:13.163822Z","end":"2026-07-16T06:52:13.393194Z","steps":["trace[2050509193] 'process raft request' (duration: 229.149393ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:52:13.393535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.834352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T06:52:13.393659Z","caller":"traceutil/trace.go:171","msg":"trace[997149170] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"140.155528ms","start":"2026-07-16T06:52:13.253437Z","end":"2026-07-16T06:52:13.393593Z","steps":["trace[997149170] 'agreement among raft nodes before linearized reading' (duration: 139.842712ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:52:13.818123Z","caller":"traceutil/trace.go:171","msg":"trace[522661176] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"384.52514ms","start":"2026-07-16T06:52:13.43344Z","end":"2026-07-16T06:52:13.817965Z","steps":["trace[522661176] 'process raft request' (duration: 347.843381ms)","trace[522661176] 'compare' (duration: 36.167279ms)"],"step_count":2} {"level":"warn","ts":"2026-07-16T06:52:13.818259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:52:13.433401Z","time spent":"384.793546ms","remote":"127.0.0.1:42754","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-07-16T06:53:28.386402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.708364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T06:53:28.386525Z","caller":"traceutil/trace.go:171","msg":"trace[1219363659] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1059; }","duration":"133.933839ms","start":"2026-07-16T06:53:28.252563Z","end":"2026-07-16T06:53:28.386496Z","steps":["trace[1219363659] 'range keys from in-memory index tree' (duration: 133.52245ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:53:45.971937Z","caller":"traceutil/trace.go:171","msg":"trace[1176514799] linearizableReadLoop","detail":"{readStateIndex:1211; appliedIndex:1210; }","duration":"266.58853ms","start":"2026-07-16T06:53:45.705315Z","end":"2026-07-16T06:53:45.971903Z","steps":["trace[1176514799] 'read index received' (duration: 266.338695ms)","trace[1176514799] 'applied index is now lower than readState.Index' (duration: 248.284µs)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:53:45.971999Z","caller":"traceutil/trace.go:171","msg":"trace[1096343801] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"415.857859ms","start":"2026-07-16T06:53:45.556101Z","end":"2026-07-16T06:53:45.971959Z","steps":["trace[1096343801] 'process raft request' (duration: 415.588033ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:53:45.972219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-16T06:53:45.556088Z","time spent":"416.014811ms","remote":"127.0.0.1:42496","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-16T06:53:45.972207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.861015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-16T06:53:45.972337Z","caller":"traceutil/trace.go:171","msg":"trace[1590478360] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1165; }","duration":"267.017988ms","start":"2026-07-16T06:53:45.705296Z","end":"2026-07-16T06:53:45.972314Z","steps":["trace[1590478360] 'agreement among raft nodes before linearized reading' (duration: 266.782474ms)"],"step_count":1} {"level":"warn","ts":"2026-07-16T06:54:04.528955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.338857ms","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-07-16T06:54:04.529027Z","caller":"traceutil/trace.go:171","msg":"trace[2119675055] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1255; }","duration":"110.468989ms","start":"2026-07-16T06:54:04.418541Z","end":"2026-07-16T06:54:04.52901Z","steps":["trace[2119675055] 'range keys from in-memory index tree' (duration: 110.166824ms)"],"step_count":1} {"level":"info","ts":"2026-07-16T06:55:47.110081Z","caller":"traceutil/trace.go:171","msg":"trace[1642795349] transaction","detail":"{read_only:false; response_revision:1749; number_of_response:1; }","duration":"133.75905ms","start":"2026-07-16T06:55:46.976297Z","end":"2026-07-16T06:55:47.110056Z","steps":["trace[1642795349] 'process raft request' (duration: 60.197831ms)","trace[1642795349] 'compare' (duration: 73.212413ms)"],"step_count":2} {"level":"info","ts":"2026-07-16T06:55:48.833345Z","caller":"traceutil/trace.go:171","msg":"trace[303734474] transaction","detail":"{read_only:false; response_revision:1755; number_of_response:1; }","duration":"102.011789ms","start":"2026-07-16T06:55:48.731273Z","end":"2026-07-16T06:55:48.833284Z","steps":["trace[303734474] 'process raft request' (duration: 101.727533ms)"],"step_count":1}