{"level":"warn","ts":"2026-04-13T16:56:23.213176Z","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-13T16:56:23.213288Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.85: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.85:2380","--initial-cluster=instance=https://199.19.213.85:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.85:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.85: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-13T16:56:23.213367Z","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-13T16:56:23.213386Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.85:2380"]} {"level":"info","ts":"2026-04-13T16:56:23.213455Z","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-13T16:56:23.214412Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.85:2379"]} {"level":"info","ts":"2026-04-13T16:56:23.214512Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.85:2380"],"listen-peer-urls":["https://199.19.213.85:2380"],"advertise-client-urls":["https://199.19.213.85:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.85:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.85: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-13T16:56:23.219375Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.520496ms"} {"level":"info","ts":"2026-04-13T16:56:23.226205Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6a0c678c4e560a44","cluster-id":"dbaaf49260b7a32b"} {"level":"info","ts":"2026-04-13T16:56:23.2263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T16:56:23.22634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 became follower at term 0"} {"level":"info","ts":"2026-04-13T16:56:23.226357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6a0c678c4e560a44 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T16:56:23.226372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 became follower at term 1"} {"level":"info","ts":"2026-04-13T16:56:23.226424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 switched to configuration voters=(7641596520048233028)"} {"level":"warn","ts":"2026-04-13T16:56:23.237923Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T16:56:23.239389Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T16:56:23.240272Z","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-13T16:56:23.242645Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6a0c678c4e560a44","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T16:56:23.242824Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6a0c678c4e560a44","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T16:56:23.242987Z","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-13T16:56:23.243026Z","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-13T16:56:23.243074Z","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-13T16:56:23.246559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 switched to configuration voters=(7641596520048233028)"} {"level":"info","ts":"2026-04-13T16:56:23.246767Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dbaaf49260b7a32b","local-member-id":"6a0c678c4e560a44","added-peer-id":"6a0c678c4e560a44","added-peer-peer-urls":["https://199.19.213.85:2380"]} {"level":"info","ts":"2026-04-13T16:56:23.248379Z","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-13T16:56:23.248749Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6a0c678c4e560a44","initial-advertise-peer-urls":["https://199.19.213.85:2380"],"listen-peer-urls":["https://199.19.213.85:2380"],"advertise-client-urls":["https://199.19.213.85:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.85:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T16:56:23.248798Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T16:56:23.249684Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.85:2380"} {"level":"info","ts":"2026-04-13T16:56:23.249728Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.85:2380"} {"level":"info","ts":"2026-04-13T16:56:23.327033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T16:56:23.327122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T16:56:23.32715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 received MsgPreVoteResp from 6a0c678c4e560a44 at term 1"} {"level":"info","ts":"2026-04-13T16:56:23.327171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 became candidate at term 2"} {"level":"info","ts":"2026-04-13T16:56:23.327183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 received MsgVoteResp from 6a0c678c4e560a44 at term 2"} {"level":"info","ts":"2026-04-13T16:56:23.327205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 became leader at term 2"} {"level":"info","ts":"2026-04-13T16:56:23.327229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6a0c678c4e560a44 elected leader 6a0c678c4e560a44 at term 2"} {"level":"info","ts":"2026-04-13T16:56:23.328408Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T16:56:23.329093Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T16:56:23.329122Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T16:56:23.329087Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6a0c678c4e560a44","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.85:2379]}","request-path":"/0/members/6a0c678c4e560a44/attributes","cluster-id":"dbaaf49260b7a32b","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T16:56:23.329485Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T16:56:23.329599Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T16:56:23.332785Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-13T16:56:23.33305Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.85:2379"} {"level":"info","ts":"2026-04-13T16:56:23.33446Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dbaaf49260b7a32b","local-member-id":"6a0c678c4e560a44","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T16:56:23.334629Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T16:56:23.334672Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-13T16:56:42.067618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.168246ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-04-13T16:56:47.211616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.208671ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T16:56:47.211756Z","caller":"traceutil/trace.go:171","msg":"trace[998904254] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"151.56136ms","start":"2026-04-13T16:56:47.060176Z","end":"2026-04-13T16:56:47.211737Z","steps":["trace[998904254] 'compare' (duration: 148.033458ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:56:48.273685Z","caller":"traceutil/trace.go:171","msg":"trace[521062685] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"138.059288ms","start":"2026-04-13T16:56:48.135608Z","end":"2026-04-13T16:56:48.273667Z","steps":["trace[521062685] 'process raft request' (duration: 137.935886ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:56:48.27819Z","caller":"traceutil/trace.go:171","msg":"trace[285491942] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"136.259092ms","start":"2026-04-13T16:56:48.141918Z","end":"2026-04-13T16:56:48.278177Z","steps":["trace[285491942] 'process raft request' (duration: 136.16011ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:56:48.27818Z","caller":"traceutil/trace.go:171","msg":"trace[609661088] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"141.862906ms","start":"2026-04-13T16:56:48.136285Z","end":"2026-04-13T16:56:48.278148Z","steps":["trace[609661088] 'process raft request' (duration: 141.701473ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:56:48.278268Z","caller":"traceutil/trace.go:171","msg":"trace[1502160000] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"132.421074ms","start":"2026-04-13T16:56:48.145841Z","end":"2026-04-13T16:56:48.278262Z","steps":["trace[1502160000] 'process raft request' (duration: 132.269201ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:56:48.278344Z","caller":"traceutil/trace.go:171","msg":"trace[1694232511] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"130.401072ms","start":"2026-04-13T16:56:48.147915Z","end":"2026-04-13T16:56:48.278316Z","steps":["trace[1694232511] 'process raft request' (duration: 130.226578ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:56:48.278434Z","caller":"traceutil/trace.go:171","msg":"trace[1074259168] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"129.640237ms","start":"2026-04-13T16:56:48.14877Z","end":"2026-04-13T16:56:48.27841Z","steps":["trace[1074259168] 'process raft request' (duration: 129.415792ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:56:48.278607Z","caller":"traceutil/trace.go:171","msg":"trace[2012784616] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"129.638445ms","start":"2026-04-13T16:56:48.148961Z","end":"2026-04-13T16:56:48.278599Z","steps":["trace[2012784616] 'process raft request' (duration: 129.255928ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:56:48.278745Z","caller":"traceutil/trace.go:171","msg":"trace[646930869] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"127.614255ms","start":"2026-04-13T16:56:48.151083Z","end":"2026-04-13T16:56:48.278697Z","steps":["trace[646930869] 'process raft request' (duration: 127.442082ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:56:48.278765Z","caller":"traceutil/trace.go:171","msg":"trace[1151954293] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"110.641337ms","start":"2026-04-13T16:56:48.168117Z","end":"2026-04-13T16:56:48.278758Z","steps":["trace[1151954293] 'process raft request' (duration: 110.483463ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:56:48.27881Z","caller":"traceutil/trace.go:171","msg":"trace[1036205122] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"101.55713ms","start":"2026-04-13T16:56:48.177239Z","end":"2026-04-13T16:56:48.278796Z","steps":["trace[1036205122] 'process raft request' (duration: 101.438748ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:56:54.753619Z","caller":"traceutil/trace.go:171","msg":"trace[1176952655] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"139.59369ms","start":"2026-04-13T16:56:54.614006Z","end":"2026-04-13T16:56:54.753599Z","steps":["trace[1176952655] 'process raft request' (duration: 139.123281ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:56:55.116685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.05055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-13T16:56:55.116699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.924847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T16:56:55.116797Z","caller":"traceutil/trace.go:171","msg":"trace[199502424] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:605; }","duration":"118.253394ms","start":"2026-04-13T16:56:54.998513Z","end":"2026-04-13T16:56:55.116767Z","steps":["trace[199502424] 'range keys from in-memory index tree' (duration: 117.843597ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:56:55.116843Z","caller":"traceutil/trace.go:171","msg":"trace[202260277] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:605; }","duration":"259.172852ms","start":"2026-04-13T16:56:54.857637Z","end":"2026-04-13T16:56:55.11681Z","steps":["trace[202260277] 'range keys from in-memory index tree' (duration: 258.809975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:56:55.602698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.110797ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T16:56:55.602786Z","caller":"traceutil/trace.go:171","msg":"trace[1934324714] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"463.706403ms","start":"2026-04-13T16:56:55.139065Z","end":"2026-04-13T16:56:55.602771Z","steps":["trace[1934324714] 'process raft request' (duration: 210.467483ms)","trace[1934324714] 'compare' (duration: 253.018055ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T16:56:55.602824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:56:55.139035Z","time spent":"463.775124ms","remote":"127.0.0.1:55546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T16:56:55.611997Z","caller":"traceutil/trace.go:171","msg":"trace[760269390] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:625; }","duration":"453.280906ms","start":"2026-04-13T16:56:55.158694Z","end":"2026-04-13T16:56:55.611975Z","steps":["trace[760269390] 'read index received' (duration: 190.834523ms)","trace[760269390] 'applied index is now lower than readState.Index' (duration: 262.444713ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T16:56:55.612051Z","caller":"traceutil/trace.go:171","msg":"trace[1826395443] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"472.250703ms","start":"2026-04-13T16:56:55.139771Z","end":"2026-04-13T16:56:55.612022Z","steps":["trace[1826395443] 'process raft request' (duration: 472.11638ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:56:55.612091Z","caller":"traceutil/trace.go:171","msg":"trace[1542277336] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"472.352695ms","start":"2026-04-13T16:56:55.13972Z","end":"2026-04-13T16:56:55.612073Z","steps":["trace[1542277336] 'process raft request' (duration: 471.825634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:56:55.612162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:56:55.13975Z","time spent":"472.337424ms","remote":"127.0.0.1:55546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-13T16:56:55.612205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.505101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vmqqv\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-04-13T16:56:55.612205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.502842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-13T16:56:55.612216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.907765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-13T16:56:55.612247Z","caller":"traceutil/trace.go:171","msg":"trace[1221462341] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vmqqv; range_end:; response_count:1; response_revision:611; }","duration":"453.587122ms","start":"2026-04-13T16:56:55.158649Z","end":"2026-04-13T16:56:55.612236Z","steps":["trace[1221462341] 'agreement among raft nodes before linearized reading' (duration: 453.438229ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:56:55.612276Z","caller":"traceutil/trace.go:171","msg":"trace[923327181] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:611; }","duration":"276.603844ms","start":"2026-04-13T16:56:55.335649Z","end":"2026-04-13T16:56:55.612252Z","steps":["trace[923327181] 'agreement among raft nodes before linearized reading' (duration: 276.511223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:56:55.612281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.22603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-13T16:56:55.612303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:56:55.15863Z","time spent":"453.664174ms","remote":"127.0.0.1:55672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-vmqqv\" "} {"level":"info","ts":"2026-04-13T16:56:55.612105Z","caller":"traceutil/trace.go:171","msg":"trace[197651795] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"468.720243ms","start":"2026-04-13T16:56:55.143373Z","end":"2026-04-13T16:56:55.612094Z","steps":["trace[197651795] 'process raft request' (duration: 468.55977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:56:55.612362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:56:55.139689Z","time spent":"472.452546ms","remote":"127.0.0.1:55714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T16:56:55.612312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.873931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-13T16:56:55.612545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T16:56:55.143357Z","time spent":"469.06154ms","remote":"127.0.0.1:55672","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T16:56:55.612348Z","caller":"traceutil/trace.go:171","msg":"trace[1297127690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:611; }","duration":"256.342632ms","start":"2026-04-13T16:56:55.355992Z","end":"2026-04-13T16:56:55.612335Z","steps":["trace[1297127690] 'agreement among raft nodes before linearized reading' (duration: 256.182129ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:56:55.612749Z","caller":"traceutil/trace.go:171","msg":"trace[699514575] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:611; }","duration":"153.204487ms","start":"2026-04-13T16:56:55.459391Z","end":"2026-04-13T16:56:55.612596Z","steps":["trace[699514575] 'agreement among raft nodes before linearized reading' (duration: 152.83442ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:56:55.613366Z","caller":"traceutil/trace.go:171","msg":"trace[1187807564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:611; }","duration":"244.030148ms","start":"2026-04-13T16:56:55.368242Z","end":"2026-04-13T16:56:55.612272Z","steps":["trace[1187807564] 'agreement among raft nodes before linearized reading' (duration: 243.914616ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:57:11.836051Z","caller":"traceutil/trace.go:171","msg":"trace[1334657297] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"137.855128ms","start":"2026-04-13T16:57:11.698169Z","end":"2026-04-13T16:57:11.836024Z","steps":["trace[1334657297] 'process raft request' (duration: 137.697755ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:57:11.864911Z","caller":"traceutil/trace.go:171","msg":"trace[490621552] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"166.607042ms","start":"2026-04-13T16:57:11.698274Z","end":"2026-04-13T16:57:11.864881Z","steps":["trace[490621552] 'process raft request' (duration: 166.408908ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:57:11.866086Z","caller":"traceutil/trace.go:171","msg":"trace[408801975] linearizableReadLoop","detail":"{readStateIndex:796; appliedIndex:794; }","duration":"166.602863ms","start":"2026-04-13T16:57:11.699464Z","end":"2026-04-13T16:57:11.866067Z","steps":["trace[408801975] 'read index received' (duration: 136.510474ms)","trace[408801975] 'applied index is now lower than readState.Index' (duration: 30.091459ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T16:57:11.866257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.768606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-13T16:57:11.866286Z","caller":"traceutil/trace.go:171","msg":"trace[557062549] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:774; }","duration":"166.838177ms","start":"2026-04-13T16:57:11.699438Z","end":"2026-04-13T16:57:11.866276Z","steps":["trace[557062549] 'agreement among raft nodes before linearized reading' (duration: 166.710185ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T16:58:29.794786Z","caller":"traceutil/trace.go:171","msg":"trace[1749847899] linearizableReadLoop","detail":"{readStateIndex:1167; appliedIndex:1166; }","duration":"183.500277ms","start":"2026-04-13T16:58:29.611265Z","end":"2026-04-13T16:58:29.794766Z","steps":["trace[1749847899] 'read index received' (duration: 183.274273ms)","trace[1749847899] 'applied index is now lower than readState.Index' (duration: 225.424µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T16:58:29.794863Z","caller":"traceutil/trace.go:171","msg":"trace[1086783519] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"197.657897ms","start":"2026-04-13T16:58:29.597171Z","end":"2026-04-13T16:58:29.794829Z","steps":["trace[1086783519] 'process raft request' (duration: 197.473433ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:58:29.794954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.674609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-13T16:58:29.794985Z","caller":"traceutil/trace.go:171","msg":"trace[1810895970] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1129; }","duration":"183.74536ms","start":"2026-04-13T16:58:29.611233Z","end":"2026-04-13T16:58:29.794978Z","steps":["trace[1810895970] 'agreement among raft nodes before linearized reading' (duration: 183.636639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T16:58:30.539066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.445036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T16:58:30.539136Z","caller":"traceutil/trace.go:171","msg":"trace[2112839212] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1133; }","duration":"118.569837ms","start":"2026-04-13T16:58:30.420551Z","end":"2026-04-13T16:58:30.539121Z","steps":["trace[2112839212] 'range keys from in-memory index tree' (duration: 118.346375ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:03:20.538974Z","caller":"traceutil/trace.go:171","msg":"trace[1932085545] transaction","detail":"{read_only:false; response_revision:2531; number_of_response:1; }","duration":"194.171934ms","start":"2026-04-13T17:03:20.344737Z","end":"2026-04-13T17:03:20.538908Z","steps":["trace[1932085545] 'process raft request' (duration: 193.956319ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:03:20.569442Z","caller":"traceutil/trace.go:171","msg":"trace[2123289472] transaction","detail":"{read_only:false; response_revision:2532; number_of_response:1; }","duration":"202.45178ms","start":"2026-04-13T17:03:20.366968Z","end":"2026-04-13T17:03:20.56942Z","steps":["trace[2123289472] 'process raft request' (duration: 202.350308ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:03:21.284504Z","caller":"traceutil/trace.go:171","msg":"trace[2127805440] transaction","detail":"{read_only:false; response_revision:2541; number_of_response:1; }","duration":"110.350271ms","start":"2026-04-13T17:03:21.174121Z","end":"2026-04-13T17:03:21.284472Z","steps":["trace[2127805440] 'process raft request' (duration: 109.496791ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:03:21.663606Z","caller":"traceutil/trace.go:171","msg":"trace[129034294] linearizableReadLoop","detail":"{readStateIndex:2642; appliedIndex:2641; }","duration":"143.53206ms","start":"2026-04-13T17:03:21.520029Z","end":"2026-04-13T17:03:21.663561Z","steps":["trace[129034294] 'read index received' (duration: 143.343916ms)","trace[129034294] 'applied index is now lower than readState.Index' (duration: 187.244µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:03:21.663667Z","caller":"traceutil/trace.go:171","msg":"trace[483474688] transaction","detail":"{read_only:false; response_revision:2542; number_of_response:1; }","duration":"164.341634ms","start":"2026-04-13T17:03:21.4993Z","end":"2026-04-13T17:03:21.663642Z","steps":["trace[483474688] 'process raft request' (duration: 164.126629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:03:21.663813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.767506ms","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-13T17:03:21.663873Z","caller":"traceutil/trace.go:171","msg":"trace[1099574729] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2542; }","duration":"143.891439ms","start":"2026-04-13T17:03:21.519967Z","end":"2026-04-13T17:03:21.663859Z","steps":["trace[1099574729] 'agreement among raft nodes before linearized reading' (duration: 143.704715ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:03:21.807164Z","caller":"traceutil/trace.go:171","msg":"trace[2125930880] transaction","detail":"{read_only:false; response_revision:2543; number_of_response:1; }","duration":"139.504306ms","start":"2026-04-13T17:03:21.667643Z","end":"2026-04-13T17:03:21.807148Z","steps":["trace[2125930880] 'process raft request' (duration: 107.71097ms)","trace[2125930880] 'compare' (duration: 31.568581ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:03:21.80718Z","caller":"traceutil/trace.go:171","msg":"trace[1352825797] transaction","detail":"{read_only:false; response_revision:2544; number_of_response:1; }","duration":"139.457234ms","start":"2026-04-13T17:03:21.667698Z","end":"2026-04-13T17:03:21.807156Z","steps":["trace[1352825797] 'process raft request' (duration: 139.388403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:03:30.918763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.790961ms","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:7"} {"level":"info","ts":"2026-04-13T17:03:30.918841Z","caller":"traceutil/trace.go:171","msg":"trace[1750861800] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:2630; }","duration":"346.924645ms","start":"2026-04-13T17:03:30.571898Z","end":"2026-04-13T17:03:30.918822Z","steps":["trace[1750861800] 'count revisions from in-memory index tree' (duration: 346.652068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:03:30.918885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:03:30.571878Z","time spent":"346.995256ms","remote":"127.0.0.1:55502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":58,"response size":30,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-04-13T17:03:30.918887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.986017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-13T17:03:30.918987Z","caller":"traceutil/trace.go:171","msg":"trace[1505196143] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2630; }","duration":"167.124541ms","start":"2026-04-13T17:03:30.751842Z","end":"2026-04-13T17:03:30.918967Z","steps":["trace[1505196143] 'range keys from in-memory index tree' (duration: 166.801683ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:03:31.478069Z","caller":"traceutil/trace.go:171","msg":"trace[502181444] transaction","detail":"{read_only:false; response_revision:2633; number_of_response:1; }","duration":"147.376853ms","start":"2026-04-13T17:03:31.330671Z","end":"2026-04-13T17:03:31.478048Z","steps":["trace[502181444] 'process raft request' (duration: 147.207279ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:03:33.612044Z","caller":"traceutil/trace.go:171","msg":"trace[141146506] transaction","detail":"{read_only:false; response_revision:2642; number_of_response:1; }","duration":"126.052265ms","start":"2026-04-13T17:03:33.485971Z","end":"2026-04-13T17:03:33.612023Z","steps":["trace[141146506] 'process raft request' (duration: 125.921342ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:03:37.091765Z","caller":"traceutil/trace.go:171","msg":"trace[1473981686] transaction","detail":"{read_only:false; response_revision:2758; number_of_response:1; }","duration":"123.664149ms","start":"2026-04-13T17:03:36.968064Z","end":"2026-04-13T17:03:37.091728Z","steps":["trace[1473981686] 'process raft request' (duration: 123.354242ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:03:37.230798Z","caller":"traceutil/trace.go:171","msg":"trace[2087016946] transaction","detail":"{read_only:false; response_revision:2759; number_of_response:1; }","duration":"135.810667ms","start":"2026-04-13T17:03:37.094962Z","end":"2026-04-13T17:03:37.230773Z","steps":["trace[2087016946] 'process raft request' (duration: 36.871156ms)","trace[2087016946] 'compare' (duration: 98.675975ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:03:53.645496Z","caller":"traceutil/trace.go:171","msg":"trace[239529785] transaction","detail":"{read_only:false; response_revision:2846; number_of_response:1; }","duration":"127.88019ms","start":"2026-04-13T17:03:53.517591Z","end":"2026-04-13T17:03:53.645471Z","steps":["trace[239529785] 'process raft request' (duration: 127.733456ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T17:03:55.265586Z","caller":"traceutil/trace.go:171","msg":"trace[809324760] transaction","detail":"{read_only:false; response_revision:2851; number_of_response:1; }","duration":"115.651248ms","start":"2026-04-13T17:03:55.14991Z","end":"2026-04-13T17:03:55.265561Z","steps":["trace[809324760] 'process raft request' (duration: 115.474564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:03:55.636764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.782762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-13T17:03:55.636833Z","caller":"traceutil/trace.go:171","msg":"trace[1868053531] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2851; }","duration":"333.906784ms","start":"2026-04-13T17:03:55.302913Z","end":"2026-04-13T17:03:55.63682Z","steps":["trace[1868053531] 'range keys from in-memory index tree' (duration: 333.585086ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:03:55.63686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:03:55.302892Z","time spent":"333.962216ms","remote":"127.0.0.1:55734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-13T17:03:55.636832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.132424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T17:03:55.636939Z","caller":"traceutil/trace.go:171","msg":"trace[435368408] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2851; }","duration":"303.497433ms","start":"2026-04-13T17:03:55.333408Z","end":"2026-04-13T17:03:55.636905Z","steps":["trace[435368408] 'range keys from in-memory index tree' (duration: 303.051102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T17:03:55.637019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T17:03:55.333385Z","time spent":"303.617436ms","remote":"127.0.0.1:55464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-13T17:03:56.19294Z","caller":"traceutil/trace.go:171","msg":"trace[1419104860] linearizableReadLoop","detail":"{readStateIndex:2964; appliedIndex:2962; }","duration":"146.03252ms","start":"2026-04-13T17:03:56.04687Z","end":"2026-04-13T17:03:56.192903Z","steps":["trace[1419104860] 'read index received' (duration: 27.167976ms)","trace[1419104860] 'applied index is now lower than readState.Index' (duration: 118.863434ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T17:03:56.19315Z","caller":"traceutil/trace.go:171","msg":"trace[1245294789] transaction","detail":"{read_only:false; response_revision:2855; number_of_response:1; }","duration":"172.55005ms","start":"2026-04-13T17:03:56.020572Z","end":"2026-04-13T17:03:56.193122Z","steps":["trace[1245294789] 'process raft request' (duration: 115.884484ms)","trace[1245294789] 'compare' (duration: 56.256666ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T17:03:56.193217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.314386ms","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-13T17:03:56.193258Z","caller":"traceutil/trace.go:171","msg":"trace[770448024] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2855; }","duration":"146.417829ms","start":"2026-04-13T17:03:56.046829Z","end":"2026-04-13T17:03:56.193247Z","steps":["trace[770448024] 'agreement among raft nodes before linearized reading' (duration: 146.218024ms)"],"step_count":1}