What is the problem?
After trying to upgrade a Rpi 3B from 1.5.0 to 1.5.1, the following message is displayed in the GUI "The update could not be started. Is it already active? Please consult octoprint.log for details."
Another 1.5.0 install(Rpi 3B+) upgraded without any issues.
Both installs are identical, apart from the HW and the hostname, installed from the downloaded image, and upgraded to 1.5.0. Only config change after the install, is an additional user added.
What did you already try to solve it?
I have rebooted and tried the upgrade to 1.5.1 several times.
Have you tried running in safe mode and if so did it solve the issue?
Safe mode did not solve the issue.
2020-12-05 13:13:02,249 - octoprint.startup - INFO - ******************************************************************************
2020-12-05 13:13:02,254 - octoprint.startup - INFO - Starting OctoPrint 1.5.0
2020-12-05 13:13:02,255 - octoprint.startup - INFO - Starting in SAFE MODE. Third party plugins will be disabled!
2020-12-05 13:13:02,257 - octoprint.startup - INFO - Reason for safe mode: setting in config.yaml
2020-12-05 13:13:02,258 - octoprint.startup - INFO - ******************************************************************************
2020-12-05 13:13:03,474 - octoprint.util.connectivity.connectivity_checker - INFO - Connectivity changed from offline to online
2020-12-05 13:13:03,487 - octoprint.util.connectivity.connectivity_checker - INFO - Connectivity state is currently: online
2020-12-05 13:13:03,489 - octoprint.util.connectivity.connectivity_checker - INFO - Connecting to 192.168.123.15:53 is working
2020-12-05 13:13:03,491 - octoprint.util.connectivity.connectivity_checker - INFO - Resolving octoprint.org is working
2020-12-05 13:13:03,899 - octoprint.startup - INFO - Blacklist processing done, adding 10 blacklisted plugin versions: roomtemp (any), GcodeEditor (0.1.1), GcodeEditor (0.2.0), GcodeEditor (0.2.1), GcodeEditor (0.2.2), GcodeEditor (0.2.3), GcodeEditor (0.2.4), GcodeEditor (0.2.5), GcodeEditor (0.2.6), GcodeEditor (0.2.8)
2020-12-05 13:13:03,968 - 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-12-05 13:13:06,564 - octoprint.plugin.core - INFO - Found 17 plugin(s) providing 17 mixin implementations, 34 hook handlers
2020-12-05 13:13:07,027 - octoprint.server.heartbeat - INFO - Starting server heartbeat, 900.0s interval
2020-12-05 13:13:07,076 - octoprint.server - INFO - Intermediary server started
2020-12-05 13:13:07,148 - octoprint.filemanager.storage - INFO - Initializing the file metadata for /home/pi/.octoprint/uploads...
2020-12-05 13:13:07,153 - octoprint.filemanager.storage - INFO - ... file metadata for /home/pi/.octoprint/uploads initialized successfully.
2020-12-05 13:13:07,161 - 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')")
2020-12-05 13:13:07,164 - 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')")
2020-12-05 13:13:07,167 - 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-12-05 13:13:07,171 - octoprint.server - INFO - Added new permission from plugin announcements: PLUGIN_ANNOUNCEMENTS_READ (needs: u"Need(method='role', value=u'plugin_announcements_read')")
2020-12-05 13:13:07,174 - 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-12-05 13:13:07,177 - octoprint.server - INFO - Added new permission from plugin appkeys: PLUGIN_APPKEYS_ADMIN (needs: u"Need(method='role', value=u'plugin_appkeys_admin')")
2020-12-05 13:13:07,181 - octoprint.server - INFO - Added new permission from plugin backup: PLUGIN_BACKUP_ACCESS (needs: u"Need(method='role', value=u'plugin_backup_access')")
2020-12-05 13:13:07,184 - octoprint.server - INFO - Added new permission from plugin firmware_check: PLUGIN_FIRMWARE_CHECK_DISPLAY (needs: u"Need(method='role', value=u'plugin_firmware_check_display')")
2020-12-05 13:13:07,188 - octoprint.server - INFO - Added new permission from plugin logging: PLUGIN_LOGGING_MANAGE (needs: u"Need(method='role', value=u'plugin_logging_manage')")
2020-12-05 13:13:07,191 - 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-12-05 13:13:07,195 - octoprint.server - INFO - Added new permission from plugin pluginmanager: PLUGIN_PLUGINMANAGER_MANAGE (needs: u"Need(method='role', value=u'plugin_pluginmanager_manage')")
2020-12-05 13:13:07,199 - 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-12-05 13:13:07,202 - octoprint.server - INFO - Added new permission from plugin softwareupdate: PLUGIN_SOFTWAREUPDATE_CHECK (needs: u"Need(method='role', value=u'plugin_softwareupdate_check')")
2020-12-05 13:13:07,205 - octoprint.server - INFO - Added new permission from plugin softwareupdate: PLUGIN_SOFTWAREUPDATE_UPDATE (needs: u"Need(method='role', value=u'plugin_softwareupdate_update')")
2020-12-05 13:13:07,207 - octoprint.server - INFO - Added new permission from plugin softwareupdate: PLUGIN_SOFTWAREUPDATE_CONFIGURE (needs: u"Need(method='role', value=u'plugin_softwareupdate_configure')")
2020-12-05 13:13:07,637 - octoprint.plugins.softwareupdate - INFO - Loaded version cache from disk
2020-12-05 13:13:09,808 - octoprint.util.pip - INFO - Using "/home/pi/oprint/bin/python2 -m pip" as command to invoke pip
2020-12-05 13:13:11,865 - octoprint.util.pip - INFO - Version of pip is 19.3.1
2020-12-05 13:13:11,869 - 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-12-05 13:13:11,871 - octoprint.util.pip - INFO - ==> pip ok -> yes
2020-12-05 13:13:11,916 - octoprint.plugin.core - INFO - Initialized 17 plugin implementation(s)
2020-12-05 13:13:11,960 - octoprint.plugin.core - INFO - 17 plugin(s) registered with the system:
| Action Command Notification Support (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/action_command_notification
| 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
| 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
| File Check (2020.8.7) (bundled) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_file_check
| Firmware Check (2020.9.23) (bundled) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_firmware_check
| GCode Viewer (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/gcodeviewer
| Logging (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/logging
| 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
| Software Update (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/softwareupdate
| Virtual Printer (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/virtual_printer
Prefix legend: ! = disabled, # = blacklisted, * = incompatible
2020-12-05 13:13:12,009 - 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.
!!! UNDERVOLTAGE REPORTED !!! Make sure that the power supply and power cable are capable of supplying enough voltage and current to your Pi.
2020-12-05 13:13:12,038 - octoprint.environment - INFO - Detected environment is Python 2.7.16 under Linux (linux2). Details:
| hardware:
| cores: 4
| freq: 1200.0
| ram: 917016576
| os:
| bits: 32
| id: linux
| platform: linux2
| plugins:
| pi_support:
| model: Raspberry Pi 3 Model B Rev 1.2
| octopi_version: 0.17.0
| throttle_state: '0x50005'
| python:
| pip: 19.3.1
| version: 2.7.16
| virtualenv: /home/pi/oprint
2020-12-05 13:13:12,069 - octoprint.server - INFO - Reset webasset folder /home/pi/.octoprint/generated/webassets...
2020-12-05 13:13:12,120 - octoprint.server - INFO - Reset webasset folder /home/pi/.octoprint/generated/.webassets-cache...
2020-12-05 13:13:14,424 - octoprint.server - INFO - Shutting down intermediary server...
2020-12-05 13:13:14,545 - octoprint.server - INFO - Intermediary server shut down
2020-12-05 13:13:14,551 - octoprint.events - INFO - Processing startup event, this is our first event
2020-12-05 13:13:14,558 - octoprint.events - INFO - Adding 2 events to queue that were held back before startup event
2020-12-05 13:13:14,577 - octoprint.server - INFO - Autoconnect on startup is configured, trying to connect to the printer...
2020-12-05 13:13:14,578 - octoprint.filemanager - INFO - Adding backlog items from all storage types to analysis queue...
2020-12-05 13:13:14,586 - octoprint.plugins.softwareupdate - INFO - Fetching check overlays from https://plugins.octoprint.org/update_check_overlay.json
2020-12-05 13:13:14,775 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid
2020-12-05 13:13:15,043 - octoprint.filemanager - INFO - Added 0 items from storage type "local" to analysis queue
2020-12-05 13:13:16,297 - octoprint.plugins.tracking - INFO - Sent tracking event system_throttled, payload: {u'throttled_mask': 327685, u'throttled_voltage_now': True, u'throttled_voltage_past': True, u'throttled_overheat_now': False, u'throttled_now': True, u'throttled_past': True, u'throttled_overheat_past': False}
2020-12-05 13:13:18,903 - octoprint.plugins.pluginmanager - INFO - Loaded notice data from disk, was still valid
2020-12-05 13:13:18,955 - octoprint.server - INFO - Trying to connect to configured serial port AUTO
2020-12-05 13:13:19,086 - octoprint.util.comm - INFO - Changing monitoring state from "Offline" to "Detecting serial connection"
2020-12-05 13:13:19,105 - octoprint.server.util.watchdog - INFO - Running initial scan on watched folder...
2020-12-05 13:13:19,108 - octoprint.server.util.watchdog - INFO - ... initial scan done.
2020-12-05 13:13:19,174 - octoprint.util.comm - INFO - Serial detection: Performing autodetection with 7 port/baudrate candidates: /dev/ttyACM0@115200, /dev/ttyACM0@250000, /dev/ttyACM0@230400, /dev/ttyACM0@57600, /dev/ttyACM0@38400, /dev/ttyACM0@19200, /dev/ttyACM0@9600
2020-12-05 13:13:19,176 - octoprint.util.comm - INFO - Serial detection: Trying port /dev/ttyACM0, baudrate 115200
2020-12-05 13:13:19,181 - octoprint.util.comm - INFO - Connecting to port /dev/ttyACM0, baudrate 115200
2020-12-05 13:13:19,194 - octoprint.util.comm - INFO - Serial detection: Handshake attempt #1 with timeout 2.0s
2020-12-05 13:13:19,201 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-12-05 13:13:19,961 - octoprint.plugins.discovery - INFO - Registered 'OctoPrint instance on octoprint1._http._tcp.local.' for _http._tcp.local.
2020-12-05 13:13:20,182 - octoprint.util.comm - INFO - Changing monitoring state from "Detecting serial connection" to "Operational"
2020-12-05 13:13:20,273 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0
2020-12-05 13:13:20,789 - octoprint.plugins.discovery - INFO - Registered 'OctoPrint instance on octoprint1._octoprint._tcp.local.' for _octoprint._tcp.local.
2020-12-05 13:13:20,817 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance on octoprint1 for SSDP
2020-12-05 13:13:20,854 - octoprint.server - INFO - Listening on http://127.0.0.1:5000
2020-12-05 13:13:20,857 - octoprint.server - INFO - Server started successfully in safe mode as requested from config, removing flag
2020-12-05 13:13:21,205 - octoprint.util.comm - INFO - Printer reports firmware name "Prusa-Firmware 3.2.3 based on Marlin"
2020-12-05 13:13:21,571 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid
2020-12-05 13:13:22,161 - octoprint.plugins.tracking - INFO - Sent tracking event printer_connected, payload: {u'printer_baudrate': 0, u'printer_port': 'AUTO', u'firmware_name': u'Prusa-Firmware 3.2.3 based on Marlin'}
2020-12-05 13:13:22,601 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:192.168.123.199
2020-12-05 13:13:23,770 - octoprint.util.pip - INFO - Using "/home/pi/oprint/bin/python2 -m pip" as command to invoke pip
2020-12-05 13:13:23,858 - 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-12-05 13:13:23,877 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:192.168.123.198
2020-12-05 13:13:23,961 - octoprint.util.pip - INFO - ==> pip ok -> yes
2020-12-05 13:13:24,175 - octoprint.plugins.softwareupdate - INFO - Minimum free storage across all update relevant locations is 4.8GB. That is considered sufficient for updating.
2020-12-05 13:13:24,905 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:192.168.123.199
2020-12-05 13:13:25,515 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:192.168.123.199
2020-12-05 13:13:25,784 - octoprint.plugins.tracking - INFO - Sent tracking event ping, payload: {'octoprint_uptime': 19}
2020-12-05 13:13:26,259 - octoprint.server.util.flask - INFO - Passively logging in user admin from ::ffff:192.168.123.198
2020-12-05 13:13:26,511 - octoprint.access.users - INFO - Logged in user: admin
2020-12-05 13:13:26,629 - octoprint.server.util.flask - INFO - Passively logging in user admin from ::ffff:192.168.123.199
2020-12-05 13:13:26,648 - octoprint.access.users - INFO - Logged in user: admin
2020-12-05 13:13:26,717 - octoprint.server.util.sockjs - INFO - User admin logged in on the socket from client ::ffff:192.168.123.198
2020-12-05 13:13:27,049 - octoprint.server.util.sockjs - INFO - User admin logged in on the socket from client ::ffff:192.168.123.199
2020-12-05 13:13:27,071 - octoprint.plugins.tracking - INFO - Sent tracking event pong, payload: {u'python': '2.7.16', u'os': u'linux', u'ram': 917016576, u'octopi_version': u'0.17.0', u'version': u'1.5.0', u'plugins': u'', u'pip': '19.3.1', u'cores': 4, u'freq': 1200.0, u'pi_model': u'Raspberry Pi 3 Model B Rev 1.2', u'bits': 32}
2020-12-05 13:13:27,091 - octoprint.plugins.pluginmanager - INFO - Loaded notice data from disk, was still valid
2020-12-05 13:13:27,267 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'query_string': 'l10n=en', 'path': '/', 'base_url': 'http://192.168.123.61/'}
2020-12-05 13:13:27,726 - octoprint.plugins.tracking - INFO - Sent tracking event startup, payload: {u'python': '2.7.16', u'os': u'linux', u'ram': 917016576, u'octopi_version': u'0.17.0', u'version': u'1.5.0', u'pip': '19.3.1', u'cores': 4, u'freq': 1200.0, u'pi_model': u'Raspberry Pi 3 Model B Rev 1.2', u'bits': 32}
2020-12-05 13:13:45,631 - octoprint.server.util.flask - INFO - Passively logging in user admin from ::ffff:192.168.123.199
2020-12-05 13:13:45,659 - octoprint.access.users - INFO - Logged in user: admin
2020-12-05 13:14:02,483 - octoprint.server.preemptive_cache - INFO - ... done in 35.22s
2020-12-05 13:14:03,575 - octoprint.server.util.flask - INFO - Passively logging in user admin from ::ffff:192.168.123.199
2020-12-05 13:14:03,579 - octoprint.access.users - INFO - Logged in user: admin
2020-12-05 13:14:04,797 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:192.168.123.199
2020-12-05 13:14:05,239 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:192.168.123.199
2020-12-05 13:14:05,396 - octoprint.server.util.flask - INFO - Passively logging in user admin from ::ffff:192.168.123.199
2020-12-05 13:14:05,399 - octoprint.access.users - INFO - Logged in user: admin
2020-12-05 13:14:09,897 - octoprint.server.util.sockjs - INFO - User admin logged in on the socket from client ::ffff:192.168.123.199
2020-12-05 13:14:15,195 - tornado.access - WARNING - 409 POST /plugin/softwareupdate/update (::ffff:192.168.123.199) 32.34ms
2020-12-05 13:15:09,698 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:192.168.123.199