{"level":"warn","ts":"2026-03-26T14:01:46.815259Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-26T14:01:46.815374Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156: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-03-26T14:01:46.815457Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-26T14:01:46.815466Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-03-26T14:01:46.815489Z","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-03-26T14:01:46.816179Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-03-26T14:01:46.816274Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156: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-03-26T14:01:46.820706Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.224216ms"} {"level":"info","ts":"2026-03-26T14:01:46.829306Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-03-26T14:01:46.829397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-03-26T14:01:46.829427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-03-26T14:01:46.829446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-26T14:01:46.829463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-03-26T14:01:46.829518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-03-26T14:01:46.835774Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-26T14:01:46.83679Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-26T14:01:46.837891Z","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-03-26T14:01:46.839818Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-26T14:01:46.841985Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-26T14:01:46.842175Z","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-03-26T14:01:46.842264Z","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-03-26T14:01:46.842293Z","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-03-26T14:01:46.844208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-03-26T14:01:46.844654Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-03-26T14:01:46.844755Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-03-26T14:01:46.84467Z","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-03-26T14:01:46.844841Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-03-26T14:01:46.845379Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-26T14:01:46.845434Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-26T14:01:47.22972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-03-26T14:01:47.229793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-26T14:01:47.229824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-03-26T14:01:47.22984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-03-26T14:01:47.229846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-03-26T14:01:47.229859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-03-26T14:01:47.229873Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-03-26T14:01:47.231545Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-03-26T14:01:47.231955Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-26T14:01:47.232061Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T14:01:47.232062Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-26T14:01:47.232897Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T14:01:47.233031Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T14:01:47.233075Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T14:01:47.234318Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-03-26T14:01:47.240956Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-26T14:01:47.241019Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-26T14:01:47.243911Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-26T14:01:51.139351Z","caller":"traceutil/trace.go:171","msg":"trace[416985159] transaction","detail":"{read_only:false; response_revision:201; number_of_response:1; }","duration":"259.657074ms","start":"2026-03-26T14:01:50.879596Z","end":"2026-03-26T14:01:51.139253Z","steps":["trace[416985159] 'process raft request' (duration: 259.46584ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T14:01:51.294014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.668635ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-26T14:01:51.294167Z","caller":"traceutil/trace.go:171","msg":"trace[499754038] transaction","detail":"{read_only:false; response_revision:202; number_of_response:1; }","duration":"148.133593ms","start":"2026-03-26T14:01:51.146012Z","end":"2026-03-26T14:01:51.294146Z","steps":["trace[499754038] 'process raft request' (duration: 35.687671ms)","trace[499754038] 'compare' (duration: 111.491201ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T14:01:51.53182Z","caller":"traceutil/trace.go:171","msg":"trace[1935629041] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"167.516583ms","start":"2026-03-26T14:01:51.364276Z","end":"2026-03-26T14:01:51.531792Z","steps":["trace[1935629041] 'process raft request' (duration: 167.467792ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T14:01:51.53186Z","caller":"traceutil/trace.go:171","msg":"trace[697501224] transaction","detail":"{read_only:false; response_revision:204; number_of_response:1; }","duration":"205.649978ms","start":"2026-03-26T14:01:51.326168Z","end":"2026-03-26T14:01:51.531818Z","steps":["trace[697501224] 'process raft request' (duration: 136.711963ms)","trace[697501224] 'compare' (duration: 68.70545ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T14:02:19.31038Z","caller":"traceutil/trace.go:171","msg":"trace[2063083645] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"194.866183ms","start":"2026-03-26T14:02:19.115477Z","end":"2026-03-26T14:02:19.310343Z","steps":["trace[2063083645] 'process raft request' (duration: 158.219172ms)","trace[2063083645] 'compare' (duration: 35.933125ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T14:02:19.311647Z","caller":"traceutil/trace.go:171","msg":"trace[1980903628] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"185.702937ms","start":"2026-03-26T14:02:19.125801Z","end":"2026-03-26T14:02:19.311504Z","steps":["trace[1980903628] 'process raft request' (duration: 185.325149ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T14:02:19.312099Z","caller":"traceutil/trace.go:171","msg":"trace[108161382] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"184.97835ms","start":"2026-03-26T14:02:19.127089Z","end":"2026-03-26T14:02:19.312068Z","steps":["trace[108161382] 'process raft request' (duration: 184.306164ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T14:02:26.131016Z","caller":"traceutil/trace.go:171","msg":"trace[2115006354] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"187.037309ms","start":"2026-03-26T14:02:25.943952Z","end":"2026-03-26T14:02:26.130989Z","steps":["trace[2115006354] 'process raft request' (duration: 186.382844ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T14:02:26.514362Z","caller":"traceutil/trace.go:171","msg":"trace[465013973] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"262.624187ms","start":"2026-03-26T14:02:26.251701Z","end":"2026-03-26T14:02:26.514325Z","steps":["trace[465013973] 'read index received' (duration: 262.446332ms)","trace[465013973] 'applied index is now lower than readState.Index' (duration: 176.505µs)"],"step_count":2} {"level":"info","ts":"2026-03-26T14:02:26.514531Z","caller":"traceutil/trace.go:171","msg":"trace[924429765] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"319.138095ms","start":"2026-03-26T14:02:26.195383Z","end":"2026-03-26T14:02:26.514521Z","steps":["trace[924429765] 'process raft request' (duration: 318.731806ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T14:02:26.514647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T14:02:26.195354Z","time spent":"319.210777ms","remote":"127.0.0.1:36880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-26T14:02:26.515026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.292232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mkj7b\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-03-26T14:02:26.515146Z","caller":"traceutil/trace.go:171","msg":"trace[1158587750] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mkj7b; range_end:; response_count:1; response_revision:584; }","duration":"263.452476ms","start":"2026-03-26T14:02:26.251661Z","end":"2026-03-26T14:02:26.515114Z","steps":["trace[1158587750] 'agreement among raft nodes before linearized reading' (duration: 263.136059ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T14:02:26.515384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.72304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T14:02:26.515472Z","caller":"traceutil/trace.go:171","msg":"trace[1446212107] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:584; }","duration":"214.857014ms","start":"2026-03-26T14:02:26.300585Z","end":"2026-03-26T14:02:26.515442Z","steps":["trace[1446212107] 'agreement among raft nodes before linearized reading' (duration: 214.743851ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T14:02:26.667039Z","caller":"traceutil/trace.go:171","msg":"trace[972279706] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"136.702896ms","start":"2026-03-26T14:02:26.530298Z","end":"2026-03-26T14:02:26.667Z","steps":["trace[972279706] 'read index received' (duration: 119.785578ms)","trace[972279706] 'applied index is now lower than readState.Index' (duration: 16.915818ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T14:02:26.667252Z","caller":"traceutil/trace.go:171","msg":"trace[23090406] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"137.950855ms","start":"2026-03-26T14:02:26.529261Z","end":"2026-03-26T14:02:26.667212Z","steps":["trace[23090406] 'process raft request' (duration: 120.929964ms)","trace[23090406] 'compare' (duration: 16.447237ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T14:02:26.667244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.90849ms","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-03-26T14:02:26.667363Z","caller":"traceutil/trace.go:171","msg":"trace[1932311286] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:585; }","duration":"137.053284ms","start":"2026-03-26T14:02:26.530292Z","end":"2026-03-26T14:02:26.667346Z","steps":["trace[1932311286] 'agreement among raft nodes before linearized reading' (duration: 136.843489ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T14:02:41.475158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.516319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T14:02:41.475318Z","caller":"traceutil/trace.go:171","msg":"trace[866574621] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:740; }","duration":"175.754204ms","start":"2026-03-26T14:02:41.299533Z","end":"2026-03-26T14:02:41.475287Z","steps":["trace[866574621] 'range keys from in-memory index tree' (duration: 175.408375ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T14:02:41.475244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.484845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-t5s6f\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-03-26T14:02:41.475428Z","caller":"traceutil/trace.go:171","msg":"trace[1140183997] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-t5s6f; range_end:; response_count:1; response_revision:740; }","duration":"106.707709ms","start":"2026-03-26T14:02:41.368708Z","end":"2026-03-26T14:02:41.475416Z","steps":["trace[1140183997] 'range keys from in-memory index tree' (duration: 106.232798ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T14:03:17.096157Z","caller":"traceutil/trace.go:171","msg":"trace[925532412] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"113.087485ms","start":"2026-03-26T14:03:16.983052Z","end":"2026-03-26T14:03:17.096139Z","steps":["trace[925532412] 'process raft request' (duration: 112.958392ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T14:03:43.451994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.873511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T14:03:43.4521Z","caller":"traceutil/trace.go:171","msg":"trace[158647136] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1047; }","duration":"151.032225ms","start":"2026-03-26T14:03:43.301048Z","end":"2026-03-26T14:03:43.45208Z","steps":["trace[158647136] 'range keys from in-memory index tree' (duration: 150.745558ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T14:03:59.03132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.461811ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T14:03:59.031664Z","caller":"traceutil/trace.go:171","msg":"trace[174235706] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"207.07325ms","start":"2026-03-26T14:03:58.824572Z","end":"2026-03-26T14:03:59.031645Z","steps":["trace[174235706] 'process raft request' (duration: 105.993184ms)","trace[174235706] 'compare' (duration: 100.201735ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T14:04:15.523402Z","caller":"traceutil/trace.go:171","msg":"trace[1047853085] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"192.518085ms","start":"2026-03-26T14:04:15.33082Z","end":"2026-03-26T14:04:15.523338Z","steps":["trace[1047853085] 'process raft request' (duration: 192.30898ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T14:04:15.692571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.686331ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-03-26T14:04:15.692689Z","caller":"traceutil/trace.go:171","msg":"trace[2069782456] linearizableReadLoop","detail":"{readStateIndex:1270; appliedIndex:1269; }","duration":"163.955963ms","start":"2026-03-26T14:04:15.528713Z","end":"2026-03-26T14:04:15.692669Z","steps":["trace[2069782456] 'read index received' (duration: 19.178519ms)","trace[2069782456] 'applied index is now lower than readState.Index' (duration: 144.775814ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T14:04:15.692841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.101217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-03-26T14:04:15.692919Z","caller":"traceutil/trace.go:171","msg":"trace[1210914898] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:1221; }","duration":"164.21969ms","start":"2026-03-26T14:04:15.528684Z","end":"2026-03-26T14:04:15.692904Z","steps":["trace[1210914898] 'agreement among raft nodes before linearized reading' (duration: 164.043256ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T14:04:15.693026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.22877ms","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-03-26T14:04:15.693137Z","caller":"traceutil/trace.go:171","msg":"trace[435815762] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1221; }","duration":"159.370333ms","start":"2026-03-26T14:04:15.53374Z","end":"2026-03-26T14:04:15.69311Z","steps":["trace[435815762] 'agreement among raft nodes before linearized reading' (duration: 159.025835ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T14:04:16.470538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.361763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-03-26T14:04:16.470558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.120956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T14:04:16.470634Z","caller":"traceutil/trace.go:171","msg":"trace[1644244200] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1226; }","duration":"297.542048ms","start":"2026-03-26T14:04:16.173068Z","end":"2026-03-26T14:04:16.47061Z","steps":["trace[1644244200] 'range keys from in-memory index tree' (duration: 297.008235ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T14:04:16.470654Z","caller":"traceutil/trace.go:171","msg":"trace[1408061510] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1226; }","duration":"159.28499ms","start":"2026-03-26T14:04:16.311349Z","end":"2026-03-26T14:04:16.470634Z","steps":["trace[1408061510] 'range keys from in-memory index tree' (duration: 159.026193ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T14:04:16.590506Z","caller":"traceutil/trace.go:171","msg":"trace[991115737] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"114.850027ms","start":"2026-03-26T14:04:16.475608Z","end":"2026-03-26T14:04:16.590458Z","steps":["trace[991115737] 'process raft request' (duration: 114.513029ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T14:04:17.447574Z","caller":"traceutil/trace.go:171","msg":"trace[13839222] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"273.624516ms","start":"2026-03-26T14:04:17.173916Z","end":"2026-03-26T14:04:17.447541Z","steps":["trace[13839222] 'process raft request' (duration: 273.415181ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T14:04:17.95653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.445594ms","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-03-26T14:04:17.956623Z","caller":"traceutil/trace.go:171","msg":"trace[79936171] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1236; }","duration":"238.962326ms","start":"2026-03-26T14:04:17.717637Z","end":"2026-03-26T14:04:17.956599Z","steps":["trace[79936171] 'range keys from in-memory index tree' (duration: 238.234369ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T14:04:17.956535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.659795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T14:04:17.95653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.189183ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-03-26T14:04:17.956711Z","caller":"traceutil/trace.go:171","msg":"trace[830814326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1236; }","duration":"201.436149ms","start":"2026-03-26T14:04:17.755257Z","end":"2026-03-26T14:04:17.956693Z","steps":["trace[830814326] 'range keys from in-memory index tree' (duration: 200.982758ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T14:04:17.956708Z","caller":"traceutil/trace.go:171","msg":"trace[1040963042] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1236; }","duration":"163.942613ms","start":"2026-03-26T14:04:17.79273Z","end":"2026-03-26T14:04:17.956672Z","steps":["trace[1040963042] 'count revisions from in-memory index tree' (duration: 163.528792ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T14:04:32.269678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.279473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-03-26T14:04:32.269797Z","caller":"traceutil/trace.go:171","msg":"trace[1199769814] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1329; }","duration":"119.448927ms","start":"2026-03-26T14:04:32.150324Z","end":"2026-03-26T14:04:32.269773Z","steps":["trace[1199769814] 'range keys from in-memory index tree' (duration: 119.090928ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T14:04:32.270026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.786563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-03-26T14:04:32.270154Z","caller":"traceutil/trace.go:171","msg":"trace[1959525004] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1329; }","duration":"173.112421ms","start":"2026-03-26T14:04:32.097Z","end":"2026-03-26T14:04:32.270112Z","steps":["trace[1959525004] 'range keys from in-memory index tree' (duration: 172.494616ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T14:04:32.583978Z","caller":"traceutil/trace.go:171","msg":"trace[451455002] linearizableReadLoop","detail":"{readStateIndex:1383; appliedIndex:1381; }","duration":"283.200445ms","start":"2026-03-26T14:04:32.300752Z","end":"2026-03-26T14:04:32.583952Z","steps":["trace[451455002] 'read index received' (duration: 71.523511ms)","trace[451455002] 'applied index is now lower than readState.Index' (duration: 211.675614ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T14:04:32.5841Z","caller":"traceutil/trace.go:171","msg":"trace[317635985] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"308.721356ms","start":"2026-03-26T14:04:32.275351Z","end":"2026-03-26T14:04:32.584073Z","steps":["trace[317635985] 'process raft request' (duration: 296.168926ms)","trace[317635985] 'compare' (duration: 12.14518ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T14:04:32.58415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.37595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T14:04:32.584181Z","caller":"traceutil/trace.go:171","msg":"trace[1508044302] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1331; }","duration":"283.474942ms","start":"2026-03-26T14:04:32.300694Z","end":"2026-03-26T14:04:32.584169Z","steps":["trace[1508044302] 'agreement among raft nodes before linearized reading' (duration: 283.39641ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T14:04:32.584267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T14:04:32.275321Z","time spent":"308.844659ms","remote":"127.0.0.1:36910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T14:04:32.584377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.502434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-03-26T14:04:32.584472Z","caller":"traceutil/trace.go:171","msg":"trace[299365750] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1331; }","duration":"184.657197ms","start":"2026-03-26T14:04:32.399788Z","end":"2026-03-26T14:04:32.584446Z","steps":["trace[299365750] 'agreement among raft nodes before linearized reading' (duration: 184.358849ms)"],"step_count":1}