klipper. помогоите найти ошибку octoprint.log

Была запущена пятичасовая печать принтер не допечатал 5% и остановился (уже не первый раз). заметил это где-то в 16:30.  Питался посмотреть octoprint.log и понять может есть какая то подсказка, но либо я плохо шарю либо там нет ничего.   Посмотрите пожалуйста подскажите куда копать!   

Принтер core XY  плата skr 1.3 + orange pi lite.

2021-09-12 09:16:41,622 - octoprint.plugin.core - INFO - Plugin DisplayLayerProgress Plugin (1.17.1) is disabled.

2021-09-12 09:16:42,078 - octoprint.plugin.core - INFO - Found 19 plugin(s) providing 17 mixin implementations, 33 hook handlers

2021-09-12 09:16:42,704 - octoprint.server.heartbeat - INFO - Starting server heartbeat, 900.0s interval

2021-09-12 09:16:42,782 - octoprint.server - INFO - Intermediary server started

2021-09-12 09:16:42,833 - octoprint.filemanager.storage - INFO - Initializing the file metadata for /home/opi/.octoprint/uploads...

2021-09-12 09:16:43,498 - octoprint.filemanager.storage - INFO - ... file metadata for /home/opi/.octoprint/uploads initialized successfully.

2021-09-12 09:16:43,506 - octoprint.server - INFO - Added new permission from plugin action_command_notification: PLUGIN_ACTION_COMMAND_NOTIFICATION_SHOW (needs: u"Need(method='role', value=u'plugin_action_command_notification_show')")

2021-09-12 09:16:43,508 - octoprint.server - INFO - Added new permission from plugin action_command_notification: PLUGIN_ACTION_COMMAND_NOTIFICATION_CLEAR (needs: u"Need(method='role', value=u'plugin_action_command_notification_clear')")

2021-09-12 09:16:43,510 - octoprint.server - INFO - Added new permission from plugin action_command_prompt: PLUGIN_ACTION_COMMAND_PROMPT_INTERACT (needs: u"Need(method='role', value=u'plugin_action_command_prompt_interact')")

2021-09-12 09:16:43,512 - octoprint.server - INFO - Added new permission from plugin announcements: PLUGIN_ANNOUNCEMENTS_READ (needs: u"Need(method='role', value=u'plugin_announcements_read')")

2021-09-12 09:16:43,513 - octoprint.server - INFO - Added new permission from plugin announcements: PLUGIN_ANNOUNCEMENTS_MANAGE (needs: u"Need(method='role', value=u'plugin_announcements_manage'), Need(method='role', value=u'plugin_announcements_read')")

2021-09-12 09:16:43,515 - octoprint.server - INFO - Added new permission from plugin appkeys: PLUGIN_APPKEYS_ADMIN (needs: u"Need(method='role', value=u'plugin_appkeys_admin')")

2021-09-12 09:16:43,518 - octoprint.server - INFO - Added new permission from plugin backup: PLUGIN_BACKUP_ACCESS (needs: u"Need(method='role', value=u'plugin_backup_access')")

2021-09-12 09:16:43,520 - octoprint.server - INFO - Added new permission from plugin logging: PLUGIN_LOGGING_MANAGE (needs: u"Need(method='role', value=u'plugin_logging_manage')")

2021-09-12 09:16:43,522 - octoprint.server - INFO - Added new permission from plugin pluginmanager: PLUGIN_PLUGINMANAGER_MANAGE (needs: u"Need(method='role', value=u'plugin_pluginmanager_manage')")

2021-09-12 09:16:43,525 - octoprint.server - INFO - Added new permission from plugin pluginmanager: PLUGIN_PLUGINMANAGER_INSTALL (needs: u"Need(method='role', value=u'plugin_pluginmanager_install'), Need(method='role', value=u'plugin_pluginmanager_manage')")

2021-09-12 09:16:43,527 - octoprint.server - INFO - Added new permission from plugin softwareupdate: PLUGIN_SOFTWAREUPDATE_CHECK (needs: u"Need(method='role', value=u'plugin_softwareupdate_check')")

2021-09-12 09:16:43,529 - octoprint.server - INFO - Added new permission from plugin softwareupdate: PLUGIN_SOFTWAREUPDATE_UPDATE (needs: u"Need(method='role', value=u'plugin_softwareupdate_update')")

2021-09-12 09:16:43,530 - octoprint.server - INFO - Added new permission from plugin softwareupdate: PLUGIN_SOFTWAREUPDATE_CONFIGURE (needs: u"Need(method='role', value=u'plugin_softwareupdate_configure')")

2021-09-12 09:16:43,827 - octoprint.plugins.softwareupdate - INFO - Loaded version cache from disk

2021-09-12 09:16:45,487 - octoprint.util.pip - INFO - Using "/home/opi/OctoPrint/venv/bin/python -m pip" as command to invoke pip

2021-09-12 09:16:46,833 - octoprint.util.pip - INFO - Version of pip is 20.0.2

2021-09-12 09:16:46,836 - octoprint.util.pip - INFO - pip installs to /home/opi/OctoPrint/venv/lib/python2.7/site-packages (writable -> yes), --user flag needed -> no, virtual env -> yes

2021-09-12 09:16:46,837 - octoprint.util.pip - INFO - ==> pip ok -> yes

2021-09-12 09:16:46,863 - octoprint.plugin.core - INFO - Initialized 17 plugin implementation(s)

2021-09-12 09:16:46,893 - octoprint.plugin.core - INFO - 19 plugin(s) registered with the system:

| Action Command Notification Support (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/action_command_notification

| Action Command Prompt Support (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/action_command_prompt

| Announcement Plugin (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/announcements

| Anonymous Usage Tracking (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/tracking

| Application Keys Plugin (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/appkeys

| Backup & Restore (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/backup

| Bed Visualizer (1.1.0) = /home/opi/OctoPrint/venv/local/lib/python2.7/site-packages/octoprint_bedlevelvisualizer

| Core Wizard (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/corewizard

| !Dashboard (1.11.1) = /home/opi/OctoPrint/venv/local/lib/python2.7/site-packages/octoprint_dashboard

| Discovery (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/discovery

| !DisplayLayerProgress Plugin (1.17.1) = /home/opi/OctoPrint/venv/local/lib/python2.7/site-packages/octoprint_DisplayLayerProgress

| Error Tracking (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/errortracking

| File Check (2021.2.23) (bundled) = /home/opi/OctoPrint/venv/local/lib/python2.7/site-packages/octoprint_file_check

| GCode Viewer (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/gcodeviewer

| Logging (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/logging

| OctoKlipper (0.2.5) = /home/opi/OctoPrint/venv/local/lib/python2.7/site-packages/octoprint_klipper

| Plugin Manager (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/pluginmanager

| Software Update (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/softwareupdate

| Virtual Printer (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/virtual_printer

Prefix legend: ! = disabled, # = blacklisted, * = incompatible

2021-09-12 09:16:46,913 - octoprint.environment - INFO - Detected environment is Python 2.7.13 under Linux (linux2). Details:

| hardware:

| cores: 4

| freq: 1368.0

| ram: 515006464

| os:

| bits: 32

| id: linux

| platform: linux2

| python:

| pip: 20.0.2

| version: 2.7.13

| virtualenv: /home/opi/OctoPrint/venv

2021-09-12 09:16:46,967 - octoprint.server - INFO - Reset webasset folder /home/opi/.octoprint/generated/webassets...

2021-09-12 09:16:46,998 - octoprint.server - INFO - Reset webasset folder /home/opi/.octoprint/generated/.webassets-cache...

2021-09-12 09:16:49,223 - octoprint.server - INFO - Shutting down intermediary server...

2021-09-12 09:16:49,573 - octoprint.server - INFO - Intermediary server shut down

2021-09-12 09:16:49,577 - octoprint.events - INFO - Processing startup event, this is our first event

2021-09-12 09:16:49,578 - octoprint.events - INFO - Adding 1 events to queue that were held back before startup event

2021-09-12 09:16:49,584 - octoprint.filemanager - INFO - Adding backlog items from all storage types to analysis queue...

2021-09-12 09:16:49,604 - octoprint.plugins.softwareupdate - INFO - Fetching check overlays from https://plugins.octoprint.org/update_check_overlay.json

2021-09-12 09:16:49,607 - octoprint.server - INFO - Autoconnect on startup is configured, trying to connect to the printer...

2021-09-12 09:16:49,608 - octoprint.filemanager - INFO - Added 0 items from storage type "local" to analysis queue

2021-09-12 09:16:49,718 - octoprint.server - INFO - Trying to connect to configured serial port /tmp/printer

2021-09-12 09:16:49,832 - octoprint.util.comm - INFO - Changing monitoring state from "Offline" to "Opening serial connection"

2021-09-12 09:16:49,839 - octoprint.util.comm - INFO - Connecting to port /tmp/printer, baudrate 250000

2021-09-12 09:16:49,848 - octoprint.server.util.watchdog - INFO - Running initial scan on watched folder...

2021-09-12 09:16:49,852 - octoprint.server.util.watchdog - INFO - ... initial scan done.

2021-09-12 09:16:49,870 - octoprint.util.comm - INFO - Changing monitoring state from "Opening serial connection" to "Connecting"

2021-09-12 09:16:49,879 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0

2021-09-12 09:16:49,891 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0

2021-09-12 09:16:49,892 - octoprint.util.comm - INFO - Changing monitoring state from "Connecting" to "Operational"

2021-09-12 09:16:49,982 - octoprint.plugins.softwareupdate - INFO - Fetching check overlays from https://plugins.octoprint.org/update_check_overlay_py2.json

2021-09-12 09:16:49,983 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0

2021-09-12 09:16:50,011 - octoprint.util.comm - INFO - Printer reports firmware name "Klipper"

2021-09-12 09:16:50,012 - octoprint.util.comm - INFO - Detected Klipper firmware, enabling relevant features for issue free communication

2021-09-12 09:16:50,068 - octoprint.plugins.announcements - INFO - Loaded channel _important from https://octoprint.org/feeds/important.xml in 0.39s

2021-09-12 09:16:50,160 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from https://plugins.octoprint.org/plugins.json

2021-09-12 09:16:50,817 - octoprint.plugins.tracking - INFO - Sent tracking event printer_connected, payload: {u'printer_baudrate': 250000, u'printer_port': '/tmp/printer', u'firmware_name': u'Klipper'}

2021-09-12 09:16:50,876 - octoprint.plugins.discovery - INFO - Registered 'OctoPrint instance on orangepilite._http._tcp.local.' for _http._tcp.local.

2021-09-12 09:16:52,327 - octoprint.plugins.discovery - INFO - Registered 'OctoPrint instance on orangepilite._octoprint._tcp.local.' for _octoprint._tcp.local.

2021-09-12 09:16:52,410 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance on orangepilite for SSDP

2021-09-12 09:16:52,661 - octoprint.server - INFO - Listening on http://0.0.0.0:5000 and http://[::]:5000

2021-09-12 09:16:53,118 - octoprint.plugins.announcements - INFO - Loaded channel _releases from https://octoprint.org/feeds/releases.xml in 1.9s

2021-09-12 09:16:53,781 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid

2021-09-12 09:16:54,767 - octoprint.util.pip - INFO - Using "/home/opi/OctoPrint/venv/bin/python -m pip" as command to invoke pip

2021-09-12 09:16:54,771 - octoprint.util.pip - INFO - pip installs to /home/opi/OctoPrint/venv/lib/python2.7/site-packages (writable -> yes), --user flag needed -> no, virtual env -> yes

2021-09-12 09:16:54,852 - octoprint.util.pip - INFO - ==> pip ok -> yes

2021-09-12 09:16:54,984 - octoprint.plugins.announcements - INFO - Loaded channel _blog from https://octoprint.org/feeds/octoblog.xml in 0.82s

2021-09-12 09:16:55,095 - octoprint.util.pip - INFO - Using "/home/opi/OctoPrint/venv/bin/python -m pip" as command to invoke pip

2021-09-12 09:16:55,187 - octoprint.util.pip - INFO - pip installs to /home/opi/OctoPrint/venv/lib/python2.7/site-packages (writable -> yes), --user flag needed -> no, virtual env -> yes

2021-09-12 09:16:55,249 - octoprint.util.pip - INFO - ==> pip ok -> yes

2021-09-12 09:16:55,423 - octoprint.plugins.announcements - INFO - Loaded channel _blog from https://octoprint.org/feeds/octoblog.xml in 0.96s

2021-09-12 09:16:55,813 - octoprint.plugins.softwareupdate - INFO - Minimum free storage across all update relevant locations is 245.6MB. That is considered sufficient for updating.

2021-09-12 09:16:56,244 - octoprint.plugins.softwareupdate - INFO - Saved version cache to disk

2021-09-12 09:16:56,668 - octoprint.plugins.bedlevelvisualizer - INFO - OctoPrint-BedLevelVisualizer loaded!

2021-09-12 09:16:56,676 - octoprint.plugins.pluginmanager - INFO - Loaded plugin notices data from https://plugins.octoprint.org/notices.json

2021-09-12 09:16:57,317 - octoprint.plugins.announcements - INFO - Loaded channel _plugins from https://plugins.octoprint.org/feed.xml in 1.7s

2021-09-12 09:16:57,418 - octoprint.plugins.announcements - INFO - Loaded channel _plugins from https://plugins.octoprint.org/feed.xml in 1.6s

2021-09-12 09:16:58,775 - octoprint.plugins.tracking - INFO - Sent tracking event ping, payload: {'printer_state': 'OPERATIONAL', 'octoprint_uptime': 15}

2021-09-12 09:16:59,037 - octoprint.plugins.pluginmanager - INFO - Loaded notice data from disk, was still valid

2021-09-12 09:16:59,073 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'query_string': 'l10n=en', 'path': '/', 'base_url': 'http://192.168.1.4:5000/'}

2021-09-12 09:16:59,107 - octoprint.plugins.announcements - INFO - Loaded channel _octopi from https://octoprint.org/feeds/octopi.xml in 0.94s

2021-09-12 09:16:59,278 - octoprint.plugins.announcements - INFO - Loaded channel _octopi from https://octoprint.org/feeds/octopi.xml in 0.69s

2021-09-12 09:16:59,383 - octoprint.plugins.tracking - INFO - Sent tracking event pong, payload: {u'python': '2.7.13', u'bits': 32, u'ram': 515006464, u'version': u'1.6.1', u'plugins': u'klipper:0.2.5,bedlevelvisualizer:1.1.0', u'pip': '20.0.2', u'cores': 4, u'freq': 1368.0, u'os': u'linux'}

2021-09-12 09:16:59,652 - octoprint.plugins.tracking - INFO - Sent tracking event startup, payload: {u'python': '2.7.13', u'os': u'linux', u'ram': 515006464, u'version': u'1.6.1', u'pip': '20.0.2', u'cores': 4, u'freq': 1368.0, u'bits': 32}

2021-09-12 09:17:18,174 - octoprint.server.preemptive_cache - INFO - ... done in 19.10s

2021-09-12 09:31:42,709 - octoprint.server.heartbeat - INFO - Server heartbeat 

    "firmware-development": FirmwareDevelopmentChecks.as_dict(),

  File "/home/opi/OctoPrint/venv/local/lib/python2.7/site-packages/octoprint_firmware_check/checks/firmware_development.py", line 20, in as_dict

    MarlinBugfixCheck(),

  File "/home/opi/OctoPrint/venv/local/lib/python2.7/site-packages/octoprint_firmware_check/checks/firmware_development.py", line 46, in __init__

    super().__init__()

TypeError: super() takes at least 1 argument (0 given)

2021-09-12 16:17:21,298 - octoprint.plugin.core - INFO - Plugin Dashboard (1.11.1) is disabled.

2021-09-12 16:31:05,810 - octoprint.plugin.core - INFO - Plugin DisplayLayerProgress Plugin (1.17.1) is disabled.

2021-09-12 16:31:06,155 - octoprint.plugin.core - INFO - Found 19 plugin(s) providing 17 mixin implementations, 33 hook handlers

2021-09-12 16:31:06,765 - octoprint.server.heartbeat - INFO - Starting server heartbeat, 900.0s interval

2021-09-12 16:31:06,828 - octoprint.server - INFO - Intermediary server started

2021-09-12 16:31:06,878 - octoprint.filemanager.storage - INFO - Initializing the file metadata for /home/opi/.octoprint/uploads...

2021-09-12 16:31:07,522 - octoprint.filemanager.storage - INFO - ... file metadata for /home/opi/.octoprint/uploads initialized successfully.

2021-09-12 16:31:07,530 - octoprint.server - INFO - Added new permission from plugin action_command_notification: PLUGIN_ACTION_COMMAND_NOTIFICATION_SHOW (needs: u"Need(method='role', value=u'plugin_action_command_notification_show')")

2021-09-12 16:31:07,532 - octoprint.server - INFO - Added new permission from plugin action_command_notification: PLUGIN_ACTION_COMMAND_NOTIFICATION_CLEAR (needs: u"Need(method='role', value=u'plugin_action_command_notification_clear')")

2021-09-12 16:31:07,534 - octoprint.server - INFO - Added new permission from plugin action_command_prompt: PLUGIN_ACTION_COMMAND_PROMPT_INTERACT (needs: u"Need(method='role', value=u'plugin_action_command_prompt_interact')")

2021-09-12 16:31:07,535 - octoprint.server - INFO - Added new permission from plugin announcements: PLUGIN_ANNOUNCEMENTS_READ (needs: u"Need(method='role', value=u'plugin_announcements_read')")

2021-09-12 16:31:07,536 - octoprint.server - INFO - Added new permission from plugin announcements: PLUGIN_ANNOUNCEMENTS_MANAGE (needs: u"Need(method='role', value=u'plugin_announcements_manage'), Need(method='role', value=u'plugin_announcements_read')")

2021-09-12 16:31:07,538 - octoprint.server - INFO - Added new permission from plugin appkeys: PLUGIN_APPKEYS_ADMIN (needs: u"Need(method='role', value=u'plugin_appkeys_admin')")

2021-09-12 16:31:07,541 - octoprint.server - INFO - Added new permission from plugin backup: PLUGIN_BACKUP_ACCESS (needs: u"Need(method='role', value=u'plugin_backup_access')")

2021-09-12 16:31:07,543 - octoprint.server - INFO - Added new permission from plugin logging: PLUGIN_LOGGING_MANAGE (needs: u"Need(method='role', value=u'plugin_logging_manage')")

2021-09-12 16:31:07,545 - octoprint.server - INFO - Added new permission from plugin pluginmanager: PLUGIN_PLUGINMANAGER_MANAGE (needs: u"Need(method='role', value=u'plugin_pluginmanager_manage')")

2021-09-12 16:31:07,549 - octoprint.server - INFO - Added new permission from plugin pluginmanager: PLUGIN_PLUGINMANAGER_INSTALL (needs: u"Need(method='role', value=u'plugin_pluginmanager_install'), Need(method='role', value=u'plugin_pluginmanager_manage')")

2021-09-12 16:31:07,551 - octoprint.server - INFO - Added new permission from plugin softwareupdate: PLUGIN_SOFTWAREUPDATE_CHECK (needs: u"Need(method='role', value=u'plugin_softwareupdate_check')")

2021-09-12 16:31:07,553 - octoprint.server - INFO - Added new permission from plugin softwareupdate: PLUGIN_SOFTWAREUPDATE_UPDATE (needs: u"Need(method='role', value=u'plugin_softwareupdate_update')")

2021-09-12 16:31:07,555 - octoprint.server - INFO - Added new permission from plugin softwareupdate: PLUGIN_SOFTWAREUPDATE_CONFIGURE (needs: u"Need(method='role', value=u'plugin_softwareupdate_configure')")

2021-09-12 16:31:07,850 - octoprint.plugins.softwareupdate - INFO - Loaded version cache from disk

2021-09-12 16:31:09,451 - octoprint.util.pip - INFO - Using "/home/opi/OctoPrint/venv/bin/python -m pip" as command to invoke pip

2021-09-12 16:31:10,749 - octoprint.util.pip - INFO - Version of pip is 20.0.2

2021-09-12 16:31:10,751 - octoprint.util.pip - INFO - pip installs to /home/opi/OctoPrint/venv/lib/python2.7/site-packages (writable -> yes), --user flag needed -> no, virtual env -> yes

2021-09-12 16:31:10,753 - octoprint.util.pip - INFO - ==> pip ok -> yes

2021-09-12 16:31:10,778 - octoprint.plugin.core - INFO - Initialized 17 plugin implementation(s)

2021-09-12 16:31:10,807 - octoprint.plugin.core - INFO - 19 plugin(s) registered with the system:

| Action Command Notification Support (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/action_command_notification

| Action Command Prompt Support (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/action_command_prompt

| Announcement Plugin (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/announcements

| Anonymous Usage Tracking (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/tracking

| Application Keys Plugin (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/appkeys

| Backup & Restore (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/backup

| Bed Visualizer (1.1.0) = /home/opi/OctoPrint/venv/local/lib/python2.7/site-packages/octoprint_bedlevelvisualizer

| Core Wizard (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/corewizard

| !Dashboard (1.11.1) = /home/opi/OctoPrint/venv/local/lib/python2.7/site-packages/octoprint_dashboard

| Discovery (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/discovery

| !DisplayLayerProgress Plugin (1.17.1) = /home/opi/OctoPrint/venv/local/lib/python2.7/site-packages/octoprint_DisplayLayerProgress

| Error Tracking (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/errortracking

| File Check (2021.2.23) (bundled) = /home/opi/OctoPrint/venv/local/lib/python2.7/site-packages/octoprint_file_check

| GCode Viewer (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/gcodeviewer

| Logging (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/logging

| OctoKlipper (0.2.5) = /home/opi/OctoPrint/venv/local/lib/python2.7/site-packages/octoprint_klipper

| Plugin Manager (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/pluginmanager

| Software Update (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/softwareupdate

| Virtual Printer (bundled) = /home/opi/OctoPrint/venv/lib/python2.7/site-packages/octoprint/plugins/virtual_printer

Prefix legend: ! = disabled, # = blacklisted, * = incompatible

2021-09-12 16:31:10,827 - octoprint.environment - INFO - Detected environment is Python 2.7.13 under Linux (linux2). Details:

| hardware:

| cores: 4

| freq: 1368.0

| ram: 515006464

| os:

| bits: 32

| id: linux

| platform: linux2

| python:

| pip: 20.0.2

| version: 2.7.13

| virtualenv: /home/opi/OctoPrint/venv

2021-09-12 16:31:10,850 - octoprint.server - INFO - Reset webasset folder /home/opi/.octoprint/generated/webassets...

2021-09-12 16:31:10,879 - octoprint.server - INFO - Reset webasset folder /home/opi/.octoprint/generated/.webassets-cache...

2021-09-12 16:31:13,111 - octoprint.server - INFO - Shutting down intermediary server...

2021-09-12 16:31:13,114 - octoprint.server - INFO - Intermediary server shut down

2021-09-12 16:31:13,119 - octoprint.events - INFO - Processing startup event, this is our first event

2021-09-12 16:31:13,121 - octoprint.events - INFO - Adding 1 events to queue that were held back before startup event

2021-09-12 16:31:13,127 - octoprint.filemanager - INFO - Adding backlog items from all storage types to analysis queue...

2021-09-12 16:31:13,139 - octoprint.server - INFO - Autoconnect on startup is configured, trying to connect to the printer...

2021-09-12 16:31:13,142 - octoprint.plugins.softwareupdate - INFO - Fetching check overlays from https://plugins.octoprint.org/update_check_overlay.json

2021-09-12 16:31:13,301 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid

2021-09-12 16:31:13,636 - octoprint.filemanager - INFO - Added 1 items from storage type "local" to analysis queue

2021-09-12 16:31:13,638 - octoprint.filemanager.analysis - INFO - Starting analysis of local:CFFFP_cup-4.gcode

2021-09-12 16:31:13,642 - octoprint.filemanager.analysis - INFO - Invoking analysis command: /home/opi/OctoPrint/venv/bin/python -m octoprint analysis gcode --speed-x=6000 --speed-y=6000 --max-t=10 --throttle=0.01 --throttle-lines=100 --bed-z=0.0 /home/opi/.octoprint/uploads/CFFFP_cup-4.gcode

2021-09-12 16:31:14,128 - octoprint.plugins.softwareupdate - INFO - Fetching check overlays from https://plugins.octoprint.org/update_check_overlay_py2.json

2021-09-12 16:31:14,386 - octoprint.plugins.announcements - INFO - Loaded channel _important from https://octoprint.org/feeds/important.xml in 1.2s

2021-09-12 16:31:16,900 - octoprint.server - INFO - Trying to connect to configured serial port /tmp/printer

2021-09-12 16:31:17,190 - octoprint.util.comm - INFO - Changing monitoring state from "Offline" to "Opening serial connection"

2021-09-12 16:31:17,195 - octoprint.util.comm - INFO - Connecting to port /tmp/printer, baudrate 250000

2021-09-12 16:31:17,207 - octoprint.server.util.watchdog - INFO - Running initial scan on watched folder...

2021-09-12 16:31:17,216 - octoprint.server.util.watchdog - INFO - ... initial scan done.

2021-09-12 16:31:17,221 - octoprint.util.comm - INFO - Changing monitoring state from "Opening serial connection" to "Connecting"

2021-09-12 16:31:17,238 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0

2021-09-12 16:31:17,247 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0

2021-09-12 16:31:17,252 - octoprint.util.comm - INFO - Changing monitoring state from "Connecting" to "Operational"

2021-09-12 16:31:17,361 - octoprint.plugins.announcements - INFO - Loaded channel _releases from https://octoprint.org/feeds/releases.xml in 1.0s

2021-09-12 16:31:17,366 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0

2021-09-12 16:31:17,448 - octoprint.util.comm - INFO - Printer reports firmware name "Klipper"

2021-09-12 16:31:17,449 - octoprint.util.comm - INFO - Detected Klipper firmware, enabling relevant features for issue free communication

2021-09-12 16:31:17,577 - octoprint.plugins.pluginmanager - INFO - Loaded plugin notices data from https://plugins.octoprint.org/notices.json

2021-09-12 16:31:17,811 - octoprint.plugins.tracking - INFO - Sent tracking event printer_connected, payload: {u'printer_baudrate': 250000, u'printer_port': '/tmp/printer', u'firmware_name': u'Klipper'}

2021-09-12 16:31:17,886 - octoprint.plugins.announcements - INFO - Loaded channel _blog from https://octoprint.org/feeds/octoblog.xml in 0.37s

2021-09-12 16:31:18,094 - octoprint.plugins.discovery - INFO - Registered 'OctoPrint instance on orangepilite._http._tcp.local.' for _http._tcp.local.

2021-09-12 16:31:18,240 - octoprint.plugins.announcements - INFO - Loaded channel _plugins from https://plugins.octoprint.org/feed.xml in 0.25s

2021-09-12 16:31:18,684 - octoprint.plugins.announcements - INFO - Loaded channel _octopi from https://octoprint.org/feeds/octopi.xml in 0.27s

2021-09-12 16:31:18,945 - octoprint.plugins.discovery - INFO - Registered 'OctoPrint instance on orangepilite._octoprint._tcp.local.' for _octoprint._tcp.local.

2021-09-12 16:31:18,955 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance on orangepilite for SSDP

2021-09-12 16:31:18,969 - octoprint.server - INFO - Listening on http://0.0.0.0:5000 and http://[::]:5000

2021-09-12 16:31:19,368 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid

2021-09-12 16:31:21,342 - octoprint.util.pip - INFO - Using "/home/opi/OctoPrint/venv/bin/python -m pip" as command to invoke pip

2021-09-12 16:31:21,352 - octoprint.util.pip - INFO - pip installs to /home/opi/OctoPrint/venv/lib/python2.7/site-packages (writable -> yes), --user flag needed -> no, virtual env -> yes

2021-09-12 16:31:21,498 - octoprint.util.pip - INFO - ==> pip ok -> yes

2021-09-12 16:31:22,039 - octoprint.plugins.softwareupdate - INFO - Minimum free storage across all update relevant locations is 245.6MB. That is considered sufficient for updating.

2021-09-12 16:31:23,260 - octoprint.plugins.bedlevelvisualizer - INFO - OctoPrint-BedLevelVisualizer loaded!

2021-09-12 16:31:23,810 - octoprint.plugins.pluginmanager - INFO - Loaded notice data from disk, was still valid

2021-09-12 16:31:23,820 - octoprint.plugins.tracking - INFO - Sent tracking event ping, payload: {'printer_state': 'OPERATIONAL', 'octoprint_uptime': 18}

2021-09-12 16:31:24,281 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'query_string': 'l10n=en', 'path': '/', 'base_url': 'http://192.168.1.4:5000/'}

2021-09-12 16:31:24,310 - octoprint.plugins.tracking - INFO - Sent tracking event startup, payload: {u'python': '2.7.13', u'os': u'linux', u'ram': 515006464, u'version': u'1.6.1', u'pip': '20.0.2', u'cores': 4, u'freq': 1368.0, u'bits': 32}

2021-09-12 16:31:24,611 - octoprint.plugins.tracking - INFO - Sent tracking event pong, payload: {u'python': '2.7.13', u'bits': 32, u'ram': 515006464, u'version': u'1.6.1', u'plugins': u'klipper:0.2.5,bedlevelvisualizer:1.1.0', u'pip': '20.0.2', u'cores': 4, u'freq': 1368.0, u'os': u'linux'}

2021-09-12 16:32:02,679 - octoprint.server.preemptive_cache - INFO - ... done in 38.40s

2021-09-12 16:32:03,058 - octoprint.server.views - INFO - Found path / in cache (key: ui:_default:http://192.168.1.4:5000/:en), signaling as cached

2021-09-12 16:32:03,221 - octoprint.server.util.flask - INFO - Passively logging in user vulkan from 192.168.1.3

2021-09-12 16:32:03,225 - octoprint.access.users - INFO - Logged in user: vulkan

2021-09-12 16:32:03,441 - octoprint.server.views - INFO - Found path / in cache (key: ui:_default:http://192.168.1.4:5000/:en), signaling as cached

2021-09-12 16:32:03,709 - octoprint.server.views - INFO - Found path / in cache (key: ui:_default:http://192.168.1.4:5000/:en), signaling as cached

2021-09-12 16:32:05,403 - octoprint.server.util.sockjs - INFO - New connection from client: 192.168.1.3

2021-09-12 16:32:05,631 - octoprint.server.util.flask - INFO - Passively logging in user vulkan from 192.168.1.3

2021-09-12 16:32:05,633 - octoprint.access.users - INFO - Logged in user: vulkan

2021-09-12 16:32:10,342 - octoprint.server.util.sockjs - INFO - User vulkan logged in on the socket from client 192.168.1.3

2021-09-12 16:33:57,775 - octoprint.util.comm - WARNING - Received an error from the printer's firmware: Must home axis first: 116.000 143.000 10.000 [0.000]

| Last lines in terminal:

| Send: M105

| Recv: ok B:53.5 /0.0 T0:179.2 /240.0

| Send: M105

| Recv: ok B:53.4 /0.0 T0:180.6 /240.0

| Send: M105

| Recv: ok B:53.4 /0.0 T0:182.4 /240.0

| Send: M105

| Recv: ok B:53.3 /0.0 T0:184.4 /240.0

| Send: M105

| Recv: ok B:53.3 /0.0 T0:187.1 /240.0

| Send: M105

| Recv: ok B:53.2 /0.0 T0:190.0 /240.0

| Send: M105

| Recv: ok B:53.2 /0.0 T0:192.6 /240.0

| Send: M105

| Recv: ok B:53.2 /0.0 T0:195.7 /240.0

| Send: G91

| Recv: ok

| Send: G28 Z0

| Recv: !! Must home axis first: 116.000 143.000 10.000 [0.000]

2021-09-12 16:34:30,639 - octoprint.filemanager.analysis - INFO - Analysis of entry local:CFFFP_cup-4.gcode finished, needed 197.00s