connection_manager.py 50 KB

1234567891011121314151617181920212223242526272829303132333435363738394041424344454647484950515253545556575859606162636465666768697071727374757677787980818283848586878889909192939495969798991001011021031041051061071081091101111121131141151161171181191201211221231241251261271281291301311321331341351361371381391401411421431441451461471481491501511521531541551561571581591601611621631641651661671681691701711721731741751761771781791801811821831841851861871881891901911921931941951961971981992002012022032042052062072082092102112122132142152162172182192202212222232242252262272282292302312322332342352362372382392402412422432442452462472482492502512522532542552562572582592602612622632642652662672682692702712722732742752762772782792802812822832842852862872882892902912922932942952962972982993003013023033043053063073083093103113123133143153163173183193203213223233243253263273283293303313323333343353363373383393403413423433443453463473483493503513523533543553563573583593603613623633643653663673683693703713723733743753763773783793803813823833843853863873883893903913923933943953963973983994004014024034044054064074084094104114124134144154164174184194204214224234244254264274284294304314324334344354364374384394404414424434444454464474484494504514524534544554564574584594604614624634644654664674684694704714724734744754764774784794804814824834844854864874884894904914924934944954964974984995005015025035045055065075085095105115125135145155165175185195205215225235245255265275285295305315325335345355365375385395405415425435445455465475485495505515525535545555565575585595605615625635645655665675685695705715725735745755765775785795805815825835845855865875885895905915925935945955965975985996006016026036046056066076086096106116126136146156166176186196206216226236246256266276286296306316326336346356366376386396406416426436446456466476486496506516526536546556566576586596606616626636646656666676686696706716726736746756766776786796806816826836846856866876886896906916926936946956966976986997007017027037047057067077087097107117127137147157167177187197207217227237247257267277287297307317327337347357367377387397407417427437447457467477487497507517527537547557567577587597607617627637647657667677687697707717727737747757767777787797807817827837847857867877887897907917927937947957967977987998008018028038048058068078088098108118128138148158168178188198208218228238248258268278288298308318328338348358368378388398408418428438448458468478488498508518528538548558568578588598608618628638648658668678688698708718728738748758768778788798808818828838848858868878888898908918928938948958968978988999009019029039049059069079089099109119129139149159169179189199209219229239249259269279289299309319329339349359369379389399409419429439449459469479489499509519529539549559569579589599609619629639649659669679689699709719729739749759769779789799809819829839849859869879889899909919929939949959969979989991000100110021003100410051006100710081009101010111012101310141015101610171018101910201021102210231024102510261027102810291030103110321033103410351036103710381039104010411042104310441045104610471048104910501051105210531054105510561057105810591060106110621063106410651066106710681069107010711072107310741075107610771078107910801081108210831084108510861087108810891090109110921093109410951096109710981099110011011102110311041105110611071108110911101111111211131114111511161117111811191120112111221123112411251126112711281129113011311132113311341135113611371138113911401141114211431144114511461147114811491150115111521153115411551156115711581159116011611162116311641165116611671168116911701171117211731174117511761177117811791180118111821183118411851186118711881189119011911192119311941195119611971198119912001201120212031204120512061207120812091210121112121213121412151216121712181219122012211222122312241225122612271228122912301231123212331234123512361237123812391240124112421243124412451246124712481249125012511252125312541255125612571258125912601261126212631264126512661267126812691270127112721273
  1. import threading
  2. import time
  3. import logging
  4. import serial
  5. import serial.tools.list_ports
  6. import websocket
  7. import asyncio
  8. import os
  9. from modules.core import pattern_manager
  10. from modules.core.state import state
  11. from modules.led.led_interface import LEDInterface
  12. from modules.led.idle_timeout_manager import idle_timeout_manager
  13. logger = logging.getLogger(__name__)
  14. IGNORE_PORTS = ['/dev/cu.debug-console', '/dev/cu.Bluetooth-Incoming-Port']
  15. # Ports to deprioritize during auto-connect (shown in UI but not auto-selected)
  16. DEPRIORITIZED_PORTS = ['/dev/ttyS0']
  17. async def _check_table_is_idle() -> bool:
  18. """Helper function to check if table is idle."""
  19. return not state.current_playing_file or state.pause_requested
  20. def _start_idle_led_timeout():
  21. """Start idle LED timeout if enabled."""
  22. if not state.dw_led_idle_timeout_enabled or state.dw_led_idle_timeout_minutes <= 0:
  23. return
  24. logger.debug(f"Starting idle LED timeout: {state.dw_led_idle_timeout_minutes} minutes")
  25. idle_timeout_manager.start_idle_timeout(
  26. timeout_minutes=state.dw_led_idle_timeout_minutes,
  27. state=state,
  28. check_idle_callback=_check_table_is_idle
  29. )
  30. ###############################################################################
  31. # Connection Abstraction
  32. ###############################################################################
  33. class BaseConnection:
  34. """Abstract base class for a connection."""
  35. def send(self, data: str) -> None:
  36. raise NotImplementedError
  37. def flush(self) -> None:
  38. raise NotImplementedError
  39. def readline(self) -> str:
  40. raise NotImplementedError
  41. def in_waiting(self) -> int:
  42. raise NotImplementedError
  43. def is_connected(self) -> bool:
  44. raise NotImplementedError
  45. def close(self) -> None:
  46. raise NotImplementedError
  47. ###############################################################################
  48. # Serial Connection Implementation
  49. ###############################################################################
  50. class SerialConnection(BaseConnection):
  51. def __init__(self, port: str, baudrate: int = 115200, timeout: int = 2):
  52. self.port = port
  53. self.baudrate = baudrate
  54. self.timeout = timeout
  55. self.lock = threading.RLock()
  56. logger.info(f'Connecting to Serial port {port}')
  57. self.ser = serial.Serial(port, baudrate, timeout=timeout)
  58. state.port = port
  59. logger.info(f'Connected to Serial port {port}')
  60. def send(self, data: str) -> None:
  61. with self.lock:
  62. self.ser.write(data.encode())
  63. self.ser.flush()
  64. def flush(self) -> None:
  65. with self.lock:
  66. self.ser.flush()
  67. def readline(self) -> str:
  68. with self.lock:
  69. return self.ser.readline().decode().strip()
  70. def in_waiting(self) -> int:
  71. with self.lock:
  72. return self.ser.in_waiting
  73. def is_connected(self) -> bool:
  74. return self.ser is not None and self.ser.is_open
  75. def close(self) -> None:
  76. # Save current state synchronously first (critical for position persistence)
  77. try:
  78. state.save()
  79. except Exception as e:
  80. logger.error(f"Error saving state on close: {e}")
  81. # Schedule async position update if event loop exists, otherwise skip
  82. # This avoids creating nested event loops which causes RuntimeError
  83. try:
  84. loop = asyncio.get_running_loop()
  85. # We're in async context - schedule as task (fire-and-forget)
  86. asyncio.create_task(update_machine_position())
  87. logger.debug("Scheduled async machine position update")
  88. except RuntimeError:
  89. # No running event loop - we're in sync context
  90. # Position was already saved above, skip async update to avoid nested loop
  91. logger.debug("No event loop running, skipping async position update")
  92. with self.lock:
  93. if self.ser.is_open:
  94. self.ser.close()
  95. ###############################################################################
  96. # WebSocket Connection Implementation
  97. ###############################################################################
  98. class WebSocketConnection(BaseConnection):
  99. def __init__(self, url: str, timeout: int = 5):
  100. self.url = url
  101. self.timeout = timeout
  102. self.lock = threading.RLock()
  103. self.ws = None
  104. self.connect()
  105. def connect(self):
  106. logger.info(f'Connecting to Websocket {self.url}')
  107. self.ws = websocket.create_connection(self.url, timeout=self.timeout)
  108. state.port = self.url
  109. logger.info(f'Connected to Websocket {self.url}')
  110. def send(self, data: str) -> None:
  111. with self.lock:
  112. self.ws.send(data)
  113. def flush(self) -> None:
  114. # WebSocket sends immediately; nothing to flush.
  115. pass
  116. def readline(self) -> str:
  117. with self.lock:
  118. data = self.ws.recv()
  119. # Decode bytes to string if necessary
  120. if isinstance(data, bytes):
  121. data = data.decode('utf-8')
  122. return data.strip()
  123. def in_waiting(self) -> int:
  124. return 0 # Not applicable for WebSocket
  125. def is_connected(self) -> bool:
  126. return self.ws is not None
  127. def close(self) -> None:
  128. # Save current state synchronously first (critical for position persistence)
  129. try:
  130. state.save()
  131. except Exception as e:
  132. logger.error(f"Error saving state on close: {e}")
  133. # Schedule async position update if event loop exists, otherwise skip
  134. # This avoids creating nested event loops which causes RuntimeError
  135. try:
  136. loop = asyncio.get_running_loop()
  137. # We're in async context - schedule as task (fire-and-forget)
  138. asyncio.create_task(update_machine_position())
  139. logger.debug("Scheduled async machine position update")
  140. except RuntimeError:
  141. # No running event loop - we're in sync context
  142. # Position was already saved above, skip async update to avoid nested loop
  143. logger.debug("No event loop running, skipping async position update")
  144. with self.lock:
  145. if self.ws:
  146. self.ws.close()
  147. def list_serial_ports():
  148. """Return a list of available serial ports."""
  149. ports = serial.tools.list_ports.comports()
  150. available_ports = [port.device for port in ports if port.device not in IGNORE_PORTS]
  151. logger.debug(f"Available serial ports: {available_ports}")
  152. return available_ports
  153. def device_init(homing=True):
  154. try:
  155. if get_machine_steps():
  156. logger.info(f"x_steps_per_mm: {state.x_steps_per_mm}, y_steps_per_mm: {state.y_steps_per_mm}, gear_ratio: {state.gear_ratio}")
  157. else:
  158. logger.fatal("Failed to get machine steps")
  159. state.conn.close()
  160. return False
  161. except:
  162. logger.fatal("Not GRBL firmware")
  163. state.conn.close()
  164. return False
  165. machine_x, machine_y = get_machine_position()
  166. if machine_x != state.machine_x or machine_y != state.machine_y:
  167. logger.info(f'x, y; {machine_x}, {machine_y}')
  168. logger.info(f'State x, y; {state.machine_x}, {state.machine_y}')
  169. if homing:
  170. success = home()
  171. if not success:
  172. logger.error("Homing failed during device initialization")
  173. else:
  174. logger.info('Machine position known, skipping home')
  175. logger.info(f'Theta: {state.current_theta}, rho: {state.current_rho}')
  176. logger.info(f'x, y; {machine_x}, {machine_y}')
  177. logger.info(f'State x, y; {state.machine_x}, {state.machine_y}')
  178. time.sleep(2) # Allow time for the connection to establish
  179. return True
  180. def connect_device(homing=True):
  181. # Initialize LED interface based on configured provider
  182. # Note: DW LEDs are initialized at startup in main.py, so we preserve the existing controller
  183. if state.led_provider == "wled" and state.wled_ip:
  184. state.led_controller = LEDInterface(provider="wled", ip_address=state.wled_ip)
  185. elif state.led_provider == "dw_leds":
  186. # DW LEDs are already initialized in main.py at startup
  187. # Only initialize here if not already set up (e.g., reconnection scenario)
  188. if not state.led_controller or not state.led_controller.is_configured:
  189. state.led_controller = LEDInterface(
  190. provider="dw_leds",
  191. num_leds=state.dw_led_num_leds,
  192. gpio_pin=state.dw_led_gpio_pin,
  193. pixel_order=state.dw_led_pixel_order,
  194. brightness=state.dw_led_brightness / 100.0,
  195. speed=state.dw_led_speed,
  196. intensity=state.dw_led_intensity
  197. )
  198. elif state.led_provider == "hyperion" and state.hyperion_ip:
  199. state.led_controller = LEDInterface(
  200. provider="hyperion",
  201. ip_address=state.hyperion_ip,
  202. port=state.hyperion_port
  203. )
  204. elif state.led_provider == "none" or not state.led_provider:
  205. state.led_controller = None
  206. # For other cases (e.g., wled without IP), preserve existing controller
  207. # Show loading effect
  208. if state.led_controller:
  209. state.led_controller.effect_loading()
  210. ports = list_serial_ports()
  211. # Check auto-connect mode: "__auto__" or None = auto, "__none__" = disabled, else specific port
  212. if state.preferred_port == "__none__":
  213. logger.info("Auto-connect disabled by user preference")
  214. # Skip all auto-connect logic, no connection will be established
  215. # Priority for auto-connect:
  216. # 1. Preferred port (user's explicit choice) if available
  217. # 2. Last used port if available
  218. # 3. First available port as fallback
  219. elif state.preferred_port and state.preferred_port not in ("__auto__", None) and state.preferred_port in ports:
  220. logger.info(f"Connecting to preferred port: {state.preferred_port}")
  221. state.conn = SerialConnection(state.preferred_port)
  222. elif state.port and state.port in ports:
  223. logger.info(f"Connecting to last used port: {state.port}")
  224. state.conn = SerialConnection(state.port)
  225. elif ports:
  226. # Prefer non-deprioritized ports (e.g., USB serial over hardware UART)
  227. preferred_ports = [p for p in ports if p not in DEPRIORITIZED_PORTS]
  228. fallback_ports = [p for p in ports if p in DEPRIORITIZED_PORTS]
  229. if preferred_ports:
  230. logger.info(f"Connecting to first available port: {preferred_ports[0]}")
  231. state.conn = SerialConnection(preferred_ports[0])
  232. elif fallback_ports:
  233. logger.info(f"Connecting to deprioritized port (no better option): {fallback_ports[0]}")
  234. state.conn = SerialConnection(fallback_ports[0])
  235. else:
  236. logger.error("Auto connect failed: No serial ports available")
  237. # state.conn = WebSocketConnection('ws://fluidnc.local:81')
  238. if (state.conn.is_connected() if state.conn else False):
  239. # Check for alarm state and unlock if needed before initializing
  240. if not check_and_unlock_alarm():
  241. logger.error("Failed to unlock device from alarm state")
  242. # Still proceed with device_init but log the issue
  243. device_init(homing)
  244. # Show connected effect, then transition to configured idle effect
  245. if state.led_controller:
  246. logger.info("Showing LED connected effect (green flash)")
  247. state.led_controller.effect_connected()
  248. # Set the configured idle effect after connection
  249. logger.info(f"Setting LED to idle effect: {state.dw_led_idle_effect}")
  250. state.led_controller.effect_idle(state.dw_led_idle_effect)
  251. _start_idle_led_timeout()
  252. def check_and_unlock_alarm():
  253. """
  254. Check if GRBL is in alarm state and unlock it with $X if needed.
  255. Returns True if device is ready (unlocked or no alarm), False on error.
  256. Note: If sensors are physically triggered (Pn:XY), the alarm may persist
  257. but we still return True to allow homing to proceed.
  258. """
  259. try:
  260. logger.info("Checking device status for alarm state...")
  261. # Clear any pending data in buffer first
  262. while state.conn.in_waiting() > 0:
  263. state.conn.readline()
  264. # Send status query
  265. state.conn.send('?\n')
  266. time.sleep(0.2)
  267. # Read response with timeout
  268. max_attempts = 10
  269. response = None
  270. for attempt in range(max_attempts):
  271. if state.conn.in_waiting() > 0:
  272. response = state.conn.readline()
  273. logger.debug(f"Status response: {response}")
  274. if response and ('<' in response or 'Alarm' in response or 'Idle' in response):
  275. break # Got a valid status response
  276. time.sleep(0.1)
  277. if not response:
  278. logger.warning("No status response received, proceeding anyway")
  279. return True
  280. # Check for alarm state
  281. if "Alarm" in response:
  282. logger.warning(f"Device in ALARM state: {response}")
  283. # Send unlock command
  284. logger.info("Sending $X to unlock...")
  285. state.conn.send('$X\n')
  286. time.sleep(1.0) # Give more time for unlock to process
  287. # Clear buffer before verification
  288. while state.conn.in_waiting() > 0:
  289. discarded = state.conn.readline()
  290. logger.debug(f"Discarded response: {discarded}")
  291. # Verify unlock succeeded
  292. state.conn.send('?\n')
  293. time.sleep(0.3)
  294. verify_response = None
  295. for attempt in range(max_attempts):
  296. if state.conn.in_waiting() > 0:
  297. verify_response = state.conn.readline()
  298. logger.debug(f"Verification response: {verify_response}")
  299. if verify_response and '<' in verify_response:
  300. break
  301. time.sleep(0.1)
  302. if verify_response and "Alarm" in verify_response:
  303. # Check if pins are physically triggered (Pn: in response)
  304. if "Pn:" in verify_response:
  305. logger.warning(f"Alarm persists due to triggered sensors: {verify_response}")
  306. logger.warning("Proceeding anyway - homing may clear the sensor state")
  307. return True # Let homing attempt to proceed
  308. else:
  309. logger.error("Failed to unlock device from alarm state")
  310. return False
  311. else:
  312. logger.info("Device successfully unlocked")
  313. return True
  314. else:
  315. logger.info("Device not in alarm state, proceeding normally")
  316. return True
  317. except Exception as e:
  318. logger.error(f"Error checking/unlocking alarm: {e}")
  319. return False
  320. def get_status_response() -> str:
  321. """
  322. Send a status query ('?') and return the response if available.
  323. """
  324. if state.conn is None or not state.conn.is_connected():
  325. logger.warning("Cannot get status response: no active connection")
  326. return False
  327. while True:
  328. try:
  329. state.conn.send('?')
  330. response = state.conn.readline()
  331. if "MPos" in response:
  332. logger.debug(f"Status response: {response}")
  333. return response
  334. except Exception as e:
  335. logger.error(f"Error getting status response: {e}")
  336. return False
  337. time.sleep(1)
  338. def parse_machine_position(response: str):
  339. """
  340. Parse the work position (MPos) from a status response.
  341. Expected format: "<...|MPos:-994.869,-321.861,0.000|...>"
  342. Returns a tuple (work_x, work_y) if found, else None.
  343. """
  344. if "MPos:" not in response:
  345. return None
  346. try:
  347. wpos_section = next((part for part in response.split("|") if part.startswith("MPos:")), None)
  348. if wpos_section:
  349. wpos_str = wpos_section.split(":", 1)[1]
  350. wpos_values = wpos_str.split(",")
  351. work_x = float(wpos_values[0])
  352. work_y = float(wpos_values[1])
  353. return work_x, work_y
  354. except Exception as e:
  355. logger.error(f"Error parsing work position: {e}")
  356. return None
  357. async def send_grbl_coordinates(x, y, speed=600, timeout=30, home=False):
  358. """
  359. Send a G-code command to FluidNC and wait for an 'ok' response.
  360. If no response after set timeout, returns False.
  361. Args:
  362. x: X coordinate
  363. y: Y coordinate
  364. speed: Feed rate in mm/min
  365. timeout: Maximum time in seconds to wait for 'ok' response
  366. home: If True, sends jog command ($J=) instead of G1
  367. Returns:
  368. True on success, False on timeout or error
  369. """
  370. logger.debug(f"Sending G-code: X{x} Y{y} at F{speed}")
  371. overall_start_time = time.time()
  372. max_retries = 3
  373. retry_count = 0
  374. while retry_count < max_retries:
  375. # Check overall timeout
  376. if time.time() - overall_start_time > timeout:
  377. logger.error(f"Timeout waiting for 'ok' response after {timeout}s")
  378. return False
  379. try:
  380. gcode = f"$J=G91 G21 Y{y} F{speed}" if home else f"G1 G53 X{x} Y{y} F{speed}"
  381. await asyncio.to_thread(state.conn.send, gcode + "\n")
  382. logger.debug(f"Sent command: {gcode}")
  383. # Wait for 'ok' response with timeout
  384. response_start = time.time()
  385. response_timeout = min(10, timeout - (time.time() - overall_start_time))
  386. while time.time() - response_start < response_timeout:
  387. # Check overall timeout
  388. if time.time() - overall_start_time > timeout:
  389. logger.error(f"Overall timeout waiting for 'ok' response")
  390. return False
  391. response = await asyncio.to_thread(state.conn.readline)
  392. if response:
  393. logger.debug(f"Response: {response}")
  394. if response.lower().strip() == "ok":
  395. logger.debug("Command execution confirmed.")
  396. return True
  397. elif 'error' in response.lower():
  398. logger.warning(f"Got error response: {response}")
  399. # Don't immediately fail - some errors are recoverable
  400. else:
  401. await asyncio.sleep(0.05)
  402. # Response timeout for this attempt
  403. logger.warning(f"No 'ok' received for {gcode}, retrying... ({retry_count + 1}/{max_retries})")
  404. retry_count += 1
  405. await asyncio.sleep(0.2)
  406. except Exception as e:
  407. error_str = str(e)
  408. logger.warning(f"Error sending command: {error_str}")
  409. # Immediately return for device not configured errors
  410. if "Device not configured" in error_str or "Errno 6" in error_str:
  411. logger.error(f"Device configuration error detected: {error_str}")
  412. state.stop_requested = True
  413. state.conn = None
  414. state.is_connected = False
  415. logger.info("Connection marked as disconnected due to device error")
  416. return False
  417. retry_count += 1
  418. await asyncio.sleep(0.2)
  419. logger.error(f"Failed to receive 'ok' response after {max_retries} retries")
  420. return False
  421. def _detect_firmware():
  422. """
  423. Detect firmware type (FluidNC or GRBL) by sending $I command.
  424. Returns tuple: (firmware_type: str, version: str or None)
  425. firmware_type is 'fluidnc', 'grbl', or 'unknown'
  426. """
  427. if not state.conn or not state.conn.is_connected():
  428. return ('unknown', None)
  429. # Clear buffer first
  430. try:
  431. while state.conn.in_waiting() > 0:
  432. state.conn.readline()
  433. except Exception:
  434. pass
  435. try:
  436. state.conn.send("$I\n")
  437. time.sleep(0.3)
  438. firmware_type = 'unknown'
  439. version = None
  440. start_time = time.time()
  441. while time.time() - start_time < 2.0:
  442. if state.conn.in_waiting() > 0:
  443. response = state.conn.readline()
  444. if response:
  445. logger.debug(f"Firmware detection response: {response}")
  446. response_lower = response.lower()
  447. if 'fluidnc' in response_lower:
  448. firmware_type = 'fluidnc'
  449. # Try to extract version from response like "FluidNC v3.7.2"
  450. if 'v' in response_lower:
  451. parts = response.split()
  452. for part in parts:
  453. if part.lower().startswith('v') and any(c.isdigit() for c in part):
  454. version = part
  455. break
  456. break
  457. elif 'grbl' in response_lower and 'fluidnc' not in response_lower:
  458. firmware_type = 'grbl'
  459. # Try to extract version like "Grbl 1.1h"
  460. parts = response.split()
  461. for i, part in enumerate(parts):
  462. if 'grbl' in part.lower() and i + 1 < len(parts):
  463. version = parts[i + 1]
  464. break
  465. break
  466. elif response.lower().strip() == 'ok':
  467. break
  468. else:
  469. time.sleep(0.05)
  470. # Clear any remaining responses
  471. while state.conn.in_waiting() > 0:
  472. state.conn.readline()
  473. return (firmware_type, version)
  474. except Exception as e:
  475. logger.warning(f"Firmware detection failed: {e}")
  476. return ('unknown', None)
  477. def _get_steps_fluidnc():
  478. """
  479. Get steps/mm from FluidNC using individual setting queries.
  480. Returns tuple: (x_steps_per_mm, y_steps_per_mm) or (None, None) on failure.
  481. Note: Works even when device is in ALARM state (e.g., limit switch active).
  482. """
  483. x_steps = None
  484. y_steps = None
  485. # Clear buffer
  486. try:
  487. while state.conn.in_waiting() > 0:
  488. state.conn.readline()
  489. except Exception:
  490. pass
  491. # Query X steps/mm
  492. try:
  493. state.conn.send("$/axes/x/steps_per_mm\n")
  494. time.sleep(0.2)
  495. start_time = time.time()
  496. while time.time() - start_time < 2.0:
  497. if state.conn.in_waiting() > 0:
  498. response = state.conn.readline()
  499. if response:
  500. logger.debug(f"FluidNC X steps response: {response}")
  501. # Response format: "/axes/x/steps_per_mm=200.000" or similar
  502. if 'steps_per_mm=' in response:
  503. try:
  504. x_steps = float(response.split('=')[1].strip())
  505. state.x_steps_per_mm = x_steps
  506. logger.info(f"X steps per mm (FluidNC): {x_steps}")
  507. except (ValueError, IndexError) as e:
  508. logger.warning(f"Failed to parse X steps: {e}")
  509. break
  510. elif response.lower().strip() == 'ok':
  511. break
  512. elif 'error' in response.lower() or 'alarm' in response.lower():
  513. # Device may be in alarm state (e.g., limit switch active)
  514. # Log and continue - settings queries often work anyway
  515. logger.debug(f"Got error/alarm response, continuing: {response}")
  516. else:
  517. time.sleep(0.05)
  518. except Exception as e:
  519. logger.error(f"Error querying FluidNC X steps: {e}")
  520. # Clear buffer before next query
  521. try:
  522. while state.conn.in_waiting() > 0:
  523. state.conn.readline()
  524. except Exception:
  525. pass
  526. # Query Y steps/mm
  527. try:
  528. state.conn.send("$/axes/y/steps_per_mm\n")
  529. time.sleep(0.2)
  530. start_time = time.time()
  531. while time.time() - start_time < 2.0:
  532. if state.conn.in_waiting() > 0:
  533. response = state.conn.readline()
  534. if response:
  535. logger.debug(f"FluidNC Y steps response: {response}")
  536. if 'steps_per_mm=' in response:
  537. try:
  538. y_steps = float(response.split('=')[1].strip())
  539. state.y_steps_per_mm = y_steps
  540. logger.info(f"Y steps per mm (FluidNC): {y_steps}")
  541. except (ValueError, IndexError) as e:
  542. logger.warning(f"Failed to parse Y steps: {e}")
  543. break
  544. elif response.lower().strip() == 'ok':
  545. break
  546. elif 'error' in response.lower() or 'alarm' in response.lower():
  547. logger.debug(f"Got error/alarm response, continuing: {response}")
  548. else:
  549. time.sleep(0.05)
  550. except Exception as e:
  551. logger.error(f"Error querying FluidNC Y steps: {e}")
  552. # Clear buffer before homing query
  553. try:
  554. while state.conn.in_waiting() > 0:
  555. state.conn.readline()
  556. except Exception:
  557. pass
  558. # Query homing cycle setting (informational - user preference takes precedence)
  559. try:
  560. state.conn.send("$/axes/y/homing/cycle\n")
  561. time.sleep(0.2)
  562. start_time = time.time()
  563. while time.time() - start_time < 1.5:
  564. if state.conn.in_waiting() > 0:
  565. response = state.conn.readline()
  566. if response:
  567. logger.debug(f"FluidNC homing response: {response}")
  568. if 'homing/cycle=' in response:
  569. try:
  570. homing_cycle = int(float(response.split('=')[1].strip()))
  571. # cycle >= 1 means homing is enabled in firmware
  572. firmware_homing = 1 if homing_cycle >= 1 else 0
  573. logger.info(f"Firmware homing setting (cycle): {homing_cycle}, using user preference: {state.homing}")
  574. except (ValueError, IndexError):
  575. pass
  576. break
  577. elif response.lower().strip() == 'ok':
  578. break
  579. else:
  580. time.sleep(0.05)
  581. except Exception as e:
  582. logger.debug(f"Could not query FluidNC homing setting: {e}")
  583. # Clear buffer
  584. try:
  585. while state.conn.in_waiting() > 0:
  586. state.conn.readline()
  587. except Exception:
  588. pass
  589. return (x_steps, y_steps)
  590. def _get_steps_grbl():
  591. """
  592. Get steps/mm from GRBL using $$ command.
  593. Returns tuple: (x_steps_per_mm, y_steps_per_mm) or (None, None) on failure.
  594. Note: Works even when device is in ALARM state (e.g., limit switch active).
  595. $$ command typically responds with settings even during alarm.
  596. """
  597. x_steps_per_mm = None
  598. y_steps_per_mm = None
  599. max_retries = 3
  600. attempt_timeout = 4
  601. for attempt in range(max_retries):
  602. logger.info(f"Requesting GRBL settings with $$ command (attempt {attempt + 1}/{max_retries})")
  603. try:
  604. state.conn.send("$$\n")
  605. except Exception as e:
  606. logger.error(f"Error sending $$ command: {e}")
  607. continue
  608. attempt_start = time.time()
  609. got_ok = False
  610. while time.time() - attempt_start < attempt_timeout:
  611. try:
  612. response = state.conn.readline()
  613. if not response:
  614. continue
  615. logger.debug(f"Raw response: {response}")
  616. for line in response.splitlines():
  617. line = line.strip()
  618. if not line:
  619. continue
  620. logger.debug(f"Config response: {line}")
  621. if line.startswith("$100="):
  622. x_steps_per_mm = float(line.split("=")[1])
  623. state.x_steps_per_mm = x_steps_per_mm
  624. logger.info(f"X steps per mm: {x_steps_per_mm}")
  625. elif line.startswith("$101="):
  626. y_steps_per_mm = float(line.split("=")[1])
  627. state.y_steps_per_mm = y_steps_per_mm
  628. logger.info(f"Y steps per mm: {y_steps_per_mm}")
  629. elif line.startswith("$22="):
  630. firmware_homing = int(line.split('=')[1])
  631. logger.info(f"Firmware homing setting ($22): {firmware_homing}, using user preference: {state.homing}")
  632. elif line.lower() == 'ok':
  633. got_ok = True
  634. logger.debug("Received 'ok' confirmation from GRBL")
  635. elif line.lower().startswith('error') or 'alarm' in line.lower():
  636. # Device may be in alarm state (e.g., limit switch active)
  637. # Log and continue - $$ typically works anyway
  638. logger.debug(f"Got error/alarm during settings query (proceeding): {line}")
  639. if got_ok:
  640. if x_steps_per_mm is not None and y_steps_per_mm is not None:
  641. logger.info("Successfully received all GRBL settings")
  642. break
  643. else:
  644. logger.warning("Received 'ok' but missing some settings")
  645. break
  646. except Exception as e:
  647. logger.error(f"Error reading GRBL response: {e}")
  648. break
  649. if x_steps_per_mm is not None and y_steps_per_mm is not None:
  650. break
  651. if attempt < max_retries - 1:
  652. logger.warning(f"Attempt {attempt + 1} did not get all settings, retrying...")
  653. time.sleep(0.5)
  654. try:
  655. while state.conn.in_waiting() > 0:
  656. state.conn.readline()
  657. except Exception:
  658. pass
  659. return (x_steps_per_mm, y_steps_per_mm)
  660. def get_machine_steps(timeout=10):
  661. """
  662. Get machine steps/mm from the controller (FluidNC or GRBL).
  663. Returns True if successful, False otherwise.
  664. Detects firmware type first:
  665. - FluidNC: Uses targeted $/axes/x/steps_per_mm queries (more reliable)
  666. - GRBL: Falls back to $$ command with retries
  667. """
  668. if not state.conn or not state.conn.is_connected():
  669. logger.error("Cannot get machine steps: No connection available")
  670. return False
  671. # Clear any pending data in the buffer
  672. try:
  673. while state.conn.in_waiting() > 0:
  674. state.conn.readline()
  675. except Exception as e:
  676. logger.warning(f"Error clearing buffer: {e}")
  677. # Verify controller is responsive before querying
  678. try:
  679. state.conn.send("?\n")
  680. time.sleep(0.2)
  681. ready_check_attempts = 5
  682. controller_ready = False
  683. in_alarm = False
  684. for _ in range(ready_check_attempts):
  685. if state.conn.in_waiting() > 0:
  686. response = state.conn.readline()
  687. if response and ('<' in response or 'Idle' in response or 'Alarm' in response):
  688. controller_ready = True
  689. if 'Alarm' in response:
  690. in_alarm = True
  691. logger.info(f"Controller in ALARM state (likely limit switch active), proceeding with settings query: {response.strip()}")
  692. else:
  693. logger.debug(f"Controller ready, status: {response}")
  694. break
  695. time.sleep(0.1)
  696. if not controller_ready:
  697. logger.warning("Controller not responding to status query, proceeding anyway...")
  698. # Clear buffer after readiness check
  699. while state.conn.in_waiting() > 0:
  700. state.conn.readline()
  701. time.sleep(0.1)
  702. except Exception as e:
  703. logger.warning(f"Readiness check failed: {e}, proceeding anyway...")
  704. # Detect firmware type
  705. firmware_type, firmware_version = _detect_firmware()
  706. if firmware_type == 'fluidnc':
  707. if firmware_version:
  708. logger.info(f"Detected FluidNC firmware, version: {firmware_version}")
  709. else:
  710. logger.info("Detected FluidNC firmware (version unknown)")
  711. x_steps_per_mm, y_steps_per_mm = _get_steps_fluidnc()
  712. # Fallback to GRBL method if FluidNC queries failed
  713. if x_steps_per_mm is None or y_steps_per_mm is None:
  714. logger.warning("FluidNC setting queries failed, falling back to $$ command...")
  715. x_steps_per_mm, y_steps_per_mm = _get_steps_grbl()
  716. else:
  717. if firmware_type == 'grbl':
  718. if firmware_version:
  719. logger.info(f"Detected GRBL firmware, version: {firmware_version}")
  720. else:
  721. logger.info("Detected GRBL firmware (version unknown)")
  722. else:
  723. logger.info("Could not detect firmware type, using GRBL commands")
  724. x_steps_per_mm, y_steps_per_mm = _get_steps_grbl()
  725. # Process results and determine table type
  726. settings_complete = (x_steps_per_mm is not None and y_steps_per_mm is not None)
  727. if settings_complete:
  728. if y_steps_per_mm == 180 and x_steps_per_mm == 256:
  729. state.table_type = 'dune_weaver_mini'
  730. elif y_steps_per_mm == 210 and x_steps_per_mm == 256:
  731. state.table_type = 'dune_weaver_mini_pro_byj'
  732. elif y_steps_per_mm == 270 and x_steps_per_mm == 200:
  733. state.table_type = 'dune_weaver_gold'
  734. elif y_steps_per_mm == 287:
  735. state.table_type = 'dune_weaver'
  736. elif y_steps_per_mm == 164:
  737. state.table_type = 'dune_weaver_mini_pro'
  738. elif y_steps_per_mm >= 320:
  739. state.table_type = 'dune_weaver_pro'
  740. else:
  741. state.table_type = None
  742. logger.warning(f"Unknown table type with Y steps/mm: {y_steps_per_mm}")
  743. # Use override if set, otherwise use detected table type
  744. effective_table_type = state.table_type_override or state.table_type
  745. # Set gear ratio based on effective table type (hardcoded)
  746. if effective_table_type in ['dune_weaver_mini', 'dune_weaver_mini_pro', 'dune_weaver_mini_pro_byj', 'dune_weaver_gold']:
  747. state.gear_ratio = 6.25
  748. else:
  749. state.gear_ratio = 10
  750. # Check for environment variable override
  751. gear_ratio_override = os.getenv('GEAR_RATIO')
  752. if gear_ratio_override is not None:
  753. try:
  754. state.gear_ratio = float(gear_ratio_override)
  755. logger.info(f"Machine type detected: {state.table_type}, effective: {effective_table_type}, gear ratio: {state.gear_ratio} (from GEAR_RATIO env var)")
  756. except ValueError:
  757. logger.error(f"Invalid GEAR_RATIO env var value: {gear_ratio_override}, using default: {state.gear_ratio}")
  758. logger.info(f"Machine type detected: {state.table_type}, effective: {effective_table_type}, gear ratio: {state.gear_ratio} (hardcoded)")
  759. elif state.table_type_override:
  760. logger.info(f"Machine type detected: {state.table_type}, overridden to: {effective_table_type}, gear ratio: {state.gear_ratio}")
  761. else:
  762. logger.info(f"Machine type detected: {state.table_type}, gear ratio: {state.gear_ratio} (hardcoded)")
  763. return True
  764. else:
  765. missing = []
  766. if x_steps_per_mm is None: missing.append("X steps/mm")
  767. if y_steps_per_mm is None: missing.append("Y steps/mm")
  768. logger.error(f"Failed to get all machine parameters after {timeout}s. Missing: {', '.join(missing)}")
  769. return False
  770. def home(timeout=90):
  771. """
  772. Perform homing sequence based on configured mode:
  773. Mode 0 (Crash):
  774. - Y axis moves -22mm (or -30mm for mini) until physical stop
  775. - Set theta=0, rho=0 (no x0 y0 command)
  776. Mode 1 (Sensor):
  777. - Send $H command to home both X and Y axes
  778. - Wait for [MSG:Homed:X] and [MSG:Homed:Y] messages
  779. - Send x0 y0 to zero positions
  780. - Set theta to compass offset, rho=0
  781. Args:
  782. timeout: Maximum time in seconds to wait for homing to complete (default: 90)
  783. """
  784. import threading
  785. import math
  786. # Check for alarm state before homing and unlock if needed
  787. if not check_and_unlock_alarm():
  788. logger.error("Failed to unlock device from alarm state, cannot proceed with homing")
  789. return False
  790. # Flag to track if homing completed
  791. homing_complete = threading.Event()
  792. homing_success = False
  793. def home_internal():
  794. nonlocal homing_success
  795. effective_table_type = state.table_type_override or state.table_type
  796. homing_speed = 400
  797. if effective_table_type == 'dune_weaver_mini':
  798. homing_speed = 100
  799. try:
  800. if state.homing == 1:
  801. # Mode 1: Sensor-based homing using $H
  802. logger.info("Using sensor-based homing mode ($H)")
  803. # Clear any pending responses
  804. state.homed_x = False
  805. state.homed_y = False
  806. # Send $H command
  807. state.conn.send("$H\n")
  808. logger.info("Sent $H command, waiting for homing messages...")
  809. # Wait for [MSG:Homed:X] and [MSG:Homed:Y] messages
  810. max_wait_time = 30 # 30 seconds timeout for homing messages
  811. start_time = time.time()
  812. while (time.time() - start_time) < max_wait_time:
  813. try:
  814. response = state.conn.readline()
  815. if response:
  816. logger.debug(f"Homing response: {response}")
  817. # Check for homing messages
  818. if "[MSG:Homed:X]" in response:
  819. state.homed_x = True
  820. logger.info("Received [MSG:Homed:X]")
  821. if "[MSG:Homed:Y]" in response:
  822. state.homed_y = True
  823. logger.info("Received [MSG:Homed:Y]")
  824. # Break if we've received both messages
  825. if state.homed_x and state.homed_y:
  826. logger.info("Received both homing confirmation messages")
  827. break
  828. except Exception as e:
  829. logger.error(f"Error reading homing response: {e}")
  830. time.sleep(0.1)
  831. if not (state.homed_x and state.homed_y):
  832. logger.warning(f"Did not receive all homing messages (X:{state.homed_x}, Y:{state.homed_y}), unlocking and continuing...")
  833. # Unlock machine to clear any alarm state
  834. state.conn.send("$X\n")
  835. time.sleep(0.5)
  836. # Wait for idle state after $H
  837. logger.info("Waiting for device to reach idle state after $H...")
  838. idle_reached = check_idle()
  839. if not idle_reached:
  840. logger.error("Device did not reach idle state after $H command")
  841. homing_complete.set()
  842. return
  843. # Skip zeroing if X homed but Y failed - moving Y to 0 would crash it
  844. # (Y controls rho/radial position which is unknown if Y didn't home)
  845. if state.homed_x and not state.homed_y:
  846. logger.warning("Skipping position zeroing - X homed but Y failed (would crash Y axis)")
  847. else:
  848. # Send x0 y0 to zero both positions using send_grbl_coordinates
  849. logger.info(f"Zeroing positions with x0 y0 f{homing_speed}")
  850. # Run async function in new event loop
  851. loop = asyncio.new_event_loop()
  852. asyncio.set_event_loop(loop)
  853. try:
  854. # Send G1 X0 Y0 F{homing_speed}
  855. result = loop.run_until_complete(send_grbl_coordinates(0, 0, homing_speed))
  856. if result == False:
  857. logger.error("Position zeroing failed - send_grbl_coordinates returned False")
  858. homing_complete.set()
  859. return
  860. logger.info("Position zeroing completed successfully")
  861. finally:
  862. loop.close()
  863. # Wait for device to reach idle state after zeroing movement
  864. logger.info("Waiting for device to reach idle state after zeroing...")
  865. idle_reached = check_idle()
  866. if not idle_reached:
  867. logger.error("Device did not reach idle state after zeroing")
  868. homing_complete.set()
  869. return
  870. # Set current position based on compass reference point (sensor mode only)
  871. offset_radians = math.radians(state.angular_homing_offset_degrees)
  872. state.current_theta = offset_radians
  873. state.current_rho = 0
  874. logger.info(f"Sensor homing completed - theta set to {state.angular_homing_offset_degrees}° ({offset_radians:.3f} rad), rho=0")
  875. else:
  876. logger.info(f"Using crash homing mode at {homing_speed} mm/min")
  877. # Run async function in new event loop
  878. loop = asyncio.new_event_loop()
  879. asyncio.set_event_loop(loop)
  880. try:
  881. if effective_table_type == 'dune_weaver_mini':
  882. result = loop.run_until_complete(send_grbl_coordinates(0, -30, homing_speed, home=True))
  883. if result == False:
  884. logger.error("Crash homing failed - send_grbl_coordinates returned False")
  885. homing_complete.set()
  886. return
  887. state.machine_y -= 30
  888. else:
  889. result = loop.run_until_complete(send_grbl_coordinates(0, -22, homing_speed, home=True))
  890. if result == False:
  891. logger.error("Crash homing failed - send_grbl_coordinates returned False")
  892. homing_complete.set()
  893. return
  894. state.machine_y -= 22
  895. finally:
  896. loop.close()
  897. # Wait for device to reach idle state after crash homing
  898. logger.info("Waiting for device to reach idle state after crash homing...")
  899. idle_reached = check_idle()
  900. if not idle_reached:
  901. logger.error("Device did not reach idle state after crash homing")
  902. homing_complete.set()
  903. return
  904. # Crash homing just sets theta and rho to 0 (no x0 y0 command)
  905. state.current_theta = 0
  906. state.current_rho = 0
  907. logger.info("Crash homing completed - theta=0, rho=0")
  908. # Update machine position from hardware after homing
  909. logger.info("Updating machine position after homing...")
  910. try:
  911. pos = get_machine_position()
  912. if pos and pos[0] is not None and pos[1] is not None:
  913. state.machine_x, state.machine_y = pos
  914. state.save()
  915. logger.info(f"Machine position updated after homing: X={state.machine_x}, Y={state.machine_y}")
  916. else:
  917. logger.warning("Could not get machine position after homing")
  918. except Exception as e:
  919. logger.error(f"Error updating machine position after homing: {e}")
  920. homing_success = True
  921. homing_complete.set()
  922. except Exception as e:
  923. logger.error(f"Error during homing: {e}")
  924. homing_complete.set()
  925. # Start homing in a separate thread
  926. homing_thread = threading.Thread(target=home_internal)
  927. homing_thread.daemon = True
  928. homing_thread.start()
  929. # Wait for homing to complete or timeout
  930. if not homing_complete.wait(timeout):
  931. logger.error(f"Homing timeout after {timeout} seconds")
  932. # Try to stop any ongoing movement
  933. try:
  934. if state.conn and state.conn.is_connected():
  935. state.conn.send("!\n") # Send feed hold
  936. time.sleep(0.1)
  937. state.conn.send("\x18\n") # Send reset
  938. except Exception as e:
  939. logger.error(f"Error stopping movement after timeout: {e}")
  940. return False
  941. if not homing_success:
  942. logger.error("Homing failed")
  943. return False
  944. logger.info("Homing completed successfully")
  945. return True
  946. def check_idle():
  947. """
  948. Continuously check if the device is idle (synchronous version).
  949. """
  950. logger.info("Checking idle")
  951. while True:
  952. response = get_status_response()
  953. if response and "Idle" in response:
  954. logger.info("Device is idle")
  955. # Schedule async update_machine_position in the existing event loop
  956. try:
  957. # Try to schedule in existing event loop if available
  958. try:
  959. loop = asyncio.get_running_loop()
  960. # Create a task but don't await it (fire and forget)
  961. asyncio.create_task(update_machine_position())
  962. logger.debug("Scheduled machine position update task")
  963. except RuntimeError:
  964. # No event loop running, skip machine position update
  965. logger.debug("No event loop running, skipping machine position update")
  966. except Exception as e:
  967. logger.error(f"Error scheduling machine position update: {e}")
  968. return True
  969. time.sleep(1)
  970. async def check_idle_async(timeout: float = 30.0):
  971. """
  972. Continuously check if the device is idle (async version).
  973. Args:
  974. timeout: Maximum seconds to wait for idle state (default 30s)
  975. Returns:
  976. True if device became idle, False if timeout or stop requested
  977. """
  978. logger.info("Checking idle (async)")
  979. start_time = asyncio.get_event_loop().time()
  980. while True:
  981. # Check if stop was requested - exit early
  982. if state.stop_requested:
  983. logger.info("Stop requested during idle check, exiting early")
  984. return False
  985. # Check timeout
  986. elapsed = asyncio.get_event_loop().time() - start_time
  987. if elapsed > timeout:
  988. logger.warning(f"Timeout ({timeout}s) waiting for device idle state")
  989. return False
  990. response = await asyncio.to_thread(get_status_response)
  991. if response and "Idle" in response:
  992. logger.info("Device is idle")
  993. try:
  994. await update_machine_position()
  995. except Exception as e:
  996. logger.error(f"Error updating machine position: {e}")
  997. return True
  998. await asyncio.sleep(1)
  999. def is_machine_idle() -> bool:
  1000. """
  1001. Single check to see if the machine is currently idle.
  1002. Does not loop - returns immediately with current status.
  1003. Returns:
  1004. True if machine is idle, False otherwise
  1005. """
  1006. if not state.conn or not state.conn.is_connected():
  1007. logger.debug("No connection - machine not idle")
  1008. return False
  1009. try:
  1010. state.conn.send('?')
  1011. response = state.conn.readline()
  1012. if response and "Idle" in response:
  1013. logger.debug("Machine status: Idle")
  1014. return True
  1015. else:
  1016. logger.debug(f"Machine status: {response}")
  1017. return False
  1018. except Exception as e:
  1019. logger.error(f"Error checking machine idle status: {e}")
  1020. return False
  1021. def get_machine_position(timeout=5):
  1022. """
  1023. Query the device for its position.
  1024. """
  1025. start_time = time.time()
  1026. while time.time() - start_time < timeout:
  1027. try:
  1028. state.conn.send('?')
  1029. response = state.conn.readline()
  1030. logger.debug(f"Raw status response: {response}")
  1031. if "MPos" in response:
  1032. pos = parse_machine_position(response)
  1033. if pos:
  1034. machine_x, machine_y = pos
  1035. logger.debug(f"Machine position: X={machine_x}, Y={machine_y}")
  1036. return machine_x, machine_y
  1037. except Exception as e:
  1038. logger.error(f"Error getting machine position: {e}")
  1039. return
  1040. time.sleep(0.1)
  1041. logger.warning("Timeout reached waiting for machine position")
  1042. return None, None
  1043. async def update_machine_position():
  1044. if (state.conn.is_connected() if state.conn else False):
  1045. try:
  1046. logger.info('Saving machine position')
  1047. state.machine_x, state.machine_y = await asyncio.to_thread(get_machine_position)
  1048. await asyncio.to_thread(state.save)
  1049. logger.info(f'Machine position saved: {state.machine_x}, {state.machine_y}')
  1050. except Exception as e:
  1051. logger.error(f"Error updating machine position: {e}")
  1052. def restart_connection(homing=False):
  1053. """
  1054. Restart the connection. If a connection exists, close it and attempt to establish a new one.
  1055. It will try to connect via serial first (if available), otherwise it will fall back to websocket.
  1056. The new connection is saved to state.conn.
  1057. Returns:
  1058. True if the connection was restarted successfully, False otherwise.
  1059. """
  1060. try:
  1061. if (state.conn.is_connected() if state.conn else False):
  1062. logger.info("Closing current connection...")
  1063. state.conn.close()
  1064. except Exception as e:
  1065. logger.error(f"Error while closing connection: {e}")
  1066. # Clear the connection reference.
  1067. state.conn = None
  1068. logger.info("Attempting to restart connection...")
  1069. try:
  1070. connect_device(homing) # This will set state.conn appropriately.
  1071. if (state.conn.is_connected() if state.conn else False):
  1072. logger.info("Connection restarted successfully.")
  1073. return True
  1074. else:
  1075. logger.error("Failed to restart connection.")
  1076. return False
  1077. except Exception as e:
  1078. logger.error(f"Error restarting connection: {e}")
  1079. return False