Ender-5 Plus starting print way too far away from bed

What is the problem?

My printer keeps starting too far away from the bed, and therefore just making spaghetti. It is an Ender 5 plus, has the BL touch to run auto bed leveling, and still prints too high after running the positioning. The only viable way to print with the octoprint right now is to run the heating, and then when it starts, manually moving the bed to match the printer head.

What did you already try to solve it?

Tried to add before printing code as follows:

G91            ; Set to relative positioning
G28 X0 Y0      ; Home all three axes
G28 Z0         ;
G90            ; Set to absolute positioning
G92 E0         ; Set position (zero out) the extruder
G28            ;
G29 T          ; Run the autolevel routine

This now runs the autolevel routine, but the ender doesn't seem to listen to it when it starts printing the official go.

Complete Logs

This is the most recient print I started, from start to first placement of filament.

2020-07-29 22:28:03,962 - octoprint.server.heartbeat - INFO - Server heartbeat <3
2020-07-29 22:28:03,966 - octoprint.server - INFO - --- Log roll over detected ---------------------------------------------------
2020-07-29 22:28:03,967 - octoprint.server - INFO - OctoPrint 1.4.0
2020-07-29 22:28:03,972 - octoprint.plugin.core - INFO - 23 plugin(s) registered with the system:
|  ABL Expert Plugin (0.6) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_ABL_Expert
|  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
|  Bed Visualizer (0.1.13) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_bedlevelvisualizer
|  BLTouch Plugin (0.3.3) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_BLTouch
|  Core Wizard (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/corewizard
|  Cost Estimation (2.1.3) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_costestimation
|  Creality Temperature (1.2.3) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_CrealityTemperature
|  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
|  HeaterTimeout (0.0.3) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_HeaterTimeout
|  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
|  PrintTimeGenius Plugin (2.2.5) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_PrintTimeGenius
|  Software Update (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/softwareupdate
|  Themeify (1.2.2) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_themeify
|  Virtual Printer (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/virtual_printer
Prefix legend: ! = disabled, # = blacklisted, * = incompatible
2020-07-29 22:28:04,006 - octoprint.util.connectivity_checker - INFO - Connectivity changed from offline to online
2020-07-29 22:28:04,018 - octoprint.environment - INFO - Detected environment is Python 2.7.16 under Linux (linux2). Details:
|  hardware:
|      cores: 4
|      freq: 1500.0
|      ram: 915337216
|  os:
|      id: linux
|      platform: linux2
|  plugins:
|      pi_support:
|          model: Raspberry Pi 4 Model B Rev 1.1
|          octopi_version: 0.17.0
|  python:
|      pip: 19.3.1
|      version: 2.7.16
|      virtualenv: /home/pi/oprint
2020-07-29 22:28:04,019 - octoprint.server - INFO - ------------------------------------------------------------------------------
2020-07-29 22:28:04,780 - octoprint.plugins.announcements - INFO - Loaded channel _important from https://octoprint.org/feeds/important.xml in 0.75s
2020-07-29 22:28:05,100 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from https://plugins.octoprint.org/plugins.json
2020-07-29 22:28:05,988 - octoprint.plugins.softwareupdate - INFO - Saved version cache to disk
2020-07-29 22:28:06,069 - octoprint.plugins.announcements - INFO - Loaded channel _releases from https://octoprint.org/feeds/releases.xml in 1.1s
2020-07-29 22:28:06,575 - octoprint.plugins.pluginmanager - INFO - Loaded plugin notices data from https://plugins.octoprint.org/notices.json
2020-07-29 22:28:06,727 - octoprint.plugins.announcements - INFO - Loaded channel _blog from https://octoprint.org/feeds/octoblog.xml in 0.62s
2020-07-29 22:28:07,378 - octoprint.plugins.announcements - INFO - Loaded channel _plugins from https://plugins.octoprint.org/feed.xml in 0.61s
2020-07-29 22:28:08,070 - octoprint.plugins.announcements - INFO - Loaded channel _octopi from https://octoprint.org/feeds/octopi.xml in 0.63s
2020-07-29 22:35:20,428 - octoprint.server.util.flask - INFO - Passively logging in user Admin from ::ffff:192.168.1.246
2020-07-29 22:35:20,431 - octoprint.access.users - INFO - Logged in user: Admin
2020-07-29 22:35:25,996 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:192.168.1.246
2020-07-29 22:35:26,096 - octoprint.server.util.flask - INFO - Passively logging in user Admin from ::ffff:192.168.1.246
2020-07-29 22:35:26,097 - octoprint.access.users - INFO - Logged in user: Admin
2020-07-29 22:35:27,387 - octoprint.server.util.sockjs - INFO - User Admin logged in on the socket from client ::ffff:192.168.1.246
2020-07-29 22:35:42,475 - octoprint.plugins.softwareupdate - INFO - Starting update of CrealityTemperature to v1.2.4...
2020-07-29 22:35:52,003 - octoprint.plugins.softwareupdate - INFO - Update of CrealityTemperature to v1.2.4 successful!
2020-07-29 22:35:52,058 - octoprint.plugins.softwareupdate - INFO - Starting update of bedlevelvisualizer to 0.1.14...
2020-07-29 22:35:59,145 - octoprint.plugins.softwareupdate - INFO - Update of bedlevelvisualizer to 0.1.14 successful!
2020-07-29 22:35:59,313 - octoprint.plugins.softwareupdate - INFO - Saved version cache to disk
2020-07-29 22:35:59,314 - octoprint.plugins.softwareupdate - INFO - Restarting...
2020-07-29 22:35:59,457 - octoprint.server - INFO - Shutting down...
2020-07-29 22:36:00,064 - octoprint.events - INFO - Processing shutdown event, this will be our last event
2020-07-29 22:36:00,070 - octoprint.events - INFO - Event loop shut down
2020-07-29 22:36:00,087 - octoprint.plugins.HeaterTimeout - INFO - Shutting down...
2020-07-29 22:36:00,092 - octoprint.server - INFO - Goodbye!
2020-07-29 22:36:01,241 - octoprint.startup - INFO - ******************************************************************************
2020-07-29 22:36:01,243 - octoprint.startup - INFO - Starting OctoPrint 1.4.0
2020-07-29 22:36:01,243 - octoprint.startup - INFO - ******************************************************************************
2020-07-29 22:36:01,545 - octoprint.util.connectivity_checker - INFO - Connectivity changed from offline to online
2020-07-29 22:36:02,345 - octoprint.startup - INFO - Blacklist processing done, adding 1 blacklisted plugin versions: roomtemp (any)
2020-07-29 22:36:02,407 - 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-07-29 22:36:03,306 - octoprint.plugin.core - INFO - Found 23 plugin(s) providing 23 mixin implementations, 44 hook handlers
2020-07-29 22:36:03,387 - octoprint.server.heartbeat - INFO - Starting server heartbeat, 900.0s interval
2020-07-29 22:36:03,401 - octoprint.server - INFO - Intermediary server started
2020-07-29 22:36:03,402 - 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-07-29 22:36:03,472 - octoprint.plugin.core - INFO - Found 23 plugin(s) providing 23 mixin implementations, 44 hook handlers
2020-07-29 22:36:03,488 - octoprint.filemanager.storage - INFO - Initializing the file metadata for /home/pi/.octoprint/uploads...
2020-07-29 22:36:03,694 - octoprint.filemanager.storage - INFO - ... file metadata for /home/pi/.octoprint/uploads initialized successfully.
2020-07-29 22:36:03,697 - 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-07-29 22:36:03,698 - octoprint.server - INFO - Added new permission from plugin announcements: PLUGIN_ANNOUNCEMENTS_READ (needs: u"Need(method='role', value=u'plugin_announcements_read')")
2020-07-29 22:36:03,698 - 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-07-29 22:36:03,699 - octoprint.server - INFO - Added new permission from plugin appkeys: PLUGIN_APPKEYS_ADMIN (needs: u"Need(method='role', value=u'plugin_appkeys_admin')")
2020-07-29 22:36:03,700 - octoprint.server - INFO - Added new permission from plugin backup: PLUGIN_BACKUP_ACCESS (needs: u"Need(method='role', value=u'plugin_backup_access')")
2020-07-29 22:36:03,701 - octoprint.server - INFO - Added new permission from plugin logging: PLUGIN_LOGGING_MANAGE (needs: u"Need(method='role', value=u'plugin_logging_manage')")
2020-07-29 22:36:03,702 - 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-07-29 22:36:03,703 - octoprint.server - INFO - Added new permission from plugin pluginmanager: PLUGIN_PLUGINMANAGER_MANAGE (needs: u"Need(method='role', value=u'plugin_pluginmanager_manage')")
2020-07-29 22:36:03,703 - 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-07-29 22:36:03,704 - 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-07-29 22:36:03,705 - octoprint.server - INFO - Added new permission from plugin softwareupdate: PLUGIN_SOFTWAREUPDATE_CHECK (needs: u"Need(method='role', value=u'plugin_softwareupdate_check')")
2020-07-29 22:36:03,706 - octoprint.server - INFO - Added new permission from plugin softwareupdate: PLUGIN_SOFTWAREUPDATE_UPDATE (needs: u"Need(method='role', value=u'plugin_softwareupdate_update')")
2020-07-29 22:36:03,717 - octoprint.printer.standard - INFO - Using print time estimator provided by PrintTimeGenius
2020-07-29 22:36:03,797 - octoprint.plugins.softwareupdate - INFO - Loaded version cache from disk
2020-07-29 22:36:04,353 - octoprint.util.pip - INFO - Using "/home/pi/oprint/bin/python2 -m pip" as command to invoke pip
2020-07-29 22:36:04,899 - octoprint.util.pip - INFO - Version of pip is 19.3.1
2020-07-29 22:36:04,900 - 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-07-29 22:36:04,901 - octoprint.util.pip - INFO - ==> pip ok -> yes
2020-07-29 22:36:04,904 - octoprint.plugin.core - INFO - Initialized 23 plugin implementation(s)
2020-07-29 22:36:04,916 - octoprint.plugin.core - INFO - 23 plugin(s) registered with the system:
|  ABL Expert Plugin (0.6) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_ABL_Expert
|  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
|  Bed Visualizer (0.1.14) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_bedlevelvisualizer
|  BLTouch Plugin (0.3.3) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_BLTouch
|  Core Wizard (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/corewizard
|  Cost Estimation (2.1.3) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_costestimation
|  Creality Temperature (1.2.4) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_CrealityTemperature
|  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
|  HeaterTimeout (0.0.3) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_HeaterTimeout
|  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
|  PrintTimeGenius Plugin (2.2.5) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_PrintTimeGenius
|  Software Update (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/softwareupdate
|  Themeify (1.2.2) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_themeify
|  Virtual Printer (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/virtual_printer
Prefix legend: ! = disabled, # = blacklisted, * = incompatible
2020-07-29 22:36:04,926 - octoprint.environment - INFO - Detected environment is Python 2.7.16 under Linux (linux2). Details:
|  hardware:
|      cores: 4
|      freq: 1500.0
|      ram: 915337216
|  os:
|      id: linux
|      platform: linux2
|  plugins:
|      pi_support:
|          model: Raspberry Pi 4 Model B Rev 1.1
|          octopi_version: 0.17.0
|  python:
|      pip: 19.3.1
|      version: 2.7.16
|      virtualenv: /home/pi/oprint
2020-07-29 22:36:04,936 - octoprint.server - INFO - Reset webasset folder /home/pi/.octoprint/generated/webassets...
2020-07-29 22:36:04,954 - octoprint.server - INFO - Reset webasset folder /home/pi/.octoprint/generated/.webassets-cache...
2020-07-29 22:36:05,431 - octoprint.server - INFO - Shutting down intermediary server...
2020-07-29 22:36:05,887 - octoprint.server - INFO - Intermediary server shut down
2020-07-29 22:36:05,889 - octoprint.events - INFO - Processing startup event, this is our first event
2020-07-29 22:36:05,891 - octoprint.events - INFO - Adding 1 events to queue that were held back before startup event
2020-07-29 22:36:05,892 - octoprint.filemanager - INFO - Adding backlog items from all storage types to analysis queue...
2020-07-29 22:36:05,893 - octoprint.server - INFO - Autoconnect on startup is configured, trying to connect to the printer...
2020-07-29 22:36:05,898 - octoprint.filemanager - INFO - Added 0 items from storage type "local" to analysis queue
2020-07-29 22:36:05,944 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid
2020-07-29 22:36:06,973 - octoprint.plugins.pluginmanager - INFO - Loaded notice data from disk, was still valid
2020-07-29 22:36:06,988 - octoprint.server - INFO - Trying to connect to configured serial port None
2020-07-29 22:36:07,015 - octoprint.util.comm - INFO - Changing monitoring state from "Offline" to "Detecting serial port"
2020-07-29 22:36:07,019 - octoprint.server.util.watchdog - INFO - Running initial scan on watched folder...
2020-07-29 22:36:07,022 - octoprint.server.util.watchdog - INFO - ... initial scan done.
2020-07-29 22:36:07,038 - octoprint.plugins.discovery - INFO - Registered 'OctoPrint instance on octopi' for _http._tcp
2020-07-29 22:36:07,046 - octoprint.plugins.discovery - INFO - Registered 'OctoPrint instance on octopi' for _octoprint._tcp
2020-07-29 22:36:07,048 - octoprint.util.comm - INFO - Changing monitoring state from "Detecting serial port" to "Opening serial port"
2020-07-29 22:36:07,050 - octoprint.util.comm - INFO - Changing monitoring state from "Opening serial port" to "Detecting baudrate"
2020-07-29 22:36:07,055 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance on octopi for SSDP
2020-07-29 22:36:07,137 - octoprint.server - INFO - Listening on http://127.0.0.1:5000
2020-07-29 22:36:07,237 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid
2020-07-29 22:36:07,580 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:192.168.1.246
2020-07-29 22:36:07,804 - octoprint.server.util.flask - INFO - Passively logging in user Admin from ::ffff:192.168.1.246
2020-07-29 22:36:07,806 - octoprint.access.users - INFO - Logged in user: Admin
2020-07-29 22:36:07,843 - octoprint.server.util.sockjs - INFO - User Admin logged in on the socket from client ::ffff:192.168.1.246
2020-07-29 22:36:07,967 - octoprint.util.pip - INFO - Using "/home/pi/oprint/bin/python2 -m pip" as command to invoke pip
2020-07-29 22:36:08,043 - 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-07-29 22:36:08,044 - octoprint.util.pip - INFO - ==> pip ok -> yes
2020-07-29 22:36:08,060 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-07-29 22:36:08,101 - octoprint.util.comm - INFO - Changing monitoring state from "Detecting baudrate" to "Operational"
2020-07-29 22:36:08,129 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-07-29 22:36:08,292 - octoprint.util.pip - INFO - Using "/home/pi/oprint/bin/python2 -m pip" as command to invoke pip
2020-07-29 22:36:08,417 - octoprint.util.pip - INFO - Using "/home/pi/oprint/bin/python2 -m pip" as command to invoke pip
2020-07-29 22:36:08,479 - octoprint.util.pip - INFO - Using "/home/pi/oprint/bin/python2 -m pip" as command to invoke pip
2020-07-29 22:36:08,844 - octoprint.plugins.pluginmanager - INFO - Loaded notice data from disk, was still valid
2020-07-29 22:36:12,033 - 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-07-29 22:36:12,034 - octoprint.util.pip - INFO - ==> pip ok -> yes
2020-07-29 22:36:12,083 - octoprint.plugins.softwareupdate - INFO - Saved version cache to disk
2020-07-29 22:36:12,084 - octoprint.plugins.HeaterTimeout - INFO - Starting up...
2020-07-29 22:36:12,086 - octoprint.plugins.bedlevelvisualizer - INFO - OctoPrint-BedLevelVisualizer loaded!
2020-07-29 22:36:12,087 - octoprint.plugins.themeify - INFO - Themeify initialized.
2020-07-29 22:36:12,181 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'query_string': 'l10n=en', 'path': '/', 'base_url': 'http://192.168.1.24/'}
2020-07-29 22:36:16,436 - octoprint.util.comm - INFO - Got a resend request from the printer: requested line = 1, current line = 3
| Last lines in terminal:
| Recv: echo:  M206 X0.00 Y0.00 Z0.00
| Recv: echo:Auto Bed Leveling:
| Recv: echo:  M420 S0 Z2.00
| Recv: echo:PID settings:
| Recv: echo:  M301 P14.72 I0.89 D61.22
| Recv: echo:Z-Probe Offset (mm):
| Recv: echo:  M851 Z0.00
| Recv: echo:enqueueing "M420 S1"
| Recv: echo:SD init fail
| Recv: ***Initing card fails***
| Recv: ===Initing RTS has finished===
| Recv: echo:SD init fail
| Recv: echo:Bed Leveling On
| Recv: echo:Fade Height 2.00
| Recv: ok
| Send: N1 M115*39
| Recv: ok
| Send: N2 M21*18
| Recv: Error:Line Number is not Last Line Number+1, Last Line: 0
| Recv: Resend: 1
2020-07-29 22:36:16,457 - octoprint.util.comm - INFO - Printer reports firmware name "Marlin Ver 1.70.0 BL (Creality3D)"
2020-07-29 22:36:16,460 - octoprint.plugins.ABL_Expert - INFO - self.printer_cap[eeprom] is now 1

2020-07-29 22:36:16,476 - octoprint.util.comm - INFO - Firmware states that it supports temperature autoreporting
2020-07-29 22:36:16,489 - octoprint.plugins.ABL_Expert - INFO - self.printer_cap[autolevel] is now 1

2020-07-29 22:36:16,497 - octoprint.plugins.ABL_Expert - INFO - self.printer_cap[z_probe] is now 1

2020-07-29 22:36:16,499 - octoprint.plugins.ABL_Expert - INFO - self.printer_cap[leveling_data] is now 1

2020-07-29 22:36:16,531 - octoprint.plugins.ABL_Expert - INFO - self.printer_cap[eeprom] is now 1

2020-07-29 22:36:16,535 - octoprint.util.comm - INFO - Firmware states that it supports temperature autoreporting
2020-07-29 22:36:16,540 - octoprint.plugins.ABL_Expert - INFO - self.printer_cap[autolevel] is now 1

2020-07-29 22:36:16,543 - octoprint.plugins.ABL_Expert - INFO - self.printer_cap[z_probe] is now 1

2020-07-29 22:36:16,546 - octoprint.plugins.ABL_Expert - INFO - self.printer_cap[leveling_data] is now 1

2020-07-29 22:36:18,091 - octoprint.server.preemptive_cache - INFO - ... done in 5.91s
2020-07-29 22:36:19,848 - octoprint.server.util.flask - INFO - Passively logging in user Admin from ::ffff:192.168.1.246
2020-07-29 22:36:19,850 - octoprint.access.users - INFO - Logged in user: Admin
2020-07-29 22:36:20,855 - octoprint.plugins.ABL_Expert - INFO - Grid mesh size is 4
2020-07-29 22:36:21,015 - octoprint.plugins.ABL_Expert - INFO - Grid mesh size is 4
2020-07-29 22:36:21,752 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:192.168.1.246
2020-07-29 22:36:23,263 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:192.168.1.246
2020-07-29 22:36:23,374 - octoprint.server.util.flask - INFO - Passively logging in user Admin from ::ffff:192.168.1.246
2020-07-29 22:36:23,377 - octoprint.access.users - INFO - Logged in user: Admin
2020-07-29 22:36:24,660 - octoprint.server.util.sockjs - INFO - User Admin logged in on the socket from client ::ffff:192.168.1.246
2020-07-29 22:44:44,730 - octoprint.printer.standard.job - INFO - Print job selected - origin: local, path: Lightbearer_Coaster_A_v3.gcode, owner: Admin, user: Admin
2020-07-29 22:44:44,756 - octoprint.util.comm - INFO - Changing monitoring state from "Operational" to "Starting"
2020-07-29 22:44:44,765 - octoprint.printer.standard.job - INFO - Print job started - origin: local, path: Lightbearer_Coaster_A_v3.gcode, owner: Admin, user: Admin
2020-07-29 22:44:44,782 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-07-29 22:44:46,845 - octoprint.util.comm - INFO - Printer seems to support the busy protocol, will adjust timeouts and set busy interval accordingly
2020-07-29 22:44:46,856 - octoprint.util.comm - INFO - Telling the printer to set the busy interval to our "communicationBusy" timeout - 1s = 2s
2020-07-29 22:47:54,689 - octoprint.plugins.ABL_Expert - INFO - Grid mesh size is 4
2020-07-29 22:47:54,895 - octoprint.util.comm - INFO - Changing monitoring state from "Starting" to "Printing"
2020-07-29 22:51:03,389 - octoprint.server.heartbeat - INFO - Server heartbeat <3
2020-07-29 22:55:02,534 - octoprint.timelapse - ERROR - Could not capture image /home/pi/.octoprint/timelapse/tmp/Lightbearer_Coaster_A_v3_20200729224444-0.jpg from http://127.0.0.1:8080/?action=snapshot
Traceback (most recent call last):
  File "/home/pi/oprint/local/lib/python2.7/site-packages/octoprint/timelapse.py", line 644, in _perform_capture
    verify=self._snapshot_validate_ssl)
  File "/home/pi/oprint/local/lib/python2.7/site-packages/requests/api.py", line 75, in get
    return request('get', url, params=params, **kwargs)
  File "/home/pi/oprint/local/lib/python2.7/site-packages/requests/api.py", line 60, in request
    return session.request(method=method, url=url, **kwargs)
  File "/home/pi/oprint/local/lib/python2.7/site-packages/requests/sessions.py", line 533, in request
    resp = self.send(prep, **send_kwargs)
  File "/home/pi/oprint/local/lib/python2.7/site-packages/requests/sessions.py", line 646, in send
    r = adapter.send(request, **kwargs)
  File "/home/pi/oprint/local/lib/python2.7/site-packages/requests/adapters.py", line 516, in send
    raise ConnectionError(e, request=request)
ConnectionError: HTTPConnectionPool(host='127.0.0.1', port=8080): Max retries exceeded with url: /?action=snapshot (Caused by NewConnectionError('<urllib3.connection.HTTPConnection object at 0xae83ac50>: Failed to establish a new connection: [Errno 111] Connection refused',))
2020-07-29 22:55:32,982 - octoprint.util.comm - INFO - Changing monitoring state from "Printing" to "Cancelling"
2020-07-29 22:55:32,992 - octoprint.util.comm - INFO - Force-sending M108 to the printer
2020-07-29 22:55:33,006 - octoprint.printer.standard.job - INFO - Print job cancelled - origin: local, path: Lightbearer_Coaster_A_v3.gcode, owner: Admin, user: Admin
2020-07-29 22:55:35,282 - octoprint.util.comm - INFO - Changing monitoring state from "Cancelling" to "Operational"

Additional information about your setup

OctoPrint 1.4.0 running on OctoPi 0.17.0

Printer: Creality Ender 5 Plus
Firmware: Ver. 1.70.0 BL

Slicer: Ultimaker Cura 4.5

I have set up the camera and timelapse, but it is unplugged currently so there are connection errors from that, pay no mind to those.

I'm not sure about the T part. I can't test it right now, but doesn't that just output a report?
Also https://marlinfw.org/docs/gcode/G029-abl-linear.html mentions a boolean behind T like T0 or T1
Try it with just G29

also make sure you Z-Offset is correct

1 Like

I set the T to T1, and made sure the offset was calibrated in the ABL Expert Plugin.