{"level":"warn","ts":"2026-05-31T20:43:21.58602Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-31T20:43:21.586153Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.147: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.147:2380","--initial-cluster=instance=https://199.19.213.147:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.147:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.147: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-05-31T20:43:21.58625Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-31T20:43:21.586286Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.147:2380"]} {"level":"info","ts":"2026-05-31T20:43:21.586318Z","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-05-31T20:43:21.587107Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"]} {"level":"info","ts":"2026-05-31T20:43:21.587256Z","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.147:2380"],"listen-peer-urls":["https://199.19.213.147:2380"],"advertise-client-urls":["https://199.19.213.147:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.147: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-05-31T20:43:21.591896Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.403627ms"} {"level":"info","ts":"2026-05-31T20:43:21.599654Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6244e483e416226f","cluster-id":"68a374eab3e2de92"} {"level":"info","ts":"2026-05-31T20:43:21.59975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=()"} {"level":"info","ts":"2026-05-31T20:43:21.599804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became follower at term 0"} {"level":"info","ts":"2026-05-31T20:43:21.59985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6244e483e416226f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-31T20:43:21.59988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became follower at term 1"} {"level":"info","ts":"2026-05-31T20:43:21.599954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=(7081035769251766895)"} {"level":"warn","ts":"2026-05-31T20:43:21.60712Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-31T20:43:21.608688Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-31T20:43:21.609791Z","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-05-31T20:43:21.612364Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6244e483e416226f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-31T20:43:21.612997Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6244e483e416226f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-31T20:43:21.613155Z","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-05-31T20:43:21.613204Z","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-05-31T20:43:21.613219Z","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-05-31T20:43:21.618066Z","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-05-31T20:43:21.618395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f switched to configuration voters=(7081035769251766895)"} {"level":"info","ts":"2026-05-31T20:43:21.618404Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.147:2380"} {"level":"info","ts":"2026-05-31T20:43:21.61854Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.147:2380"} {"level":"info","ts":"2026-05-31T20:43:21.618584Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"68a374eab3e2de92","local-member-id":"6244e483e416226f","added-peer-id":"6244e483e416226f","added-peer-peer-urls":["https://199.19.213.147:2380"]} {"level":"info","ts":"2026-05-31T20:43:21.61889Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6244e483e416226f","initial-advertise-peer-urls":["https://199.19.213.147:2380"],"listen-peer-urls":["https://199.19.213.147:2380"],"advertise-client-urls":["https://199.19.213.147:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.147:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-31T20:43:21.618938Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-31T20:43:21.900558Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f is starting a new election at term 1"} {"level":"info","ts":"2026-05-31T20:43:21.900618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became pre-candidate at term 1"} {"level":"info","ts":"2026-05-31T20:43:21.900655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f received MsgPreVoteResp from 6244e483e416226f at term 1"} {"level":"info","ts":"2026-05-31T20:43:21.900675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became candidate at term 2"} {"level":"info","ts":"2026-05-31T20:43:21.900692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f received MsgVoteResp from 6244e483e416226f at term 2"} {"level":"info","ts":"2026-05-31T20:43:21.900719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6244e483e416226f became leader at term 2"} {"level":"info","ts":"2026-05-31T20:43:21.900737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6244e483e416226f elected leader 6244e483e416226f at term 2"} {"level":"info","ts":"2026-05-31T20:43:21.90167Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-31T20:43:21.902378Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-31T20:43:21.902378Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6244e483e416226f","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.147:2379]}","request-path":"/0/members/6244e483e416226f/attributes","cluster-id":"68a374eab3e2de92","publish-timeout":"7s"} {"level":"info","ts":"2026-05-31T20:43:21.902484Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-31T20:43:21.902698Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-31T20:43:21.902778Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-31T20:43:21.903089Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"68a374eab3e2de92","local-member-id":"6244e483e416226f","cluster-version":"3.5"} {"level":"info","ts":"2026-05-31T20:43:21.903211Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-31T20:43:21.903253Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-31T20:43:21.907524Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-31T20:43:21.908917Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.147:2379"} {"level":"info","ts":"2026-05-31T20:43:39.93699Z","caller":"traceutil/trace.go:171","msg":"trace[1477097042] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"238.040955ms","start":"2026-05-31T20:43:39.698915Z","end":"2026-05-31T20:43:39.936956Z","steps":["trace[1477097042] 'process raft request' (duration: 161.068622ms)","trace[1477097042] 'compare' (duration: 76.826779ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T20:43:40.328043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.492036ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"warn","ts":"2026-05-31T20:44:03.584621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.956103ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-31T20:44:03.584788Z","caller":"traceutil/trace.go:171","msg":"trace[314832099] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"179.487296ms","start":"2026-05-31T20:44:03.405279Z","end":"2026-05-31T20:44:03.584766Z","steps":["trace[314832099] 'read index received' (duration: 40.591534ms)","trace[314832099] 'applied index is now lower than readState.Index' (duration: 138.894092ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T20:44:03.58511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.816323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31145"} {"level":"info","ts":"2026-05-31T20:44:03.585182Z","caller":"traceutil/trace.go:171","msg":"trace[63248885] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:632; }","duration":"179.915074ms","start":"2026-05-31T20:44:03.40525Z","end":"2026-05-31T20:44:03.585165Z","steps":["trace[63248885] 'agreement among raft nodes before linearized reading' (duration: 179.68965ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T20:44:03.585057Z","caller":"traceutil/trace.go:171","msg":"trace[1693691479] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"180.640769ms","start":"2026-05-31T20:44:03.40432Z","end":"2026-05-31T20:44:03.584961Z","steps":["trace[1693691479] 'process raft request' (duration: 41.619104ms)","trace[1693691479] 'compare' (duration: 137.75595ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T20:44:03.74782Z","caller":"traceutil/trace.go:171","msg":"trace[659546624] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"138.862451ms","start":"2026-05-31T20:44:03.608927Z","end":"2026-05-31T20:44:03.74779Z","steps":["trace[659546624] 'read index received' (duration: 138.647557ms)","trace[659546624] 'applied index is now lower than readState.Index' (duration: 213.534µs)"],"step_count":2} {"level":"info","ts":"2026-05-31T20:44:03.747937Z","caller":"traceutil/trace.go:171","msg":"trace[1080588829] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"147.118055ms","start":"2026-05-31T20:44:03.600777Z","end":"2026-05-31T20:44:03.747895Z","steps":["trace[1080588829] 'process raft request' (duration: 146.83235ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T20:44:03.748274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.3069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31126"} {"level":"info","ts":"2026-05-31T20:44:03.748387Z","caller":"traceutil/trace.go:171","msg":"trace[1343277798] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:633; }","duration":"139.470983ms","start":"2026-05-31T20:44:03.608889Z","end":"2026-05-31T20:44:03.74836Z","steps":["trace[1343277798] 'agreement among raft nodes before linearized reading' (duration: 139.124377ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T20:44:10.078236Z","caller":"traceutil/trace.go:171","msg":"trace[696194590] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"149.182517ms","start":"2026-05-31T20:44:09.929006Z","end":"2026-05-31T20:44:10.078189Z","steps":["trace[696194590] 'process raft request' (duration: 126.682811ms)","trace[696194590] 'compare' (duration: 22.106488ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T20:44:10.354822Z","caller":"traceutil/trace.go:171","msg":"trace[1770446658] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"120.293043ms","start":"2026-05-31T20:44:10.234488Z","end":"2026-05-31T20:44:10.354781Z","steps":["trace[1770446658] 'process raft request' (duration: 115.350346ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T20:44:11.003137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.283727ms","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":"warn","ts":"2026-05-31T20:44:11.003191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.622681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T20:44:11.003228Z","caller":"traceutil/trace.go:171","msg":"trace[1538149391] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:698; }","duration":"210.44351ms","start":"2026-05-31T20:44:10.792766Z","end":"2026-05-31T20:44:11.00321Z","steps":["trace[1538149391] 'range keys from in-memory index tree' (duration: 210.025391ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T20:44:11.003294Z","caller":"traceutil/trace.go:171","msg":"trace[2082751063] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:698; }","duration":"543.758763ms","start":"2026-05-31T20:44:10.459511Z","end":"2026-05-31T20:44:11.00327Z","steps":["trace[2082751063] 'range keys from in-memory index tree' (duration: 543.388007ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T20:44:11.003391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-31T20:44:10.459406Z","time spent":"543.976737ms","remote":"127.0.0.1:39068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-31T20:44:11.004282Z","caller":"traceutil/trace.go:171","msg":"trace[1618596052] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"172.088779ms","start":"2026-05-31T20:44:10.832155Z","end":"2026-05-31T20:44:11.004244Z","steps":["trace[1618596052] 'process raft request' (duration: 171.204302ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T20:44:26.416583Z","caller":"traceutil/trace.go:171","msg":"trace[1346950926] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"111.02279ms","start":"2026-05-31T20:44:26.305522Z","end":"2026-05-31T20:44:26.416545Z","steps":["trace[1346950926] 'process raft request' (duration: 110.799175ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T20:44:26.580528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.853394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-31T20:44:26.580599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.124214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T20:44:26.580645Z","caller":"traceutil/trace.go:171","msg":"trace[246996579] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:824; }","duration":"121.993317ms","start":"2026-05-31T20:44:26.458618Z","end":"2026-05-31T20:44:26.580612Z","steps":["trace[246996579] 'range keys from in-memory index tree' (duration: 121.705571ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T20:44:26.580755Z","caller":"traceutil/trace.go:171","msg":"trace[975343201] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:824; }","duration":"154.302248ms","start":"2026-05-31T20:44:26.426373Z","end":"2026-05-31T20:44:26.580675Z","steps":["trace[975343201] 'range keys from in-memory index tree' (duration: 154.005831ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T20:45:01.604979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.304518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T20:45:01.605085Z","caller":"traceutil/trace.go:171","msg":"trace[318273748] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1036; }","duration":"144.423941ms","start":"2026-05-31T20:45:01.460638Z","end":"2026-05-31T20:45:01.605062Z","steps":["trace[318273748] 'range keys from in-memory index tree' (duration: 143.876329ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T20:45:27.035279Z","caller":"traceutil/trace.go:171","msg":"trace[1010886672] linearizableReadLoop","detail":"{readStateIndex:1167; appliedIndex:1166; }","duration":"212.104635ms","start":"2026-05-31T20:45:26.823148Z","end":"2026-05-31T20:45:27.035253Z","steps":["trace[1010886672] 'read index received' (duration: 211.756498ms)","trace[1010886672] 'applied index is now lower than readState.Index' (duration: 347.047µs)"],"step_count":2} {"level":"info","ts":"2026-05-31T20:45:27.035383Z","caller":"traceutil/trace.go:171","msg":"trace[428446356] transaction","detail":"{read_only:false; response_revision:1121; number_of_response:1; }","duration":"249.81669ms","start":"2026-05-31T20:45:26.785526Z","end":"2026-05-31T20:45:27.035343Z","steps":["trace[428446356] 'process raft request' (duration: 249.569405ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T20:45:27.035421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.249779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-31T20:45:27.035459Z","caller":"traceutil/trace.go:171","msg":"trace[824669091] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1121; }","duration":"212.361021ms","start":"2026-05-31T20:45:26.823087Z","end":"2026-05-31T20:45:27.035449Z","steps":["trace[824669091] 'agreement among raft nodes before linearized reading' (duration: 212.265319ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T20:45:28.579169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.94734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-31T20:45:28.579172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.001932ms","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-05-31T20:45:28.579262Z","caller":"traceutil/trace.go:171","msg":"trace[1578597001] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1124; }","duration":"121.094344ms","start":"2026-05-31T20:45:28.458145Z","end":"2026-05-31T20:45:28.579239Z","steps":["trace[1578597001] 'range keys from in-memory index tree' (duration: 120.844919ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T20:45:28.579272Z","caller":"traceutil/trace.go:171","msg":"trace[857369503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1124; }","duration":"103.153815ms","start":"2026-05-31T20:45:28.476098Z","end":"2026-05-31T20:45:28.579252Z","steps":["trace[857369503] 'range keys from in-memory index tree' (duration: 102.789698ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T20:45:28.727876Z","caller":"traceutil/trace.go:171","msg":"trace[1223447993] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"141.786598ms","start":"2026-05-31T20:45:28.586062Z","end":"2026-05-31T20:45:28.727849Z","steps":["trace[1223447993] 'process raft request' (duration: 119.705105ms)","trace[1223447993] 'compare' (duration: 21.897949ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T20:45:44.530763Z","caller":"traceutil/trace.go:171","msg":"trace[1585056111] linearizableReadLoop","detail":"{readStateIndex:1277; appliedIndex:1276; }","duration":"142.172765ms","start":"2026-05-31T20:45:44.388566Z","end":"2026-05-31T20:45:44.530739Z","steps":["trace[1585056111] 'read index received' (duration: 141.971431ms)","trace[1585056111] 'applied index is now lower than readState.Index' (duration: 200.474µs)"],"step_count":2} {"level":"info","ts":"2026-05-31T20:45:44.530829Z","caller":"traceutil/trace.go:171","msg":"trace[1280117539] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"215.836631ms","start":"2026-05-31T20:45:44.314956Z","end":"2026-05-31T20:45:44.530793Z","steps":["trace[1280117539] 'process raft request' (duration: 215.601286ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T20:45:44.531055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.476421ms","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-05-31T20:45:44.531144Z","caller":"traceutil/trace.go:171","msg":"trace[1378130081] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1226; }","duration":"142.634625ms","start":"2026-05-31T20:45:44.388487Z","end":"2026-05-31T20:45:44.531122Z","steps":["trace[1378130081] 'agreement among raft nodes before linearized reading' (duration: 142.37307ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T20:46:02.797245Z","caller":"traceutil/trace.go:171","msg":"trace[1083158344] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"100.295896ms","start":"2026-05-31T20:46:02.696919Z","end":"2026-05-31T20:46:02.797215Z","steps":["trace[1083158344] 'process raft request' (duration: 100.105212ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T20:46:02.976969Z","caller":"traceutil/trace.go:171","msg":"trace[274312214] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"161.323373ms","start":"2026-05-31T20:46:02.815591Z","end":"2026-05-31T20:46:02.976914Z","steps":["trace[274312214] 'process raft request' (duration: 147.722ms)","trace[274312214] 'compare' (duration: 12.298628ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T20:46:03.571439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.888219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-31T20:46:03.571572Z","caller":"traceutil/trace.go:171","msg":"trace[351031103] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1326; }","duration":"113.102344ms","start":"2026-05-31T20:46:03.458439Z","end":"2026-05-31T20:46:03.571541Z","steps":["trace[351031103] 'range keys from in-memory index tree' (duration: 112.750446ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T20:46:03.740943Z","caller":"traceutil/trace.go:171","msg":"trace[1613489649] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"163.62606ms","start":"2026-05-31T20:46:03.577289Z","end":"2026-05-31T20:46:03.740915Z","steps":["trace[1613489649] 'process raft request' (duration: 163.460967ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T20:46:03.890763Z","caller":"traceutil/trace.go:171","msg":"trace[1909481046] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"143.489644ms","start":"2026-05-31T20:46:03.747264Z","end":"2026-05-31T20:46:03.890754Z","steps":["trace[1909481046] 'process raft request' (duration: 143.454303ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T20:46:03.890813Z","caller":"traceutil/trace.go:171","msg":"trace[1984281468] linearizableReadLoop","detail":"{readStateIndex:1383; appliedIndex:1381; }","duration":"210.182015ms","start":"2026-05-31T20:46:03.68062Z","end":"2026-05-31T20:46:03.890802Z","steps":["trace[1984281468] 'read index received' (duration: 60.107719ms)","trace[1984281468] 'applied index is now lower than readState.Index' (duration: 150.073276ms)"],"step_count":2} {"level":"info","ts":"2026-05-31T20:46:03.890742Z","caller":"traceutil/trace.go:171","msg":"trace[1356903337] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"263.244532ms","start":"2026-05-31T20:46:03.627467Z","end":"2026-05-31T20:46:03.890711Z","steps":["trace[1356903337] 'process raft request' (duration: 236.994645ms)","trace[1356903337] 'compare' (duration: 26.142375ms)"],"step_count":2} {"level":"warn","ts":"2026-05-31T20:46:03.891408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.775876ms","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-05-31T20:46:03.89148Z","caller":"traceutil/trace.go:171","msg":"trace[1977405875] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1329; }","duration":"210.915229ms","start":"2026-05-31T20:46:03.68055Z","end":"2026-05-31T20:46:03.891466Z","steps":["trace[1977405875] 'agreement among raft nodes before linearized reading' (duration: 210.325877ms)"],"step_count":1} {"level":"warn","ts":"2026-05-31T20:46:03.892423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.687659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-05-31T20:46:03.89252Z","caller":"traceutil/trace.go:171","msg":"trace[841515630] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1329; }","duration":"147.855783ms","start":"2026-05-31T20:46:03.744642Z","end":"2026-05-31T20:46:03.892497Z","steps":["trace[841515630] 'agreement among raft nodes before linearized reading' (duration: 146.482204ms)"],"step_count":1} {"level":"info","ts":"2026-05-31T20:46:14.268806Z","caller":"traceutil/trace.go:171","msg":"trace[2027658573] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"276.377836ms","start":"2026-05-31T20:46:13.992398Z","end":"2026-05-31T20:46:14.268776Z","steps":["trace[2027658573] 'process raft request' (duration: 276.158472ms)"],"step_count":1}