Possible crash, printer moving X, Y and Z back and forth up and down

What is the problem?

The printer starts moving the Z axis up and down randomly and the x axis the same, while extruding.

I can print the same gcode just fine, but on follow on prints it sometimes has this issue.

I've created a video of the behaviour https://photos.app.goo.gl/eucdGzQSgGDF21Gk6

What did you already try to solve it?

Removing plugins installed recently

Logs (octoprint.log, serial.log or output on terminal tab at a minimum, browser error console if UI issue ... no logs, no support!)

2020-05-06 17:24:21,945 - octoprint.plugins.tracking - INFO - Sent tracking event ping, payload: {'octoprint_uptime': 7266}

2020-05-06 17:27:40,774 - octoprint.util.comm - INFO - Finished in 7160.495 s.

2020-05-06 17:27:40,788 - octoprint.util.comm - INFO - Changing monitoring state from "Printing" to "Finishing"

2020-05-06 17:27:40,846 - octoprint.printer.standard.job - INFO - Print job done - origin: local, path: Fusebox_Lid.gcode, owner: jamie

2020-05-06 17:27:40,975 - octoprint.util.comm - INFO - Changing monitoring state from "Finishing" to "Operational"

2020-05-06 17:27:42,390 - octoprint.plugins.tracking - INFO - Sent tracking event print_done, payload: {'origin': u'local', 'file': 'bc2dc6c3fa80e47cf74043f3e0932505becd9243', u'elapsed': 7160}

2020-05-06 17:29:40,388 - octoprint.util.comm - INFO - Changing monitoring state from "Operational" to "Starting"

2020-05-06 17:29:40,477 - octoprint.printer.standard.job - INFO - Print job started - origin: local, path: Fusebox_Lid.gcode, owner: jamie, user: jamie

2020-05-06 17:29:40,536 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0

2020-05-06 17:29:40,609 - octoprint.util.comm - INFO - Changing monitoring state from "Starting" to "Printing"

2020-05-06 17:29:42,142 - octoprint.plugins.tracking - INFO - Sent tracking event print_started, payload: {'origin': u'local', 'file': 'bc2dc6c3fa80e47cf74043f3e0932505becd9243'}

2020-05-06 17:33:01,584 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:192.168.1.3

2020-05-06 17:34:48,360 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:192.168.1.3

2020-05-06 17:34:49,165 - octoprint.server.util.flask - INFO - Passively logging in user jamie from ::ffff:192.168.1.3

2020-05-06 17:34:49,181 - octoprint.access.users - INFO - Logged in user: jamie

2020-05-06 17:34:49,562 - octoprint.server.util.sockjs - INFO - User jamie logged in on the socket from client ::ffff:192.168.1.3

2020-05-06 17:38:18,551 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2020-05-06 17:39:21,068 - octoprint.plugins.tracking - INFO - Sent tracking event ping, payload: {'octoprint_uptime': 8166}

2020-05-06 17:46:42,578 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:192.168.1.3

2020-05-06 17:53:18,571 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2020-05-06 17:54:21,216 - octoprint.plugins.tracking - INFO - Sent tracking event ping, payload: {'octoprint_uptime': 9066}

2020-05-06 18:02:56,533 - octoprint.util.connectivity_checker - INFO - Connectivity changed from online to offline

2020-05-06 18:08:18,590 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2020-05-06 18:23:18,601 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2020-05-06 18:38:18,614 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2020-05-06 18:48:04,004 - octoprint.util.connectivity_checker - INFO - Connectivity changed from offline to online

2020-05-06 18:48:04,257 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid

2020-05-06 18:48:20,506 - octoprint.plugins.pluginmanager - INFO - Loaded notice data from disk, was still valid

2020-05-06 18:53:18,628 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2020-05-06 18:54:25,937 - octoprint.plugins.tracking - INFO - Sent tracking event ping, payload: {'octoprint_uptime': 12666}

2020-05-06 19:03:07,079 - octoprint.util.connectivity_checker - INFO - Connectivity changed from online to offline

2020-05-06 19:08:18,643 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2020-05-06 19:18:08,269 - octoprint.util.connectivity_checker - INFO - Connectivity changed from offline to online

2020-05-06 19:18:08,512 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid

2020-05-06 19:18:27,162 - octoprint.plugins.pluginmanager - INFO - Loaded notice data from disk, was still valid

2020-05-06 19:23:18,665 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2020-05-06 19:24:21,236 - octoprint.plugins.tracking - INFO - Sent tracking event ping, payload: {'octoprint_uptime': 14466}

2020-05-06 19:27:02,397 - octoprint.util.comm - INFO - Finished in 7042.012 s.

2020-05-06 19:27:02,411 - octoprint.util.comm - INFO - Changing monitoring state from "Printing" to "Finishing"

2020-05-06 19:27:02,469 - octoprint.printer.standard.job - INFO - Print job done - origin: local, path: Fusebox_Lid.gcode, owner: jamie

2020-05-06 19:27:02,675 - octoprint.util.comm - INFO - Changing monitoring state from "Finishing" to "Operational"

2020-05-06 19:27:03,995 - octoprint.plugins.tracking - INFO - Sent tracking event print_done, payload: {'origin': u'local', 'file': 'bc2dc6c3fa80e47cf74043f3e0932505becd9243', u'elapsed': 7042}

2020-05-06 19:33:11,345 - octoprint.util.connectivity_checker - INFO - Connectivity changed from online to offline

2020-05-06 19:38:18,677 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2020-05-06 19:44:59,052 - octoprint.server.util.flask - INFO - Passively logging in user jamie from ::ffff:192.168.1.3

2020-05-06 19:44:59,065 - octoprint.access.users - INFO - Logged in user: jamie

2020-05-06 19:45:03,895 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:192.168.1.3

2020-05-06 19:45:04,773 - octoprint.server.util.flask - INFO - Passively logging in user jamie from ::ffff:192.168.1.3

2020-05-06 19:45:04,786 - octoprint.access.users - INFO - Logged in user: jamie

2020-05-06 19:45:14,789 - octoprint.util.connectivity_checker - INFO - Connectivity changed from offline to online

2020-05-06 19:45:14,999 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid

2020-05-06 19:45:16,948 - octoprint.server.util.sockjs - INFO - User jamie logged in on the socket from client ::ffff:192.168.1.3

2020-05-06 19:45:29,025 - octoprint.util.comm - INFO - Changing monitoring state from "Operational" to "Starting"

2020-05-06 19:45:29,156 - octoprint.printer.standard.job - INFO - Print job started - origin: local, path: Fusebox_Lid.gcode, owner: jamie, user: jamie

2020-05-06 19:45:29,221 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0

2020-05-06 19:45:29,341 - octoprint.util.comm - INFO - Changing monitoring state from "Starting" to "Printing"

2020-05-06 19:45:31,371 - octoprint.plugins.tracking - INFO - Sent tracking event print_started, payload: {'origin': u'local', 'file': 'bc2dc6c3fa80e47cf74043f3e0932505becd9243'}

2020-05-06 19:45:35,955 - octoprint.plugins.pluginmanager - INFO - Loaded notice data from disk, was still valid

2020-05-06 19:53:18,690 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2020-05-06 19:24:46,348 - octoprint.startup - INFO - ******************************************************************************

2020-05-06 19:24:46,360 - octoprint.startup - INFO - Starting OctoPrint 1.4.0

2020-05-06 19:24:46,363 - octoprint.startup - INFO - ******************************************************************************

2020-05-06 19:24:50,975 - octoprint.util.connectivity_checker - INFO - Connectivity changed from offline to online

2020-05-06 19:24:51,842 - octoprint.startup - INFO - Blacklist processing done, adding 1 blacklisted plugin versions: roomtemp (any)

2020-05-06 19:24:52,163 - octoprint.plugin.core - INFO - Loading plugins from /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins, /home/pi/.octoprint/plugins and installed plugin packages...

2020-05-06 19:55:08,199 - octoprint.plugin.core - INFO - Found 18 plugin(s) providing 18 mixin implementations, 32 hook handlers

2020-05-06 19:55:09,753 - octoprint.server.heartbeat - INFO - Starting server heartbeat, 900.0s interval

2020-05-06 19:55:09,967 - octoprint.server - INFO - Intermediary server started

2020-05-06 19:55:09,981 - octoprint.plugin.core - INFO - Loading plugins from /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins, /home/pi/.octoprint/plugins and installed plugin packages...

2020-05-06 19:55:11,048 - octoprint.plugin.core - INFO - Found 18 plugin(s) providing 18 mixin implementations, 32 hook handlers

2020-05-06 19:55:11,321 - octoprint.filemanager.storage - INFO - Initializing the file metadata for /home/pi/.octoprint/uploads...

2020-05-06 19:55:15,374 - octoprint.filemanager.storage - INFO - ... file metadata for /home/pi/.octoprint/uploads initialized successfully.

2020-05-06 19:55:15,410 - 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')")

2020-05-06 19:55:15,421 - octoprint.server - INFO - Added new permission from plugin announcements: PLUGIN_ANNOUNCEMENTS_READ (needs: u"Need(method='role', value=u'plugin_announcements_read')")

2020-05-06 19:55:15,433 - 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')")

2020-05-06 19:55:15,445 - octoprint.server - INFO - Added new permission from plugin appkeys: PLUGIN_APPKEYS_ADMIN (needs: u"Need(method='role', value=u'plugin_appkeys_admin')")

2020-05-06 19:55:15,458 - octoprint.server - INFO - Added new permission from plugin backup: PLUGIN_BACKUP_ACCESS (needs: u"Need(method='role', value=u'plugin_backup_access')")

2020-05-06 19:55:15,471 - octoprint.server - INFO - Added new permission from plugin logging: PLUGIN_LOGGING_MANAGE (needs: u"Need(method='role', value=u'plugin_logging_manage')")

2020-05-06 19:55:15,482 - octoprint.server - INFO - Added new permission from plugin pi_support: PLUGIN_PI_SUPPORT_STATUS (needs: u"Need(method='role', value=u'plugin_pi_support_check')")

2020-05-06 19:55:15,495 - octoprint.server - INFO - Added new permission from plugin pluginmanager: PLUGIN_PLUGINMANAGER_MANAGE (needs: u"Need(method='role', value=u'plugin_pluginmanager_manage')")

2020-05-06 19:55:15,507 - 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')")

2020-05-06 19:55:15,518 - octoprint.server - INFO - Added new permission from plugin printer_safety_check: PLUGIN_PRINTER_SAFETY_CHECK_DISPLAY (needs: u"Need(method='role', value=u'plugin_printer_safety_check_display')")

2020-05-06 19:55:15,529 - octoprint.server - INFO - Added new permission from plugin softwareupdate: PLUGIN_SOFTWAREUPDATE_CHECK (needs: u"Need(method='role', value=u'plugin_softwareupdate_check')")

2020-05-06 19:55:15,540 - octoprint.server - INFO - Added new permission from plugin softwareupdate: PLUGIN_SOFTWAREUPDATE_UPDATE (needs: u"Need(method='role', value=u'plugin_softwareupdate_update')")

2020-05-06 19:55:16,486 - octoprint.plugins.softwareupdate - INFO - Loaded version cache from disk

2020-05-06 19:55:23,858 - octoprint.util.pip - INFO - Using "/home/pi/oprint/bin/python2 -m pip" as command to invoke pip

2020-05-06 19:55:30,851 - octoprint.util.pip - INFO - Version of pip is 19.3.1

2020-05-06 19:55:30,866 - octoprint.util.pip - INFO - pip installs to /home/pi/oprint/lib/python2.7/site-packages (writable -> yes), --user flag needed -> no, virtual env -> yes

2020-05-06 19:55:30,875 - octoprint.util.pip - INFO - ==> pip ok -> yes

2020-05-06 19:55:30,907 - octoprint.plugin.core - INFO - Initialized 18 plugin implementation(s)

2020-05-06 19:55:31,011 - octoprint.plugin.core - INFO - 18 plugin(s) registered with the system:

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

| Announcement Plugin (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/announcements

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

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

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

| Continuous Print (1.0.2) = /home/pi/oprint/local/lib/python2.7/site-packages/continuousprint

| Core Wizard (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/corewizard

| Discovery (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/discovery

| Error Tracking (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/errortracking

| Firmware Updater (1.7.0) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_firmwareupdater

| Logging (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/logging

| Login UI (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/loginui

| Pi Support Plugin (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/pi_support

| Plugin Manager (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/pluginmanager

| Printer Safety Check (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/printer_safety_check

| Software Update (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/softwareupdate

| TouchUI (0.3.14) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_touchui

| Virtual Printer (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/virtual_printer

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

2020-05-06 19:55:31,129 - octoprint.environment - INFO - Detected environment is Python 2.7.16 under Linux (linux2). Details:

| hardware:

| cores: 1

| freq: 700.0

| ram: 387194880

| os:

| id: linux

| platform: linux2

| plugins:

| pi_support:

| model: Raspberry Pi Model B Plus Rev 1.2

| octopi_version: 0.17.0

| python:

| pip: 19.3.1

| version: 2.7.16

| virtualenv: /home/pi/oprint

Additional information about your setup (OctoPrint version, OctoPi version, printer, firmware, browser, operating system, ... as much data as possible)

OctoPrint 1.4.0 running on OctoPi 0.17.0

Fixed the formatting for you.

1 Like

Going to need a serial log that is captured while the issue occurs.

Do you have anything defined within Settings->GCODE Scripts?

Nothing in the GCODE scrips.

Serial log log attached, 2 successful prints of the same thing, print number 3 error. I turned on serial logging after the first.

serial.log.zip (1.2 MB) octoprint.log (159.7 KB)

TIA

EDIT

I'm starting to think it might not be octoprint related.

2020-05-07 09:01:56,158 - Recv: Bilinear Leveling Grid:
2020-05-07 09:01:56,174 - Recv:       0      1      2
2020-05-07 09:01:56,187 - Recv:  0 -0.368 +0.082 +0.460
2020-05-07 09:01:56,213 - Recv:  1 -0.378 -0.053 +0.355
2020-05-07 09:01:56,231 - Recv:  2 -0.583 -0.100 +0.430

bad print

2020-05-07 11:30:10,414 - Recv: Bilinear Leveling Grid:
2020-05-07 11:30:10,423 - Recv:       0      1      2
2020-05-07 11:30:10,434 - Recv:  0 +10.000 +15.000 +25.000
2020-05-07 11:30:10,446 - Recv:  1 +55.000 +45.000 +35.000
2020-05-07 11:30:10,455 - Recv:  2 +65.000 +75.000 +85.000

I'm going to close this, I'm pretty sure Octoprint is not the cause and was just coincidence my probe started malfunctioning shortly after an upgrade.