mcu timeout on connect

[tomkiley]

I think I've flashed klipper correctly but I'm unable to connect to the printer. I used the same method to flash back to stock marlin and then back to klipper again and that appeared to work.

Some debugging output:

$ dmesg -e
[Apr16 11:45] usb 6-1: new full-speed USB device number 6 using ohci-platform
[  +0.225063] usb 6-1: New USB device found, idVendor=1a86, idProduct=7523, bcdDevice= 2.64
[  +0.000044] usb 6-1: New USB device strings: Mfr=0, Product=2, SerialNumber=0
[  +0.000020] usb 6-1: Product: USB Serial
[  +0.002270] ch341 6-1:1.0: ch341-uart converter detected
[  +0.012032] usb 6-1: ch341-uart converter now attached to ttyUSB0

$ ls -l /dev/serial/by-id/usb-1a86_USB_Serial-if00-port0
lrwxrwxrwx 1 root root 13 Apr 16 11:45 /dev/serial/by-id/usb-1a86_USB_Serial-if00-port0 -> ../../ttyUSB0

$ ls -l /dev/ttyUSB0
crw-rw---- 1 root dialout 188, 0 Apr 16 11:45 /dev/ttyUSB0

$ /bin/udevadm info --name=/dev/ttyUSB0
P: /devices/platform/soc/5200400.usb/usb6/6-1/6-1:1.0/ttyUSB0/tty/ttyUSB0
N: ttyUSB0
L: 0
S: serial/by-path/platform-5200400.usb-usb-0:1:1.0-port0
S: serial/by-id/usb-1a86_USB_Serial-if00-port0
E: DEVPATH=/devices/platform/soc/5200400.usb/usb6/6-1/6-1:1.0/ttyUSB0/tty/ttyUSB0
E: DEVNAME=/dev/ttyUSB0
E: MAJOR=188
E: MINOR=0
E: SUBSYSTEM=tty
E: USEC_INITIALIZED=7650528090
E: ID_VENDOR=1a86
E: ID_VENDOR_ENC=1a86
E: ID_VENDOR_ID=1a86
E: ID_MODEL=USB_Serial
E: ID_MODEL_ENC=USB\x20Serial
E: ID_MODEL_ID=7523
E: ID_REVISION=0264
E: ID_SERIAL=1a86_USB_Serial
E: ID_TYPE=generic
E: ID_BUS=usb
E: ID_USB_INTERFACES=:ff0102:
E: ID_USB_INTERFACE_NUM=00
E: ID_USB_DRIVER=ch341
E: ID_USB_CLASS_FROM_DATABASE=Vendor Specific Class
E: ID_VENDOR_FROM_DATABASE=QinHeng Electronics
E: ID_MODEL_FROM_DATABASE=CH340 serial converter
E: ID_PATH=platform-5200400.usb-usb-0:1:1.0
E: ID_PATH_TAG=platform-5200400_usb-usb-0_1_1_0
E: ID_FOR_SEAT=tty-platform-5200400_usb-usb-0_1_1_0
E: DEVLINKS=/dev/serial/by-path/platform-5200400.usb-usb-0:1:1.0-port0 /dev/serial/by-id/usb-1a86_USB_Serial-if00-port0
E: TAGS=:uaccess:seat:systemd:
E: CURRENT_TAGS=:uaccess:seat:systemd:

klippy.log

Start printer at Sun Apr 16 11:47:04 2023 (1681660024.3 7726.4)
===== Config file =====

...

[mcu]
serial = /dev/serial/by-id/usb-1a86_USB_Serial-if00-port0
restart_method = command

...

=======================
Extruder max_extrude_ratio=0.266081
mcu 'mcu': Starting serial connect
webhooks client 281473016570272: New connection
webhooks client 281473016570272: Client info {'program': 'Moonraker', 'version': 'v0.8.0-35-geff0901'}
mcu 'mcu': Timeout on connect
mcu 'mcu': Wait for identify_response
Traceback (most recent call last):
  File "/home/orangepi/klipper/klippy/serialhdl.py", line 68, in _get_identify_data
    params = self.send_with_response(msg, 'identify_response')
  File "/home/orangepi/klipper/klippy/serialhdl.py", line 261, in send_with_response
    return src.get_response([cmd], self.default_cmd_queue)
  File "/home/orangepi/klipper/klippy/serialhdl.py", line 318, in get_response
    self.serial.raw_send_wait_ack(cmds[-1], minclock, reqclock,
  File "/home/orangepi/klipper/klippy/serialhdl.py", line 253, in raw_send_wait_ack
    self._error("Serial connection closed")
  File "/home/orangepi/klipper/klippy/serialhdl.py", line 61, in _error
    raise error(self.warn_prefix + (msg % params))
serialhdl.error: mcu 'mcu': Serial connection closed

... repeats ~15 more times

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
  File "/home/orangepi/klipper/klippy/klippy.py", line 176, in _connect
    self.send_event("klippy:mcu_identify")
  File "/home/orangepi/klipper/klippy/klippy.py", line 263, in send_event
    return [cb(*params) for cb in self.event_handlers.get(event, [])]
  File "/home/orangepi/klipper/klippy/klippy.py", line 263, in <listcomp>
    return [cb(*params) for cb in self.event_handlers.get(event, [])]
  File "/home/orangepi/klipper/klippy/mcu.py", line 803, in _mcu_identify
    raise error(str(e))
mcu.error: mcu 'mcu': Unable to connect
No build file /home/orangepi/klipper/klippy/../.config
No build file /home/orangepi/klipper/klippy/../out/klipper.dict
No build file /home/orangepi/klipper/klippy/../out/klipper.elf
mcu 'mcu': Wait for identify_response
Traceback (most recent call last):
  File "/home/orangepi/klipper/klippy/serialhdl.py", line 68, in _get_identify_data
    params = self.send_with_response(msg, 'identify_response')
  File "/home/orangepi/klipper/klippy/serialhdl.py", line 261, in send_with_response
    return src.get_response([cmd], self.default_cmd_queue)
  File "/home/orangepi/klipper/klippy/serialhdl.py", line 318, in get_response
    self.serial.raw_send_wait_ack(cmds[-1], minclock, reqclock,
  File "/home/orangepi/klipper/klippy/serialhdl.py", line 253, in raw_send_wait_ack
    self._error("Serial connection closed")
  File "/home/orangepi/klipper/klippy/serialhdl.py", line 61, in _error
    raise error(self.warn_prefix + (msg % params))
serialhdl.error: mcu 'mcu': Serial connection closed

Any suggestions?

[bassamanator]

Please read the Before you begin section, and check your username.

[tomkiley]

Thanks.

I think I did the home directory substitutions correctly.

orangepi@klipper:~/printer_data$ grep home config/moonraker.conf
klippy_uds_address: /home/orangepi/printer_data/comms/klippy.sock

orangepi@klipper:~/printer_data$ ls -l /home/orangepi/printer_data/comms/klippy.sock
srwxr-xr-x 1 orangepi orangepi 0 Apr 16 12:01 /home/orangepi/printer_data/comms/klippy.sock

orangepi@klipper:~/printer_data$ grep home config/cfgs/misc-macros.cfg
path: /home/orangepi/printer_data/gcodes
    {% if "xyz" not in printer.toolhead.homed_axes %}

orangepi@klipper:~/printer_data$ ls -l /home/orangepi/printer_data/gcodes
total 0

orangepi@klipper:~/printer_data$ ps ax | grep klippy
   2560 ?        Ssl    0:57 /home/orangepi/klippy-env/bin/python /home/orangepi/klipper/klippy/klippy.py /home/orangepi/printer_data/config/printer.cfg -I /home/orangepi/printer_data/comms/klippy.serial -l /home/orangepi/printer_data/logs/klippy.log -a /home/orangepi/printer_data/comms/klippy.sock

[tomkiley]

Removed both these lines

[temperature_sensor raspberry_pi]
sensor_type: temperature_host

No change though. Rebooted to be sure the new values were being read. I really appreciate your help.

[bassamanator]

Post klippy.log.

[tomkiley]

klippy.log

[bassamanator]

Paste the output from groups $USER.

[tomkiley]

orangepi@klipper:~$ groups $USER
orangepi : orangepi tty disk dialout sudo audio video plugdev games users systemd-journal input netdev

[tomkiley]

I think I've got it now.

I made a few more attempts at flashing and tried a different SD Card and that seems to have done it.

Thanks again for you help and the work you did putting this together.

[bassamanator]

Based on what I was reading in the log, it seemed that there was perhaps some issue with the flash but couldn't say with certainty. Glad you figured it out.

Please close this discussion.

Best!