What is the problem?
Im new to using Octoprint but have it connected. The problem is after printing for an hour or so I get what I believe is the Server disconnecting and the printer freezing. Im not touching it or doing anything before it looses connection. This has happend many times now, so Id be really grateful if anyone can offer any advise from the log. Many thanks
What did you already try to solve it?
I have disconnected the wifi and am using just an Ethernet connection. I have reflashed the SD card with all the latest version and have not installed any additional plugins. I have changed the USB lead to the printer supplied one which has ferrites either end.
Have you tried running in safe mode?
Yes
Did running in safe mode solve the problem?
No, but Im only running the very basic now anyway.
Complete Logs
octoprint.log, serial.log or output on terminal tab at a minimum, browser error console if UI issue ... no logs, no support! Not log excerpts, complete logs.)
021-01-17 10:48:46,158 - octoprint.server.heartbeat - INFO - Server heartbeat <3
2021-01-17 11:03:46,158 - octoprint.server.heartbeat - INFO - Server heartbeat <3
2021-01-17 11:18:46,159 - octoprint.server.heartbeat - INFO - Server heartbeat <3
2021-01-17 11:28:26,271 - octoprint.server - CRITICAL - Now that is embarrassing... Something really really went wrong here. Please report this including the stacktrace below in OctoPrint's bugtracker. Thanks!
2021-01-17 11:28:26,272 - octoprint.server - ERROR - Stacktrace follows:
Traceback (most recent call last):
File "/home/pi/oprint/lib/python3.7/site-packages/octoprint/server/init.py", line 1186, in run
ioloop.start()
File "/home/pi/oprint/lib/python3.7/site-packages/tornado/platform/asyncio.py", line 132, in start
self.asyncio_loop.run_forever()
File "/usr/lib/python3.7/asyncio/base_events.py", line 539, in run_forever
self.run_once()
File "/usr/lib/python3.7/asyncio/base_events.py", line 1759, in run_once
for i in range(ntodo):
TypeError: unsupported operand type(s) for //: 'int' and 'int'
2021-01-17 11:28:26,273 - octoprint.server - INFO - Shutting down...
2021-01-17 11:28:26,464 - octoprint.server - INFO - Calling on_shutdown on plugins
2021-01-17 11:28:26,467 - octoprint.events - INFO - Processing shutdown event, this will be our last event
2021-01-17 11:28:26,472 - octoprint.events - INFO - Event loop shut down
2021-01-17 11:28:26,991 - octoprint.server - INFO - Goodbye!
2021-01-17 11:17:06,956 - octoprint.startup - INFO - ******************************************************************************
2021-01-17 11:17:06,957 - octoprint.startup - INFO - Starting OctoPrint 1.5.2
2021-01-17 11:17:06,958 - octoprint.startup - INFO - ******************************************************************************
2021-01-17 11:17:13,277 - octoprint.util.connectivity.connectivity_checker - INFO - Connectivity state is currently: offline
2021-01-17 11:17:13,277 - octoprint.util.connectivity.connectivity_checker - INFO - Connecting to 4.2.2.2:53 is not working
2021-01-17 11:17:13,278 - octoprint.util.connectivity.connectivity_checker - INFO - Resolving octoprint.org is not working
2021-01-17 11:17:13,284 - octoprint.startup - INFO - We don't appear to be online, not fetching plugin blacklist
2021-01-17 11:17:13,367 - octoprint.plugin.core - INFO - Loading plugins from /home/pi/oprint/lib/python3.7/site-packages/octoprint/plugins, /home/pi/.octoprint/plugins and installed plugin packages...
2021-01-17 11:17:14,459 - octoprint.plugin.core - INFO - Found 18 plugin(s) providing 18 mixin implementations, 35 hook handlers
2021-01-17 11:17:14,559 - octoprint.server.heartbeat - INFO - Starting server heartbeat, 900.0s interval
2021-01-17 11:17:14,576 - octoprint.server - INFO - Intermediary server started
2021-01-17 11:17:14,594 - octoprint.filemanager.storage - INFO - Initializing the file metadata for /home/pi/.octoprint/uploads...
2021-01-17 11:17:14,800 - octoprint.filemanager.storage - INFO - ... file metadata for /home/pi/.octoprint/uploads initialized successfully.
2021-01-17 11:17:14,803 - octoprint.server - INFO - Added new permission from plugin action_command_notification: PLUGIN_ACTION_COMMAND_NOTIFICATION_SHOW (needs: "Need(method='role', value='plugin_action_command_notification_show')")
2021-01-17 11:17:14,803 - octoprint.server - INFO - Added new permission from plugin action_command_notification: PLUGIN_ACTION_COMMAND_NOTIFICATION_CLEAR (needs: "Need(method='role', value='plugin_action_command_notification_clear')")
2021-01-17 11:17:14,804 - octoprint.server - INFO - Added new permission from plugin action_command_prompt: PLUGIN_ACTION_COMMAND_PROMPT_INTERACT (needs: "Need(method='role', value='plugin_action_command_prompt_interact')")
2021-01-17 11:17:14,804 - octoprint.server - INFO - Added new permission from plugin announcements: PLUGIN_ANNOUNCEMENTS_READ (needs: "Need(method='role', value='plugin_announcements_read')")
2021-01-17 11:17:14,804 - octoprint.server - INFO - Added new permission from plugin announcements: PLUGIN_ANNOUNCEMENTS_MANAGE (needs: "Need(method='role', value='plugin_announcements_manage'), Need(method='role', value='plugin_announcements_read')")
2021-01-17 11:17:14,805 - octoprint.server - INFO - Added new permission from plugin appkeys: PLUGIN_APPKEYS_ADMIN (needs: "Need(method='role', value='plugin_appkeys_admin')")
2021-01-17 11:17:14,805 - octoprint.server - INFO - Added new permission from plugin backup: PLUGIN_BACKUP_ACCESS (needs: "Need(method='role', value='plugin_backup_access')")
2021-01-17 11:17:14,806 - octoprint.server - INFO - Added new permission from plugin firmware_check: PLUGIN_FIRMWARE_CHECK_DISPLAY (needs: "Need(method='role', value='plugin_firmware_check_display')")
2021-01-17 11:17:14,806 - octoprint.server - INFO - Added new permission from plugin logging: PLUGIN_LOGGING_MANAGE (needs: "Need(method='role', value='plugin_logging_manage')")
2021-01-17 11:17:14,807 - octoprint.server - INFO - Added new permission from plugin pi_support: PLUGIN_PI_SUPPORT_STATUS (needs: "Need(method='role', value='plugin_pi_support_check')")
2021-01-17 11:17:14,807 - octoprint.server - INFO - Added new permission from plugin pluginmanager: PLUGIN_PLUGINMANAGER_MANAGE (needs: "Need(method='role', value='plugin_pluginmanager_manage')")
2021-01-17 11:17:14,807 - octoprint.server - INFO - Added new permission from plugin pluginmanager: PLUGIN_PLUGINMANAGER_INSTALL (needs: "Need(method='role', value='plugin_pluginmanager_install'), Need(method='role', value='plugin_pluginmanager_manage')")
2021-01-17 11:17:14,809 - octoprint.server - INFO - Added new permission from plugin softwareupdate: PLUGIN_SOFTWAREUPDATE_CHECK (needs: "Need(method='role', value='plugin_softwareupdate_check')")
2021-01-17 11:17:14,810 - octoprint.server - INFO - Added new permission from plugin softwareupdate: PLUGIN_SOFTWAREUPDATE_UPDATE (needs: "Need(method='role', value='plugin_softwareupdate_update')")
2021-01-17 11:17:14,811 - octoprint.server - INFO - Added new permission from plugin softwareupdate: PLUGIN_SOFTWAREUPDATE_CONFIGURE (needs: "Need(method='role', value='plugin_softwareupdate_configure')")
2021-01-17 11:17:15,489 - octoprint.util.pip - INFO - Using "/home/pi/oprint/bin/python3 -m pip" as command to invoke pip
2021-01-17 11:17:16,088 - octoprint.util.pip - INFO - Version of pip is 20.3.3
2021-01-17 11:17:16,090 - octoprint.util.pip - INFO - pip installs to /home/pi/oprint/lib/python3.7/site-packages (writable -> yes), --user flag needed -> no, virtual env -> yes
2021-01-17 11:17:16,090 - octoprint.util.pip - INFO - ==> pip ok -> yes
2021-01-17 11:17:16,138 - octoprint.plugins.softwareupdate - INFO - Loaded version cache from disk
2021-01-17 11:17:16,166 - octoprint.plugin.core - INFO - Initialized 18 plugin implementation(s)
2021-01-17 11:17:16,196 - octoprint.plugin.core - INFO - 18 plugin(s) registered with the system:
| Action Command Notification Support (bundled) = /home/pi/oprint/lib/python3.7/site-packages/octoprint/plugins/action_command_notification
| Action Command Prompt Support (bundled) = /home/pi/oprint/lib/python3.7/site-packages/octoprint/plugins/action_command_prompt
| Announcement Plugin (bundled) = /home/pi/oprint/lib/python3.7/site-packages/octoprint/plugins/announcements
| Anonymous Usage Tracking (bundled) = /home/pi/oprint/lib/python3.7/site-packages/octoprint/plugins/tracking
| Application Keys Plugin (bundled) = /home/pi/oprint/lib/python3.7/site-packages/octoprint/plugins/appkeys
| Backup & Restore (bundled) = /home/pi/oprint/lib/python3.7/site-packages/octoprint/plugins/backup
| Core Wizard (bundled) = /home/pi/oprint/lib/python3.7/site-packages/octoprint/plugins/corewizard
| Discovery (bundled) = /home/pi/oprint/lib/python3.7/site-packages/octoprint/plugins/discovery
| Error Tracking (bundled) = /home/pi/oprint/lib/python3.7/site-packages/octoprint/plugins/errortracking
| File Check (2020.8.7) (bundled) = /home/pi/oprint/lib/python3.7/site-packages/octoprint_file_check
| Firmware Check (2020.9.23) (bundled) = /home/pi/oprint/lib/python3.7/site-packages/octoprint_firmware_check
| GCode Viewer (bundled) = /home/pi/oprint/lib/python3.7/site-packages/octoprint/plugins/gcodeviewer
| Logging (bundled) = /home/pi/oprint/lib/python3.7/site-packages/octoprint/plugins/logging
| Navbar Temperature Plugin (0.14) = /home/pi/oprint/lib/python3.7/site-packages/octoprint_navbartemp
| Pi Support Plugin (bundled) = /home/pi/oprint/lib/python3.7/site-packages/octoprint/plugins/pi_support
| Plugin Manager (bundled) = /home/pi/oprint/lib/python3.7/site-packages/octoprint/plugins/pluginmanager
| Software Update (bundled) = /home/pi/oprint/lib/python3.7/site-packages/octoprint/plugins/softwareupdate
| Virtual Printer (bundled) = /home/pi/oprint/lib/python3.7/site-packages/octoprint/plugins/virtual_printer
Prefix legend: ! = disabled, # = blacklisted, * = incompatible
2021-01-17 11:17:16,223 - octoprint.environment - INFO - Detected environment is Python 3.7.3 under Linux (linux). Details:
| hardware:
| cores: 4
| freq: 1500.0
| ram: 1903988736
| os:
| bits: 32
| id: linux
| platform: linux
| plugins:
| pi_support:
| model: Raspberry Pi 4 Model B Rev 1.4
| octopi_version: 0.18.0
| throttle_state: '0x0'
| python:
| pip: 20.3.3
| version: 3.7.3
| virtualenv: /home/pi/oprint
2021-01-17 11:17:16,238 - octoprint.server - INFO - Reset webasset folder /home/pi/.octoprint/generated/webassets...
2021-01-17 11:17:16,253 - octoprint.server - INFO - Reset webasset folder /home/pi/.octoprint/generated/.webassets-cache...
2021-01-17 11:17:16,720 - octoprint.server - INFO - Shutting down intermediary server...
2021-01-17 11:17:16,781 - octoprint.server - INFO - Intermediary server shut down
2021-01-17 11:17:16,782 - octoprint.events - INFO - Processing startup event, this is our first event
2021-01-17 11:17:16,783 - octoprint.events - INFO - Adding 1 events to queue that were held back before startup event
2021-01-17 11:17:16,784 - octoprint.filemanager - INFO - Adding backlog items from all storage types to analysis queue...
2021-01-17 11:17:16,790 - octoprint.server.util.watchdog - INFO - Running initial scan on watched folder...
2021-01-17 11:17:16,794 - octoprint.server.util.watchdog - INFO - ... initial scan done.
2021-01-17 11:17:16,817 - octoprint.filemanager - INFO - Added 1 items from storage type "local" to analysis queue
2021-01-17 11:17:16,818 - octoprint.filemanager.analysis - INFO - Starting analysis of local:BrilloHolder6-2_0.2mm_PETG_MK3S_1h57m.gcode
2021-01-17 11:17:16,818 - octoprint.filemanager.analysis - INFO - Invoking analysis command: /home/pi/oprint/bin/python3 -m octoprint analysis gcode --speed-x=6000 --speed-y=6000 --max-t=10 --throttle=0.01 --throttle-lines=100 /home/pi/.octoprint/uploads/BrilloHolder6-2_0.2mm_PETG_MK3S_1h57m.gcode
2021-01-17 11:17:17,629 - octoprint.plugins.discovery - INFO - Registered 'OctoPrint instance on octopi.http.tcp.local.' for http.tcp.local.
2021-01-17 11:17:18,436 - octoprint.plugins.discovery - INFO - Registered 'OctoPrint instance on octopi.octoprint.tcp.local.' for octoprint.tcp.local.
2021-01-17 11:17:18,491 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance on octopi for SSDP
2021-01-17 11:17:18,502 - octoprint.server - INFO - Listening on http://127.0.0.1:5000
2021-01-17 11:17:18,824 - tornado.access - WARNING - 404 GET /intermediary.gif?=1610883009086 (fe80::35ee:d2bd:8355:d8ac) 256.88ms
2021-01-17 11:17:18,957 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid
2021-01-17 11:17:19,049 - tornado.access - WARNING - 404 GET /cached.gif?=1610883011246 (fe80::35ee:d2bd:8355:d8ac) 113.71ms
2021-01-17 11:17:19,407 - tornado.access - WARNING - 404 GET /intermediary.gif?=1610883011590 (fe80::35ee:d2bd:8355:d8ac) 33.54ms
2021-01-17 11:17:19,599 - octoprint.util.pip - INFO - Using "/home/pi/oprint/bin/python3 -m pip" as command to invoke pip
2021-01-17 11:17:19,605 - octoprint.util.pip - INFO - pip installs to /home/pi/oprint/lib/python3.7/site-packages (writable -> yes), --user flag needed -> no, virtual env -> yes
2021-01-17 11:17:19,605 - octoprint.util.pip - INFO - ==> pip ok -> yes
2021-01-17 11:17:19,779 - tornado.access - WARNING - 404 GET /cached.gif?=1610883011913 (fe80::35ee:d2bd:8355:d8ac) 171.04ms
2021-01-17 11:17:19,780 - octoprint.plugins.softwareupdate - INFO - Minimum free storage across all update relevant locations is 25.1GB. That is considered sufficient for updating.
2021-01-17 11:17:19,780 - octoprint.plugins.softwareupdate - INFO - Not fetching check overlays, we are offline
2021-01-17 11:17:19,955 - octoprint.util.connectivity.connectivity_checker - INFO - Connectivity changed from offline to online
2021-01-17 11:17:20,099 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid
2021-01-17 11:17:20,197 - tornado.access - WARNING - 404 GET /cached.gif?=1610883012371 (fe80::35ee:d2bd:8355:d8ac) 131.74ms
2021-01-17 11:17:21,133 - tornado.access - WARNING - 404 GET /cached.gif?=1610883013137 (fe80::35ee:d2bd:8355:d8ac) 199.69ms
2021-01-17 11:17:21,497 - tornado.access - WARNING - 404 GET /cached.gif?=1610883013538 (fe80::35ee:d2bd:8355:d8ac) 118.55ms
2021-01-17 11:17:21,909 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui default) for {'base_url': 'http://192.168.1.101/', 'path': '/', 'query_string': 'l10n=en'}
2021-01-17 11:17:22,139 - octoprint.plugins.pluginmanager - INFO - Loaded notice data from disk, was still valid
2021-01-17 11:17:22,212 - tornado.access - WARNING - 404 GET /cached.gif?=1610883014501 (fe80::35ee:d2bd:8355:d8ac) 21.43ms
2021-01-17 11:17:22,531 - octoprint.plugins.pluginmanager - INFO - Loaded notice data from disk, was still valid
2021-01-17 11:17:23,388 - tornado.access - WARNING - 404 GET /cached.gif?=1610883014852 (fe80::35ee:d2bd:8355:d8ac) 769.40ms
2021-01-17 11:17:23,533 - tornado.access - WARNING - 404 GET /cached.gif?=1610883015563 (fe80::35ee:d2bd:8355:d8ac) 105.08ms
2021-01-17 11:17:24,400 - tornado.access - WARNING - 404 GET /cached.gif?=1610883016527 (fe80::35ee:d2bd:8355:d8ac) 62.21ms
2021-01-17 11:17:24,748 - tornado.access - WARNING - 404 GET /cached.gif?=1610883016899 (fe80::35ee:d2bd:8355:d8ac) 117.75ms
2021-01-17 11:17:25,504 - tornado.access - WARNING - 404 GET /cached.gif?=1610883017753 (fe80::35ee:d2bd:8355:d8ac) 54.46ms
2021-01-17 11:17:25,973 - tornado.access - WARNING - 404 GET /cached.gif?_=1610883018021 (fe80::35ee:d2bd:8355:d8ac) 204.35ms
2021-01-17 11:17:27,934 - octoprint.filemanager.analysis - INFO - Analysis of entry local:BrilloHolder6-2_0.2mm_PETG_MK3S_1h57m.gcode finished, needed 11.12s
2021-01-17 11:17:28,107 - octoprint.server.util.flask - INFO - Passively logging in user SteveRH from fe80::35ee:d2bd:8355:d8ac
2021-01-17 11:17:28,107 - octoprint.access.users - INFO - Logged in user: SteveRH
2021-01-17 11:30:30,303 - octoprint.server.preemptive_cache - INFO - ... done in 15.98s
2021-01-17 11:30:30,304 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'base_url': 'http://192.168.1.142/', 'path': '/', 'query_string': 'l10n=en'}
2021-01-17 11:30:30,343 - octoprint.server.views - INFO - Found path / in cache (key: ui:_default:http://octopi.local/:en), signaling as cached
2021-01-17 11:30:30,361 - octoprint.server.views - INFO - Found path / in cache (key: ui:_default:http://octopi.local/:en), signaling as cached
2021-01-17 11:30:30,649 - octoprint.server.preemptive_cache - INFO - ... done in 0.35s
2021-01-17 11:30:30,650 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'base_url': 'http://octopi.local/', 'path': '/', 'query_string': 'l10n=en'}
2021-01-17 11:30:30,683 - octoprint.server.preemptive_cache - INFO - ... done in 0.03s
2021-01-17 11:30:30,683 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'base_url': 'http://192.168.1.125/', 'path': '/', 'query_string': 'l10n=en'}
2021-01-17 11:30:30,773 - octoprint.server.util.flask - INFO - Passively logging in user SteveRH from fe80::35ee:d2bd:8355:d8ac
2021-01-17 11:30:30,773 - octoprint.access.users - INFO - Logged in user: SteveRH
2021-01-17 11:30:31,014 - octoprint.server.preemptive_cache - INFO - ... done in 0.33s
2021-01-17 11:30:31,229 - octoprint.server.util.sockjs - INFO - New connection from client: fe80::35ee:d2bd:8355:d8ac
2021-01-17 11:30:31,414 - octoprint.server.util.flask - INFO - Passively logging in user SteveRH from fe80::35ee:d2bd:8355:d8ac
2021-01-17 11:30:31,415 - octoprint.access.users - INFO - Logged in user: SteveRH
2021-01-17 11:30:32,930 - octoprint.server.util.sockjs - INFO - User SteveRH logged in on the socket from client fe80::35ee:d2bd:8355:d8ac
2021-01-17 11:30:50,728 - octoprint.server.util.sockjs - INFO - Client connection closed: fe80::35ee:d2bd:8355:d8ac
Additional information about your setup
python.version : 3.7.3
octoprint.version : 1.5.2
printer.firmware : Prusa-Firmware 3.9.3