Hey guys,
Getting OctoPrint set up on my Tevo Tornado. I love it when it works. Running a RasPi 3B. It's been just randomly losing connection to the printer in mid-print. Doesn't power off, just loses connection.
Knowing that power issues are a thing, I got a brand new USB power supply for it and made sure it was 5v 2.5A.
Also went with USB cable with ferrite chokes.
https://www.amazon.com/gp/product/B003MQ29B2/ref=ppx_yo_dt_b_asin_title_o06_s00?ie=UTF8&psc=1
Here's the log:
2020-08-17 19:13:40,488 - octoprint.server.heartbeat - INFO - Server heartbeat <3
2020-08-17 19:13:41,502 - octoprint.server.util.flask - INFO - Passively logging in user Overlord from ::ffff:192.168.1.9
2020-08-17 19:13:41,505 - octoprint.access.users - INFO - Logged in user: Overlord
2020-08-17 19:14:25,273 - octoprint.server.preemptive_cache - INFO - ... done in 45.64s
2020-08-17 19:14:25,276 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'query_string': 'l10n=en', 'path': '/', 'base_url': 'http://octopi.local/'}
2020-08-17 19:14:25,365 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:192.168.1.9
2020-08-17 19:14:26,246 - octoprint.server.preemptive_cache - INFO - ... done in 0.97s
2020-08-17 19:14:26,249 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'query_string': 'l10n=en', 'path': '/', 'base_url': 'http://192.168.1.12/'}
2020-08-17 19:14:27,079 - octoprint.server.preemptive_cache - INFO - ... done in 0.83s
2020-08-17 19:14:29,324 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:192.168.1.9
2020-08-17 19:14:29,420 - octoprint.server.util.flask - INFO - Passively logging in user Overlord from ::ffff:192.168.1.9
2020-08-17 19:14:29,421 - octoprint.access.users - INFO - Logged in user: Overlord
2020-08-17 19:14:33,567 - octoprint.plugins.announcements - INFO - Loaded channel _important from https://octoprint.org/feeds/important.xml in 0.51s
2020-08-17 19:14:34,356 - octoprint.plugins.announcements - INFO - Loaded channel _releases from https://octoprint.org/feeds/releases.xml in 0.55s
2020-08-17 19:14:35,992 - octoprint.plugins.announcements - INFO - Loaded channel _blog from https://octoprint.org/feeds/octoblog.xml in 0.53s
2020-08-17 19:14:36,594 - octoprint.plugins.announcements - INFO - Loaded channel _plugins from https://plugins.octoprint.org/feed.xml in 0.53s
2020-08-17 19:14:37,289 - octoprint.plugins.announcements - INFO - Loaded channel _octopi from https://octoprint.org/feeds/octopi.xml in 0.59s
2020-08-17 19:14:38,246 - octoprint.plugins.pluginmanager - INFO - Loaded plugin notices data from https://plugins.octoprint.org/notices.json
2020-08-17 19:14:38,892 - octoprint.server.util.sockjs - INFO - User Overlord logged in on the socket from client ::ffff:192.168.1.9
2020-08-17 19:16:57,360 - octoprint.filemanager.analysis - INFO - Starting analysis of local:Pi_pieces.gcode
2020-08-17 19:16:57,367 - octoprint.filemanager.analysis - INFO - Invoking analysis command: /home/pi/oprint/bin/python2 -m octoprint analysis gcode --speed-x=6000 --speed-y=6000 --max-t=10 --throttle=0.0 --throttle-lines=100 /home/pi/.octoprint/uploads/Pi_pieces.gcode
2020-08-17 19:17:06,193 - octoprint.util.comm - INFO - Changing monitoring state from "Offline" to "Detecting serial connection"
2020-08-17 19:17:06,353 - octoprint.util.comm - INFO - Serial detection: Performing autodetection with 7 port/baudrate candidates: /dev/ttyUSB0@115200, /dev/ttyUSB0@250000, /dev/ttyUSB0@230400, /dev/ttyUSB0@57600, /dev/ttyUSB0@38400, /dev/ttyUSB0@19200, /dev/ttyUSB0@9600
2020-08-17 19:17:06,355 - octoprint.util.comm - INFO - Serial detection: Trying port /dev/ttyUSB0, baudrate 115200
2020-08-17 19:17:06,357 - octoprint.util.comm - INFO - Connecting to port /dev/ttyUSB0, baudrate 115200
2020-08-17 19:17:06,370 - octoprint.util.comm - INFO - Serial detection: Handshake attempt #1 with timeout 2.0s
2020-08-17 19:17:06,374 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-08-17 19:17:09,543 - octoprint.util.comm - INFO - Serial detection: Handshake attempt #2 with timeout 2.0s
2020-08-17 19:17:09,550 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-08-17 19:17:11,553 - octoprint.util.comm - INFO - Serial detection: Handshake attempt #3 with timeout 2.0s
2020-08-17 19:17:11,561 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-08-17 19:17:13,563 - octoprint.util.comm - INFO - Serial detection: Trying port /dev/ttyUSB0, baudrate 250000
2020-08-17 19:17:13,570 - octoprint.util.comm - INFO - Serial detection: Handshake attempt #1 with timeout 2.0s
2020-08-17 19:17:13,574 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-08-17 19:17:14,152 - octoprint.filemanager.analysis - INFO - Analysis of entry local:Pi_pieces.gcode finished, needed 16.79s
2020-08-17 19:17:14,586 - octoprint.util.comm - INFO - Changing monitoring state from "Detecting serial connection" to "Operational"
2020-08-17 19:17:14,597 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-08-17 19:17:14,778 - octoprint.util.comm - INFO - Printer reports firmware name "Marlin 1.1.6 (Github)"
2020-08-17 19:17:14,783 - octoprint.util.comm - INFO - Firmware states that it supports temperature autoreporting
2020-08-17 19:17:14,796 - octoprint.util.comm - INFO - Got a resend request from the printer: requested line = 1, current line = 3
| Last lines in terminal:
| Recv: ok
| Send: N1 M115*39
| Recv: ok
| Send: N2 M20*19
| Recv: FIRMWARE_NAME:Marlin 1.1.6 (Github) SOURCE_CODE_URL:https://github.com/MarlinFirmware/Marlin PROTOCOL_VERSION:1.0 MACHINE_TYPE:TEVO Tornado EXTRUDER_COUNT:1 UUID:cede2a2f-41a2-4748-9b12-c55c62f367ff
| Recv: Cap:EEPROM:1
| Recv: Cap:AUTOREPORT_TEMP:1
| Recv: Cap:PROGRESS:0
| Recv: Cap:PRINT_JOB:1
| Recv: Cap:AUTOLEVEL:1
| Recv: Cap:Z_PROBE:1
| Recv: Cap:LEVELING_DATA:1
| Recv: Cap:SOFTWARE_POWER:0
| Recv: Cap:TOGGLE_LIGHTS:0
| Recv: Cap:CASE_LIGHT_BRIGHTNESS:0
| Recv: Cap:EMERGENCY_PARSER:0
| Recv: ok
| Send: M155 S2
| Recv: Error:Line Number is not Last Line Number+1, Last Line: 0
| Recv: Resend: 1
2020-08-17 19:17:14,836 - octoprint.util.comm - INFO - Firmware states that it supports temperature autoreporting
2020-08-17 19:17:15,161 - octoprint.filemanager.analysis - INFO - Starting analysis of local:CR-10_Spool_Holder.gcode
2020-08-17 19:17:15,164 - octoprint.filemanager.analysis - INFO - Invoking analysis command: /home/pi/oprint/bin/python2 -m octoprint analysis gcode --speed-x=6000 --speed-y=6000 --max-t=10 --throttle=0.01 --throttle-lines=100 /home/pi/.octoprint/uploads/CR-10_Spool_Holder.gcode
2020-08-17 19:17:25,544 - octoprint.printer.standard.job - INFO - Print job selected - origin: local, path: Pi_pieces.gcode, owner: Overlord, user: Overlord
2020-08-17 19:17:25,563 - octoprint.util.comm - INFO - Changing monitoring state from "Operational" to "Starting"
2020-08-17 19:17:25,571 - octoprint.printer.standard.job - INFO - Print job started - origin: local, path: Pi_pieces.gcode, owner: Overlord, user: Overlord
2020-08-17 19:17:25,578 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-08-17 19:17:25,602 - octoprint.util.comm - INFO - Changing monitoring state from "Starting" to "Printing"
2020-08-17 19:18:40,589 - octoprint.plugins.pi_support - WARNING - This Raspberry Pi is reporting problems that might lead to bad performance or errors caused by overheating or insufficient power.
!!! FREQUENCY CAPPING DUE TO OVERHEATING REPORTED !!! Improve cooling on the Pi's CPU and GPU.
2020-08-17 19:20:01,900 - octoprint.util.comm - INFO - Printer seems to support the busy protocol, will adjust timeouts and set busy interval accordingly
2020-08-17 19:20:25,904 - octoprint.util.comm - INFO - Telling the printer to set the busy interval to our "communicationBusy" timeout - 1s = 2s
2020-08-17 19:28:40,507 - octoprint.server.heartbeat - INFO - Server heartbeat <3
2020-08-17 19:36:24,990 - octoprint.util.comm - INFO - Communication timeout while printing, trying to trigger response from printer.
2020-08-17 19:36:28,007 - octoprint.util.comm - INFO - Communication timeout while printing, trying to trigger response from printer.
2020-08-17 19:36:31,016 - octoprint.util.comm - INFO - Communication timeout while printing, trying to trigger response from printer.
2020-08-17 19:36:34,023 - octoprint.util.comm - INFO - Communication timeout while printing, trying to trigger response from printer.
2020-08-17 19:36:37,031 - octoprint.util.comm - INFO - Communication timeout while printing, trying to trigger response from printer.
2020-08-17 19:36:40,047 - octoprint.util.comm - INFO - No response from printer after 6 consecutive communication timeouts, considering it dead.
2020-08-17 19:36:40,088 - octoprint.util.comm - INFO - Changing monitoring state from "Printing" to "Offline (Error: Too many consecutive timeouts, printer still connected and alive?)"
2020-08-17 19:36:40,096 - octoprint.filemanager.analysis - INFO - Starting analysis of local:CR-10_Spool_Holder.gcode
2020-08-17 19:36:40,100 - octoprint.filemanager.analysis - INFO - Invoking analysis command: /home/pi/oprint/bin/python2 -m octoprint analysis gcode --speed-x=6000 --speed-y=6000 --max-t=10 --throttle=0.01 --throttle-lines=100 /home/pi/.octoprint/uploads/CR-10_Spool_Holder.gcode
2020-08-17 19:36:40,119 - octoprint.plugins.action_command_notification - INFO - Notifications cleared
2020-08-17 19:36:40,847 - tornado.access - WARNING - 409 GET /api/printer (::ffff:192.168.1.15) 11.01ms
2020-08-17 19:36:41,305 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:192.168.1.15
2020-08-17 19:36:41,865 - octoprint.server.util.flask - INFO - Passively logging in user _api from ::ffff:192.168.1.15
2020-08-17 19:36:41,867 - octoprint.access.users - INFO - Logged in user: _api
2020-08-17 19:36:41,984 - octoprint.server.util.sockjs - INFO - User _api logged in on the socket from client ::ffff:192.168.1.15
2020-08-17 19:36:42,917 - octoprint.util.comm - INFO - Changing monitoring state from "Offline" to "Detecting serial connection"
2020-08-17 19:36:43,002 - octoprint.util.comm - INFO - Serial detection: Performing autodetection with 7 port/baudrate candidates: /dev/ttyUSB0@115200, /dev/ttyUSB0@250000, /dev/ttyUSB0@230400, /dev/ttyUSB0@57600, /dev/ttyUSB0@38400, /dev/ttyUSB0@19200, /dev/ttyUSB0@9600
2020-08-17 19:36:43,004 - octoprint.util.comm - INFO - Serial detection: Trying port /dev/ttyUSB0, baudrate 115200
2020-08-17 19:36:43,006 - octoprint.util.comm - INFO - Connecting to port /dev/ttyUSB0, baudrate 115200
2020-08-17 19:36:43,018 - octoprint.util.comm - INFO - Serial detection: Handshake attempt #1 with timeout 2.0s
2020-08-17 19:36:43,022 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-08-17 19:36:44,151 - octoprint.util.comm - WARNING - Received line:
2020-08-17 19:36:44,152 - octoprint.util.comm - WARNING - | 8|J"áAÿzzBâzzBò!x{I2N>¼}tÛseÛ_p8JÿJJ JJ0%%ÿ%%'\x00ù=Ncº_KnCsùmSváñ!KoSvë!|Bâ!BÿKJAüJJròKJC²N>\x00¾]«ö}V!e
2020-08-17 19:36:44,153 - octoprint.util.comm - WARNING - The received line contains at least one null byte character at position 59, this hints at some data corruption going on
2020-08-17 19:36:46,180 - octoprint.util.comm - INFO - Serial detection: Handshake attempt #2 with timeout 2.0s
2020-08-17 19:36:46,184 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-08-17 19:36:48,187 - octoprint.util.comm - INFO - Serial detection: Handshake attempt #3 with timeout 2.0s
2020-08-17 19:36:48,190 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-08-17 19:36:48,970 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:192.168.1.15
2020-08-17 19:36:50,202 - octoprint.util.comm - INFO - Serial detection: Trying port /dev/ttyUSB0, baudrate 250000
2020-08-17 19:36:50,207 - octoprint.util.comm - INFO - Serial detection: Handshake attempt #1 with timeout 2.0s
2020-08-17 19:36:50,210 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-08-17 19:36:51,230 - octoprint.util.comm - INFO - Changing monitoring state from "Detecting serial connection" to "Operational"
2020-08-17 19:36:51,235 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-08-17 19:36:51,461 - octoprint.util.comm - INFO - Printer reports firmware name "Marlin 1.1.6 (Github)"
2020-08-17 19:36:51,469 - octoprint.util.comm - INFO - Firmware states that it supports temperature autoreporting
2020-08-17 19:37:46,720 - octoprint.server.util.sockjs - INFO - New connection from client: fe80::1435:2ea3:7ad8:e797
2020-08-17 19:37:47,287 - octoprint.server.util.flask - INFO - Passively logging in user _api from fe80::1435:2ea3:7ad8:e797
2020-08-17 19:37:47,290 - octoprint.access.users - INFO - Logged in user: _api
2020-08-17 19:37:47,315 - octoprint.server.util.sockjs - INFO - User _api logged in on the socket from client fe80::1435:2ea3:7ad8:e797
2020-08-17 19:37:56,035 - octoprint.printer.standard.job - INFO - Print job selected - origin: local, path: Pi_pieces.gcode, owner: _api, user: _api
2020-08-17 19:37:56,058 - octoprint.util.comm - INFO - Changing monitoring state from "Operational" to "Starting"
2020-08-17 19:37:56,066 - octoprint.printer.standard.job - INFO - Print job started - origin: local, path: Pi_pieces.gcode, owner: _api, user: _api
2020-08-17 19:37:56,075 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-08-17 19:37:56,093 - octoprint.util.comm - INFO - Changing monitoring state from "Starting" to "Printing"
2020-08-17 19:38:17,098 - octoprint.server.util.sockjs - INFO - Client connection closed: fe80::1435:2ea3:7ad8:e797
2020-08-17 19:39:03,563 - octoprint.util.comm - INFO - Printer seems to support the busy protocol, will adjust timeouts and set busy interval accordingly
2020-08-17 19:39:19,544 - octoprint.util.comm - INFO - Telling the printer to set the busy interval to our "communicationBusy" timeout - 1s = 2s
2020-08-17 19:41:27,988 - octoprint.util.comm - INFO - Communication timeout while printing, trying to trigger response from printer.
2020-08-17 19:41:30,996 - octoprint.util.comm - INFO - Communication timeout while printing, trying to trigger response from printer.
2020-08-17 19:41:34,003 - octoprint.util.comm - INFO - Communication timeout while printing, trying to trigger response from printer.
2020-08-17 19:41:37,010 - octoprint.util.comm - INFO - Communication timeout while printing, trying to trigger response from printer.
2020-08-17 19:41:40,017 - octoprint.util.comm - INFO - Communication timeout while printing, trying to trigger response from printer.
2020-08-17 19:41:43,032 - octoprint.util.comm - INFO - No response from printer after 6 consecutive communication timeouts, considering it dead.
2020-08-17 19:41:43,072 - octoprint.util.comm - INFO - Changing monitoring state from "Printing" to "Offline (Error: Too many consecutive timeouts, printer still connected and alive?)"
2020-08-17 19:41:43,095 - octoprint.filemanager.analysis - INFO - Starting analysis of local:CR-10_Spool_Holder.gcode
2020-08-17 19:41:43,100 - octoprint.filemanager.analysis - INFO - Invoking analysis command: /home/pi/oprint/bin/python2 -m octoprint analysis gcode --speed-x=6000 --speed-y=6000 --max-t=10 --throttle=0.01 --throttle-lines=100 /home/pi/.octoprint/uploads/CR-10_Spool_Holder.gcode
2020-08-17 19:41:43,102 - octoprint.plugins.action_command_notification - INFO - Notifications cleared
2020-08-17 19:42:58,017 - octoprint.server.util.sockjs - INFO - New connection from client: fe80::1435:2ea3:7ad8:e797
2020-08-17 19:42:58,371 - tornado.access - WARNING - 409 GET /api/printer (fe80::1435:2ea3:7ad8:e797) 11.18ms
2020-08-17 19:42:58,669 - octoprint.server.util.flask - INFO - Passively logging in user _api from fe80::1435:2ea3:7ad8:e797
2020-08-17 19:42:58,673 - octoprint.access.users - INFO - Logged in user: _api
2020-08-17 19:42:58,693 - octoprint.server.util.sockjs - INFO - User _api logged in on the socket from client fe80::1435:2ea3:7ad8:e797
2020-08-17 19:42:59,565 - octoprint.util.comm - INFO - Changing monitoring state from "Offline" to "Detecting serial connection"
2020-08-17 19:42:59,636 - octoprint.util.comm - INFO - Serial detection: Performing autodetection with 7 port/baudrate candidates: /dev/ttyUSB0@115200, /dev/ttyUSB0@250000, /dev/ttyUSB0@230400, /dev/ttyUSB0@57600, /dev/ttyUSB0@38400, /dev/ttyUSB0@19200, /dev/ttyUSB0@9600
2020-08-17 19:42:59,638 - octoprint.util.comm - INFO - Serial detection: Trying port /dev/ttyUSB0, baudrate 115200
2020-08-17 19:42:59,640 - octoprint.util.comm - INFO - Connecting to port /dev/ttyUSB0, baudrate 115200
2020-08-17 19:42:59,652 - octoprint.util.comm - INFO - Serial detection: Handshake attempt #1 with timeout 2.0s
2020-08-17 19:42:59,657 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-08-17 19:43:00,807 - octoprint.util.comm - WARNING - Received line:
2020-08-17 19:43:00,808 - octoprint.util.comm - WARNING - | 'Lº¿[ÒZ}\x00KrÂàátLÐ/HaÒT8<J"áAÿzrÂâzzBòax{I2'ü}.av>Hº_vñÿJJ %%%%ÿJJ2't+ÛW&¹ÙØé«ÈK»¹a6«sùmH±þKJCüJJròKJCN>@¾]È{}«ÙmcV=Ù-uÛOCð{û-?cÝc&^|vCðßO³À<|=DòFÙM@JOÃüJBù%°jJ2¦:|"Øðma
2020-08-17 19:43:00,810 - octoprint.util.comm - WARNING - The received line contains at least one null byte character at position 15, this hints at some data corruption going on
2020-08-17 19:43:02,822 - octoprint.util.comm - INFO - Serial detection: Handshake attempt #2 with timeout 2.0s
2020-08-17 19:43:02,831 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-08-17 19:43:03,283 - octoprint.server.util.sockjs - INFO - Client connection closed: fe80::1435:2ea3:7ad8:e797
2020-08-17 19:43:04,834 - octoprint.util.comm - INFO - Serial detection: Handshake attempt #3 with timeout 2.0s
2020-08-17 19:43:04,841 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-08-17 19:43:06,843 - octoprint.util.comm - INFO - Serial detection: Trying port /dev/ttyUSB0, baudrate 250000
2020-08-17 19:43:06,850 - octoprint.util.comm - INFO - Serial detection: Handshake attempt #1 with timeout 2.0s
2020-08-17 19:43:06,855 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-08-17 19:43:08,862 - octoprint.util.comm - INFO - Serial detection: Handshake attempt #2 with timeout 2.0s
2020-08-17 19:43:08,865 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-08-17 19:43:09,955 - octoprint.util.comm - INFO - Changing monitoring state from "Detecting serial connection" to "Operational"
2020-08-17 19:43:09,963 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-08-17 19:43:10,184 - octoprint.util.comm - INFO - Printer reports firmware name "Marlin 1.1.6 (Github)"
2020-08-17 19:43:10,190 - octoprint.util.comm - INFO - Firmware states that it supports temperature autoreporting
2020-08-17 19:43:40,509 - octoprint.server.heartbeat - INFO - Server heartbeat <3
2020-08-17 19:44:45,480 - octoprint.util.comm - ERROR - Unexpected error while reading from serial port
Traceback (most recent call last):
File "/home/pi/oprint/local/lib/python2.7/site-packages/octoprint/util/comm.py", line 2916, in _readline
ret = self._serial.readline()
File "/home/pi/oprint/local/lib/python2.7/site-packages/octoprint/util/comm.py", line 5069, in readline
c = self.read(1)
File "/home/pi/oprint/local/lib/python2.7/site-packages/serial/serialposix.py", line 501, in read
'device reports readiness to read but returned no data '
SerialException: device reports readiness to read but returned no data (device disconnected or multiple access on port?)
2020-08-17 19:44:45,511 - octoprint.util.comm - ERROR - Please see https://faq.octoprint.org/serialerror for possible reasons of this.
2020-08-17 19:44:45,519 - octoprint.util.comm - INFO - Changing monitoring state from "Operational" to "Offline (Error: SerialException: 'device reports readiness to read but returned no data (device disconnected or multiple access on port?)' @ comm.py:_readline:2916)"
2020-08-17 19:44:45,530 - octoprint.plugins.action_command_notification - INFO - Notifications cleared
2020-08-17 19:45:10,112 - octoprint.filemanager.analysis - INFO - Analysis of entry local:CR-10_Spool_Holder.gcode finished, needed 207.02s
Running OctoPrint 1.4.2, OctoPi 0.17.0 and the printer is running Marlin 1.1.6