Skip to content

Instantly share code, notes, and snippets.

@mearleycf
Created August 17, 2017 15:00
Show Gist options
  • Save mearleycf/d155fbad07131b107c63835dfb15513a to your computer and use it in GitHub Desktop.
Save mearleycf/d155fbad07131b107c63835dfb15513a to your computer and use it in GitHub Desktop.
octoprint log file for issue
2017-08-16 15:03:02,263 - octoprint.server - INFO - ******************************************************************************
2017-08-16 15:03:02,266 - octoprint.server - INFO - Starting OctoPrint 0+unknown
2017-08-16 15:03:02,266 - octoprint.server - INFO - ******************************************************************************
2017-08-16 15:03:02,822 - octoprint.plugin.core - INFO - Loading plugins from c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins, C:\Users\Johnda\AppData\Roaming\OctoPrint\plugins and installed plugin packages...
2017-08-16 15:03:08,052 - octoprint.plugins.discovery - INFO - pybonjour is not installed, Zeroconf Discovery won't be available
2017-08-16 15:03:08,052 - octoprint.plugin.core - INFO - Found 7 plugin(s) providing 7 mixin implementations, 4 hook handlers
2017-08-16 15:03:08,362 - octoprint.plugin.core - INFO - Loading plugins from c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins, C:\Users\Johnda\AppData\Roaming\OctoPrint\plugins and installed plugin packages...
2017-08-16 15:03:08,559 - octoprint.plugin.core - INFO - Found 7 plugin(s) providing 7 mixin implementations, 4 hook handlers
2017-08-16 15:03:08,562 - octoprint.printer.profile - ERROR - Profile _default does not exist, creating _default again and setting it as default
2017-08-16 15:03:08,628 - octoprint.filemanager.storage - INFO - Initializing the file metadata for C:\Users\Johnda\AppData\Roaming\OctoPrint\uploads...
2017-08-16 15:03:08,628 - octoprint.filemanager.storage - INFO - ... file metadata for C:\Users\Johnda\AppData\Roaming\OctoPrint\uploads initialized successfully.
2017-08-16 15:03:13,029 - octoprint.util.pip - INFO - Using "c:\OctoPrint\oct\Scripts\python.exe -m pip" as command to invoke pip
2017-08-16 15:03:19,165 - octoprint.util.pip - INFO - Version of pip is 9.0.1
2017-08-16 15:03:19,165 - octoprint.util.pip - INFO - pip installs to c:\OctoPrint\oct\Lib\site-packages, --user flag needed => no, virtual env => yes
2017-08-16 15:03:19,167 - octoprint.plugin.core - INFO - Initialized 7 plugin implementation(s)
2017-08-16 15:03:19,207 - octoprint.plugin.core - INFO - 7 plugin(s) registered with the system:
| Announcement Plugin (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\announcements
| Core Wizard (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\corewizard
| CuraEngine (<= 15.04) (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\cura
| Discovery (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\discovery
| Plugin Manager (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\pluginmanager
| Software Update (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate
| Virtual Printer (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\virtual_printer
2017-08-16 15:03:19,213 - octoprint.server - INFO - Reset webasset folder C:\Users\Johnda\AppData\Roaming\OctoPrint\generated\webassets...
2017-08-16 15:03:19,213 - octoprint.filemanager - INFO - Adding backlog items from all storage types to analysis queue...
2017-08-16 15:03:19,213 - octoprint.server - INFO - Reset webasset folder C:\Users\Johnda\AppData\Roaming\OctoPrint\generated\.webassets-cache...
2017-08-16 15:03:19,214 - octoprint.filemanager - INFO - Added 0 items from storage type "local" to analysis queue
2017-08-16 15:03:19,923 - octoprint.server - INFO - Listening on http://0.0.0.0:5000
2017-08-16 15:03:19,924 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance on Johnda-PC for SSDP
2017-08-16 15:03:20,203 - octoprint.plugins.announcements - INFO - Loaded channel _important from http://octoprint.org/feeds/important.xml in 0.17s
2017-08-16 15:03:21,234 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from http://plugins.octoprint.org/plugins.json
2017-08-16 15:03:21,934 - octoprint.plugins.softwareupdate - INFO - Saved version cache to disk
2017-08-16 15:03:22,084 - octoprint.plugins.pluginmanager - INFO - Loaded plugin notices data from http://plugins.octoprint.org/notices.json
2017-08-16 15:03:22,101 - octoprint.plugins.announcements - INFO - Loaded channel _releases from http://octoprint.org/feeds/releases.xml in 0.064s
2017-08-16 15:03:22,187 - octoprint.plugins.announcements - INFO - Loaded channel _blog from http://octoprint.org/feeds/octoblog.xml in 0.054s
2017-08-16 15:03:22,331 - octoprint.plugins.announcements - INFO - Loaded channel _plugins from http://plugins.octoprint.org/feed.xml in 0.11s
2017-08-16 15:03:22,430 - octoprint.plugins.announcements - INFO - Loaded channel _octopi from http://octoprint.org/feeds/octopi.xml in 0.06s
2017-08-16 15:03:45,437 - octoprint.server.util.flask.PreemptiveCache - INFO - Adding entry for / and {'query_string': 'l10n=en', 'path': u'/', '_count': 1, '_timestamp': 1502910225.437, 'base_url': 'http://localhost:5000/'}
2017-08-16 15:03:55,604 - octoprint.server.util.sockjs - INFO - New connection from client: 127.0.0.1
2017-08-16 15:03:56,000 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-16 15:08:44,407 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-16 15:08:48,808 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-16 15:09:15,144 - octoprint.plugins.pluginmanager - INFO - Installing plugin from https://github.com/donovan6000/M33-Fio/archive/master.zip
2017-08-16 15:09:38,362 - octoprint.plugin.core - INFO - Loading plugins from c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins, C:\Users\Johnda\AppData\Roaming\OctoPrint\plugins and installed plugin packages...
2017-08-16 15:09:38,503 - octoprint.plugin.core - INFO - Found 8 plugin(s) providing 7 mixin implementations, 4 hook handlers
2017-08-16 15:09:38,506 - octoprint.plugin.core - INFO - 8 plugin(s) registered with the system:
| Announcement Plugin (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\announcements
| Core Wizard (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\corewizard
| CuraEngine (<= 15.04) (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\cura
| Discovery (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\discovery
| !M33 Fio (1.21) = c:\OctoPrint\oct\lib\site-packages\octoprint_m33fio
| Plugin Manager (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\pluginmanager
| Software Update (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate
| Virtual Printer (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\virtual_printer
2017-08-16 15:09:38,506 - octoprint.plugins.pluginmanager - INFO - The plugin was installed successfully: M33 Fio, version 1.21
2017-08-17 10:06:30,865 - octoprint.server - INFO - Shutting down...
2017-08-17 10:06:30,986 - octoprint.events - INFO - Processing shutdown event, this will be our last event
2017-08-17 10:06:30,992 - octoprint.events - INFO - Event loop shut down
2017-08-17 10:06:31,029 - octoprint.server - INFO - Goodbye!
2017-08-17 10:06:46,161 - octoprint.server - INFO - ******************************************************************************
2017-08-17 10:06:46,161 - octoprint.server - INFO - Starting OctoPrint 0+unknown
2017-08-17 10:06:46,161 - octoprint.server - INFO - ******************************************************************************
2017-08-17 10:06:47,119 - octoprint.plugin.core - INFO - Loading plugins from c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins, C:\Users\Johnda\AppData\Roaming\OctoPrint\plugins and installed plugin packages...
2017-08-17 10:06:55,361 - octoprint.plugins.discovery - INFO - pybonjour is not installed, Zeroconf Discovery won't be available
2017-08-17 10:06:55,362 - octoprint.plugin.core - INFO - Found 8 plugin(s) providing 8 mixin implementations, 8 hook handlers
2017-08-17 10:06:55,898 - octoprint.plugin.core - INFO - Loading plugins from c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins, C:\Users\Johnda\AppData\Roaming\OctoPrint\plugins and installed plugin packages...
2017-08-17 10:06:56,115 - octoprint.plugin.core - INFO - Found 8 plugin(s) providing 8 mixin implementations, 8 hook handlers
2017-08-17 10:06:56,157 - octoprint.filemanager.storage - INFO - Initializing the file metadata for C:\Users\Johnda\AppData\Roaming\OctoPrint\uploads...
2017-08-17 10:06:56,157 - octoprint.filemanager.storage - INFO - ... file metadata for C:\Users\Johnda\AppData\Roaming\OctoPrint\uploads initialized successfully.
2017-08-17 10:06:56,232 - octoprint.plugins.softwareupdate - INFO - Loaded version cache from disk
2017-08-17 10:07:00,908 - octoprint.util.pip - INFO - Using "c:\OctoPrint\oct\Scripts\python.exe -m pip" as command to invoke pip
2017-08-17 10:07:01,632 - octoprint.util.pip - INFO - Version of pip is 9.0.1
2017-08-17 10:07:01,632 - octoprint.util.pip - INFO - pip installs to c:\OctoPrint\oct\Lib\site-packages, --user flag needed => no, virtual env => yes
2017-08-17 10:07:01,634 - octoprint.plugin.core - INFO - Initialized 8 plugin implementation(s)
2017-08-17 10:07:01,634 - octoprint.plugin.core - INFO - 8 plugin(s) registered with the system:
| Announcement Plugin (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\announcements
| Core Wizard (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\corewizard
| CuraEngine (<= 15.04) (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\cura
| Discovery (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\discovery
| M33 Fio (1.21) = c:\OctoPrint\oct\lib\site-packages\octoprint_m33fio
| Plugin Manager (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\pluginmanager
| Software Update (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate
| Virtual Printer (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\virtual_printer
2017-08-17 10:07:01,635 - octoprint.filemanager - INFO - Adding backlog items from all storage types to analysis queue...
2017-08-17 10:07:01,637 - octoprint.filemanager - INFO - Added 0 items from storage type "local" to analysis queue
2017-08-17 10:07:01,683 - octoprint.server - INFO - Reset webasset folder C:\Users\Johnda\AppData\Roaming\OctoPrint\generated\webassets...
2017-08-17 10:07:01,743 - octoprint.server - INFO - Reset webasset folder C:\Users\Johnda\AppData\Roaming\OctoPrint\generated\.webassets-cache...
2017-08-17 10:07:04,388 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance on Johnda-PC for SSDP
2017-08-17 10:07:04,427 - octoprint.server - INFO - Listening on http://0.0.0.0:5000
2017-08-17 10:07:04,763 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:07:04,765 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:07:04,802 - octoprint.plugins.announcements - INFO - Loaded channel _important from http://octoprint.org/feeds/important.xml in 0.15s
2017-08-17 10:07:06,323 - octoprint.plugins.announcements - INFO - Loaded channel _releases from http://octoprint.org/feeds/releases.xml in 0.059s
2017-08-17 10:07:06,411 - octoprint.plugins.announcements - INFO - Loaded channel _blog from http://octoprint.org/feeds/octoblog.xml in 0.06s
2017-08-17 10:07:06,540 - octoprint.plugins.announcements - INFO - Loaded channel _plugins from http://plugins.octoprint.org/feed.xml in 0.1s
2017-08-17 10:07:06,634 - octoprint.plugins.announcements - INFO - Loaded channel _octopi from http://octoprint.org/feeds/octopi.xml in 0.059s
2017-08-17 10:07:06,829 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid
2017-08-17 10:07:06,904 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'query_string': 'l10n=en', 'path': '/', 'base_url': 'http://localhost:5000/'}
2017-08-17 10:07:07,108 - octoprint.plugins.pluginmanager - INFO - Loaded plugin notices data from http://plugins.octoprint.org/notices.json
2017-08-17 10:07:07,276 - octoprint.plugins.announcements - INFO - Loaded channel _m33fio from https://exploitkings.com/scripts/M33 Fio.xml in 0.62s
2017-08-17 10:07:07,928 - octoprint.util.pip - INFO - Using "c:\OctoPrint\oct\Scripts\python.exe -m pip" as command to invoke pip
2017-08-17 10:07:07,930 - octoprint.util.pip - INFO - Version of pip is 9.0.1
2017-08-17 10:07:08,759 - octoprint.server.util.sockjs - INFO - New connection from client: 127.0.0.1
2017-08-17 10:07:10,282 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:07:10,573 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:07:10,747 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:07:10,811 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:07:10,812 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:07:11,188 - octoprint.util.pip - INFO - pip installs to c:\OctoPrint\oct\Lib\site-packages\, --user flag needed => no, virtual env => yes
2017-08-17 10:07:11,265 - octoprint.plugins.softwareupdate - INFO - Saved version cache to disk
2017-08-17 10:07:22,433 - octoprint.server.preemptive_cache - INFO - ... done in 15.53s
2017-08-17 10:07:23,009 - octoprint.server.util.sockjs - INFO - Client connection closed: 127.0.0.1
2017-08-17 10:07:25,743 - octoprint.server.util.sockjs - INFO - New connection from client: 127.0.0.1
2017-08-17 10:07:26,829 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:07:26,836 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:07:26,839 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:07:26,841 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:07:26,841 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:07:27,253 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:07:28,940 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:07:29,042 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:07:56,483 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:07:56,483 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:07:56,875 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:07:56,881 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:08:08,216 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:08:43,256 - octoprint.server - INFO - Shutting down...
2017-08-17 10:08:43,796 - octoprint.events - INFO - Processing shutdown event, this will be our last event
2017-08-17 10:08:43,801 - octoprint.events - INFO - Event loop shut down
2017-08-17 10:08:43,838 - octoprint.server - INFO - Goodbye!
2017-08-17 10:11:46,124 - octoprint.server - INFO - ******************************************************************************
2017-08-17 10:11:46,124 - octoprint.server - INFO - Starting OctoPrint 0+unknown
2017-08-17 10:11:46,124 - octoprint.server - INFO - ******************************************************************************
2017-08-17 10:11:46,733 - octoprint.plugin.core - INFO - Loading plugins from c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins, C:\Users\Johnda\AppData\Roaming\OctoPrint\plugins and installed plugin packages...
2017-08-17 10:11:50,546 - octoprint.plugins.discovery - INFO - pybonjour is not installed, Zeroconf Discovery won't be available
2017-08-17 10:11:50,548 - octoprint.plugin.core - INFO - Found 8 plugin(s) providing 8 mixin implementations, 8 hook handlers
2017-08-17 10:11:50,844 - octoprint.plugin.core - INFO - Loading plugins from c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins, C:\Users\Johnda\AppData\Roaming\OctoPrint\plugins and installed plugin packages...
2017-08-17 10:11:50,967 - octoprint.plugin.core - INFO - Found 8 plugin(s) providing 8 mixin implementations, 8 hook handlers
2017-08-17 10:11:50,977 - octoprint.filemanager.storage - INFO - Initializing the file metadata for C:\Users\Johnda\AppData\Roaming\OctoPrint\uploads...
2017-08-17 10:11:50,977 - octoprint.filemanager.storage - INFO - ... file metadata for C:\Users\Johnda\AppData\Roaming\OctoPrint\uploads initialized successfully.
2017-08-17 10:11:50,993 - octoprint.plugins.softwareupdate - INFO - Loaded version cache from disk
2017-08-17 10:11:54,256 - octoprint.util.pip - INFO - Using "c:\OctoPrint\oct\Scripts\python.exe -m pip" as command to invoke pip
2017-08-17 10:11:54,973 - octoprint.util.pip - INFO - Version of pip is 9.0.1
2017-08-17 10:11:54,973 - octoprint.util.pip - INFO - pip installs to c:\OctoPrint\oct\Lib\site-packages, --user flag needed => no, virtual env => yes
2017-08-17 10:11:54,973 - octoprint.plugin.core - INFO - Initialized 8 plugin implementation(s)
2017-08-17 10:11:54,976 - octoprint.plugin.core - INFO - 8 plugin(s) registered with the system:
| Announcement Plugin (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\announcements
| Core Wizard (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\corewizard
| CuraEngine (<= 15.04) (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\cura
| Discovery (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\discovery
| M33 Fio (1.21) = c:\OctoPrint\oct\lib\site-packages\octoprint_m33fio
| Plugin Manager (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\pluginmanager
| Software Update (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate
| Virtual Printer (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\virtual_printer
2017-08-17 10:11:54,976 - octoprint.filemanager - INFO - Adding backlog items from all storage types to analysis queue...
2017-08-17 10:11:54,977 - octoprint.filemanager - INFO - Added 0 items from storage type "local" to analysis queue
2017-08-17 10:11:54,982 - octoprint.server - INFO - Reset webasset folder C:\Users\Johnda\AppData\Roaming\OctoPrint\generated\webassets...
2017-08-17 10:11:55,030 - octoprint.server - INFO - Reset webasset folder C:\Users\Johnda\AppData\Roaming\OctoPrint\generated\.webassets-cache...
2017-08-17 10:11:55,855 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance on Johnda-PC for SSDP
2017-08-17 10:11:55,892 - octoprint.server - INFO - Listening on http://0.0.0.0:5000
2017-08-17 10:11:56,049 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:11:56,096 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:11:57,364 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid
2017-08-17 10:11:57,382 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'query_string': 'l10n=en', 'path': '/', 'base_url': 'http://localhost:5000/'}
2017-08-17 10:11:57,411 - octoprint.plugins.pluginmanager - INFO - Loaded notices from disk, was still valid
2017-08-17 10:12:05,371 - octoprint.server.preemptive_cache - INFO - ... done in 7.99s
2017-08-17 10:12:53,505 - octoprint.server.util.sockjs - INFO - New connection from client: 127.0.0.1
2017-08-17 10:12:54,573 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:12:54,575 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:12:54,578 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:12:54,579 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:12:54,581 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:13:45,299 - octoprint.server.util.sockjs - INFO - Client connection closed: 127.0.0.1
2017-08-17 10:13:47,318 - octoprint.server.util.sockjs - INFO - New connection from client: 127.0.0.1
2017-08-17 10:13:47,914 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:13:47,914 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:13:47,915 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:13:47,917 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:13:47,917 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:13:48,000 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:13:49,137 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:13:49,645 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:13:53,805 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:13:53,809 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:13:54,194 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:13:54,219 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:14:05,471 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:14:58,029 - octoprint.plugins.softwareupdate - INFO - Saved version cache to disk
2017-08-17 10:14:58,036 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:15:09,408 - octoprint.plugins.softwareupdate - INFO - Starting update of octoprint to 1.3.4...
2017-08-17 10:15:10,265 - octoprint.plugins.softwareupdate.updaters.update_script - ERROR - Target: octoprint, error while executing update script, got returncode 1
Traceback (most recent call last):
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate\updaters\update_script.py", line 88, in perform_update
caller.checked_call(update_command, cwd=folder)
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\util\commandline.py", line 69, in checked_call
raise CommandlineError(returncode, stdout, stderr)
CommandlineError
2017-08-17 10:15:10,269 - octoprint.plugins.softwareupdate - ERROR - Update of octoprint can not be performed
Traceback (most recent call last):
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate\__init__.py", line 823, in _perform_update
update_result = updater.perform_update(target, populated_check, target_version, log_cb=self._log)
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate\updaters\update_script.py", line 91, in perform_update
raise UpdateError("Error while executing update script for %s", (e.stdout, e.stderr))
UpdateError
2017-08-17 10:18:42,309 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:18:42,585 - octoprint.plugins.softwareupdate - INFO - Saved version cache to disk
2017-08-17 10:18:52,068 - octoprint.plugins.softwareupdate - INFO - Starting update of octoprint to 1.3.4...
2017-08-17 10:18:52,829 - octoprint.plugins.softwareupdate.updaters.update_script - ERROR - Target: octoprint, error while executing update script, got returncode 1
Traceback (most recent call last):
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate\updaters\update_script.py", line 88, in perform_update
caller.checked_call(update_command, cwd=folder)
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\util\commandline.py", line 69, in checked_call
raise CommandlineError(returncode, stdout, stderr)
CommandlineError
2017-08-17 10:18:52,926 - octoprint.plugins.softwareupdate - ERROR - Update of octoprint can not be performed
Traceback (most recent call last):
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate\__init__.py", line 823, in _perform_update
update_result = updater.perform_update(target, populated_check, target_version, log_cb=self._log)
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate\updaters\update_script.py", line 91, in perform_update
raise UpdateError("Error while executing update script for %s", (e.stdout, e.stderr))
UpdateError
2017-08-17 10:19:17,460 - octoprint.plugins.softwareupdate - INFO - Starting update of octoprint to 1.3.4...
2017-08-17 10:19:18,239 - octoprint.plugins.softwareupdate.updaters.update_script - ERROR - Target: octoprint, error while executing update script, got returncode 1
Traceback (most recent call last):
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate\updaters\update_script.py", line 88, in perform_update
caller.checked_call(update_command, cwd=folder)
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\util\commandline.py", line 69, in checked_call
raise CommandlineError(returncode, stdout, stderr)
CommandlineError
2017-08-17 10:19:18,239 - octoprint.plugins.softwareupdate - ERROR - Update of octoprint can not be performed
Traceback (most recent call last):
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate\__init__.py", line 823, in _perform_update
update_result = updater.perform_update(target, populated_check, target_version, log_cb=self._log)
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate\updaters\update_script.py", line 91, in perform_update
raise UpdateError("Error while executing update script for %s", (e.stdout, e.stderr))
UpdateError
2017-08-17 10:22:57,835 - octoprint.plugins.pluginmanager - INFO - Installing plugin from https://github.com/OctoPrint/OctoPrint-Yamlpatcher/archive/master.zip
2017-08-17 10:23:06,707 - octoprint.plugin.core - INFO - Loading plugins from c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins, C:\Users\Johnda\AppData\Roaming\OctoPrint\plugins and installed plugin packages...
2017-08-17 10:23:06,834 - octoprint.plugin.core - INFO - Found 9 plugin(s) providing 8 mixin implementations, 8 hook handlers
2017-08-17 10:23:06,835 - octoprint.plugin.core - INFO - 9 plugin(s) registered with the system:
| Announcement Plugin (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\announcements
| Core Wizard (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\corewizard
| CuraEngine (<= 15.04) (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\cura
| Discovery (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\discovery
| M33 Fio (1.21) = c:\OctoPrint\oct\lib\site-packages\octoprint_m33fio
| Plugin Manager (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\pluginmanager
| Software Update (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate
| Virtual Printer (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\virtual_printer
| !Yamlpatcher (0.1.1) = c:\OctoPrint\oct\lib\site-packages\octoprint_yamlpatcher
2017-08-17 10:23:06,835 - octoprint.plugins.pluginmanager - INFO - The plugin was installed successfully: Yamlpatcher, version 0.1.1
2017-08-17 10:25:45,453 - octoprint.server - INFO - Shutting down...
2017-08-17 10:25:46,165 - octoprint.events - INFO - Processing shutdown event, this will be our last event
2017-08-17 10:25:46,171 - octoprint.events - INFO - Event loop shut down
2017-08-17 10:25:46,209 - octoprint.server - INFO - Goodbye!
2017-08-17 10:25:55,721 - octoprint.server - INFO - ******************************************************************************
2017-08-17 10:25:55,721 - octoprint.server - INFO - Starting OctoPrint 0+unknown
2017-08-17 10:25:55,721 - octoprint.server - INFO - ******************************************************************************
2017-08-17 10:25:55,767 - octoprint.plugin.core - INFO - Loading plugins from c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins, C:\Users\Johnda\AppData\Roaming\OctoPrint\plugins and installed plugin packages...
2017-08-17 10:25:56,513 - octoprint.plugin.core - DEBUG - Loaded plugin m33fio: M33 Fio (1.21)
2017-08-17 10:25:56,513 - octoprint.plugin.core - DEBUG - Loaded plugin softwareupdate: Software Update
2017-08-17 10:25:56,513 - octoprint.plugin.core - DEBUG - Loaded plugin pluginmanager: Plugin Manager
2017-08-17 10:25:56,513 - octoprint.plugin.core - DEBUG - Loaded plugin yamlpatcher: Yamlpatcher (0.1.1)
2017-08-17 10:25:56,513 - octoprint.plugin.core - DEBUG - Loaded plugin virtual_printer: Virtual Printer
2017-08-17 10:25:56,515 - octoprint.plugin.core - DEBUG - Loaded plugin announcements: Announcement Plugin
2017-08-17 10:25:56,515 - octoprint.plugin.core - DEBUG - Loaded plugin corewizard: Core Wizard
2017-08-17 10:25:56,515 - octoprint.plugin.core - DEBUG - Loaded plugin cura: CuraEngine (<= 15.04)
2017-08-17 10:25:56,515 - octoprint.plugins.discovery - INFO - pybonjour is not installed, Zeroconf Discovery won't be available
2017-08-17 10:25:56,515 - octoprint.plugin.core - DEBUG - Loaded plugin discovery: Discovery
2017-08-17 10:25:56,516 - octoprint.plugin.core - DEBUG - Enabled plugin m33fio: M33 Fio (1.21)
2017-08-17 10:25:56,516 - octoprint.plugin.core - DEBUG - Enabled plugin softwareupdate: Software Update
2017-08-17 10:25:56,516 - octoprint.plugin.core - DEBUG - Enabled plugin pluginmanager: Plugin Manager
2017-08-17 10:25:56,516 - octoprint.plugin.core - DEBUG - Enabled plugin yamlpatcher: Yamlpatcher (0.1.1)
2017-08-17 10:25:56,516 - octoprint.plugin.core - DEBUG - Enabled plugin virtual_printer: Virtual Printer
2017-08-17 10:25:56,516 - octoprint.plugin.core - DEBUG - Enabled plugin announcements: Announcement Plugin
2017-08-17 10:25:56,516 - octoprint.plugin.core - DEBUG - Enabled plugin corewizard: Core Wizard
2017-08-17 10:25:56,516 - octoprint.plugin.core - DEBUG - Enabled plugin cura: CuraEngine (<= 15.04)
2017-08-17 10:25:56,516 - octoprint.plugin.core - DEBUG - Enabled plugin discovery: Discovery
2017-08-17 10:25:56,517 - octoprint.plugin.core - INFO - Found 9 plugin(s) providing 9 mixin implementations, 9 hook handlers
2017-08-17 10:25:56,760 - octoprint.server - DEBUG - Starting intermediary server on 0.0.0.0:5000
2017-08-17 10:25:56,766 - octoprint.server - DEBUG - Intermediary server started
2017-08-17 10:25:56,766 - octoprint.plugin.core - INFO - Loading plugins from c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins, C:\Users\Johnda\AppData\Roaming\OctoPrint\plugins and installed plugin packages...
2017-08-17 10:25:56,891 - octoprint.plugin.core - INFO - Found 9 plugin(s) providing 9 mixin implementations, 9 hook handlers
2017-08-17 10:25:56,903 - octoprint.filemanager.storage - INFO - Initializing the file metadata for C:\Users\Johnda\AppData\Roaming\OctoPrint\uploads...
2017-08-17 10:25:56,903 - octoprint.filemanager.storage - INFO - ... file metadata for C:\Users\Johnda\AppData\Roaming\OctoPrint\uploads initialized successfully.
2017-08-17 10:25:56,907 - octoprint.events - DEBUG - Subscribed listener <bound method Printer._on_event_MetadataAnalysisFinished of <octoprint.printer.standard.Printer object at 0x041A6E70>> for event MetadataAnalysisFinished
2017-08-17 10:25:56,907 - octoprint.events - DEBUG - Subscribed listener <bound method Printer._on_event_MetadataStatisticsUpdated of <octoprint.printer.standard.Printer object at 0x041A6E70>> for event MetadataStatisticsUpdated
2017-08-17 10:25:56,907 - octoprint.plugin.core - DEBUG - Initialized plugin mixin implementation for plugin yamlpatcher
2017-08-17 10:25:56,907 - octoprint.plugin.core - DEBUG - Initialized plugin mixin implementation for plugin virtual_printer
2017-08-17 10:25:56,907 - octoprint.plugin.core - DEBUG - Initialized plugin mixin implementation for plugin corewizard
2017-08-17 10:25:56,908 - octoprint.plugin.core - DEBUG - Initialized plugin mixin implementation for plugin m33fio
2017-08-17 10:25:56,920 - octoprint.plugins.softwareupdate - INFO - Loaded version cache from disk
2017-08-17 10:25:56,920 - octoprint.plugin.core - DEBUG - Initialized plugin mixin implementation for plugin softwareupdate
2017-08-17 10:25:56,921 - octoprint.plugin.core - DEBUG - Initialized plugin mixin implementation for plugin cura
2017-08-17 10:25:56,921 - octoprint.plugin.core - DEBUG - Initialized plugin mixin implementation for plugin announcements
2017-08-17 10:25:57,650 - octoprint.util.pip - INFO - Using "c:\OctoPrint\oct\Scripts\python.exe -m pip" as command to invoke pip
2017-08-17 10:25:58,382 - octoprint.util.pip - INFO - Version of pip is 9.0.1
2017-08-17 10:25:58,382 - octoprint.util.pip - INFO - pip installs to c:\OctoPrint\oct\Lib\site-packages, --user flag needed => no, virtual env => yes
2017-08-17 10:25:58,382 - octoprint.plugin.core - DEBUG - Initialized plugin mixin implementation for plugin pluginmanager
2017-08-17 10:25:58,384 - octoprint.plugin.core - DEBUG - Initialized plugin mixin implementation for plugin discovery
2017-08-17 10:25:58,384 - octoprint.plugin.core - INFO - Initialized 9 plugin implementation(s)
2017-08-17 10:25:58,423 - octoprint.plugin.core - INFO - 9 plugin(s) registered with the system:
| Announcement Plugin (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\announcements
| Core Wizard (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\corewizard
| CuraEngine (<= 15.04) (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\cura
| Discovery (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\discovery
| M33 Fio (1.21) = c:\OctoPrint\oct\lib\site-packages\octoprint_m33fio
| Plugin Manager (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\pluginmanager
| Software Update (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate
| Virtual Printer (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\virtual_printer
| Yamlpatcher (0.1.1) = c:\OctoPrint\oct\lib\site-packages\octoprint_yamlpatcher
2017-08-17 10:25:58,424 - octoprint.filemanager - INFO - Adding backlog items from all storage types to analysis queue...
2017-08-17 10:25:58,424 - octoprint.filemanager - INFO - Added 0 items from storage type "local" to analysis queue
2017-08-17 10:25:58,426 - octoprint.server - DEBUG - Deleting C:\Users\Johnda\AppData\Roaming\OctoPrint\generated\webassets...
2017-08-17 10:25:58,428 - octoprint.server - DEBUG - Creating C:\Users\Johnda\AppData\Roaming\OctoPrint\generated\webassets...
2017-08-17 10:25:58,428 - octoprint.server - INFO - Reset webasset folder C:\Users\Johnda\AppData\Roaming\OctoPrint\generated\webassets...
2017-08-17 10:25:58,430 - octoprint.server - DEBUG - Deleting C:\Users\Johnda\AppData\Roaming\OctoPrint\generated\.webassets-cache...
2017-08-17 10:25:58,486 - octoprint.server - DEBUG - Creating C:\Users\Johnda\AppData\Roaming\OctoPrint\generated\.webassets-cache...
2017-08-17 10:25:58,486 - octoprint.server - INFO - Reset webasset folder C:\Users\Johnda\AppData\Roaming\OctoPrint\generated\.webassets-cache...
2017-08-17 10:25:58,523 - octoprint.server - DEBUG - Registered API of plugin announcements under URL prefix /plugin/announcements
2017-08-17 10:25:58,526 - octoprint.server - DEBUG - Registered API of plugin corewizard under URL prefix /plugin/corewizard
2017-08-17 10:25:58,526 - octoprint.server - DEBUG - Registered API of plugin cura under URL prefix /plugin/cura
2017-08-17 10:25:58,528 - octoprint.server - DEBUG - Registered API of plugin discovery under URL prefix /plugin/discovery
2017-08-17 10:25:58,529 - octoprint.server - DEBUG - Registered API of plugin m33fio under URL prefix /plugin/m33fio
2017-08-17 10:25:58,530 - octoprint.server - DEBUG - Registered API of plugin pluginmanager under URL prefix /plugin/pluginmanager
2017-08-17 10:25:58,532 - octoprint.server - DEBUG - Registered API of plugin softwareupdate under URL prefix /plugin/softwareupdate
2017-08-17 10:25:58,532 - octoprint.server - DEBUG - Registered assets of plugin yamlpatcher under URL prefix /plugin/yamlpatcher
2017-08-17 10:25:58,540 - octoprint.server - DEBUG - Adding maximum body size of 52428800B for POST requests to /plugin/m33fio/upload)
2017-08-17 10:25:58,540 - octoprint.server - DEBUG - Adding maximum body size of 52428800B for POST requests to /plugin/pluginmanager/upload_archive)
2017-08-17 10:25:58,540 - octoprint.server - DEBUG - Shutting down intermediary server...
2017-08-17 10:26:01,897 - octoprint.server - DEBUG - Intermediary server shut down
2017-08-17 10:26:01,897 - octoprint.events - DEBUG - Firing event: Startup (Payload: None)
2017-08-17 10:26:01,904 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance on Johnda-PC for SSDP
2017-08-17 10:26:01,905 - octoprint.server - INFO - Listening on http://0.0.0.0:5000
2017-08-17 10:26:02,072 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:02,073 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:02,355 - tornado.access - INFO - 200 GET /plugin/discovery/discovery.xml (192.168.86.47) 182.00ms
2017-08-17 10:26:03,328 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid
2017-08-17 10:26:03,355 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'query_string': 'l10n=en', 'path': '/', 'base_url': 'http://localhost:5000/'}
2017-08-17 10:26:03,430 - octoprint.plugins.pluginmanager - INFO - Loaded notices from disk, was still valid
2017-08-17 10:26:03,523 - octoprint.server.views - DEBUG - Forcing rendering of view _default
2017-08-17 10:26:03,630 - octoprint.server.util.flask - DEBUG - No cache entry or refreshing cache for / (key: ui:_default:http://localhost:5000/:en), calling wrapped function
2017-08-17 10:26:04,476 - octoprint.util.pip - INFO - Using "c:\OctoPrint\oct\Scripts\python.exe -m pip" as command to invoke pip
2017-08-17 10:26:04,476 - octoprint.util.pip - INFO - Version of pip is 9.0.1
2017-08-17 10:26:06,269 - octoprint.util.pip - INFO - pip installs to c:\OctoPrint\oct\Lib\site-packages\, --user flag needed => no, virtual env => yes
2017-08-17 10:26:06,292 - octoprint.plugins.softwareupdate - INFO - Saved version cache to disk
2017-08-17 10:26:08,213 - tornado.access - INFO - 200 GET /sockjs/info?t=1502979967911 (127.0.0.1) 1.00ms
2017-08-17 10:26:08,535 - octoprint.server.util.sockjs - INFO - New connection from client: 127.0.0.1
2017-08-17 10:26:08,551 - octoprint.events - DEBUG - Firing event: ClientOpened (Payload: {'remoteAddress': '127.0.0.1'})
2017-08-17 10:26:08,551 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PowerOn
2017-08-17 10:26:08,552 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event TransferStarted
2017-08-17 10:26:08,565 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event FileDeselected
2017-08-17 10:26:08,671 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PostRollEnd
2017-08-17 10:26:08,736 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event SlicingProfileDeleted
2017-08-17 10:26:08,842 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event SlicingProfileModified
2017-08-17 10:26:08,918 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrinterStateChanged
2017-08-17 10:26:08,950 - octoprint.server.util.flask - DEBUG - Needed 5.32s to render / (key: ui:_default:http://localhost:5000/:en)
2017-08-17 10:26:08,973 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event ('FolderRemoved',)
2017-08-17 10:26:08,996 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PowerOff
2017-08-17 10:26:08,999 - octoprint.server.preemptive_cache - INFO - ... done in 5.64s
2017-08-17 10:26:09,022 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event ('FileAdded',)
2017-08-17 10:26:09,032 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrintDone
2017-08-17 10:26:09,072 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event FileSelected
2017-08-17 10:26:09,118 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrintCancelled
2017-08-17 10:26:09,216 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event MetadataAnalysisStarted
2017-08-17 10:26:09,299 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event UpdatedFiles
2017-08-17 10:26:09,321 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event MetadataStatisticsUpdated
2017-08-17 10:26:09,346 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event ('FolderAdded',)
2017-08-17 10:26:09,368 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event SlicingCancelled
2017-08-17 10:26:09,390 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Disconnected
2017-08-17 10:26:09,413 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Conveyor
2017-08-17 10:26:09,437 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event SettingsUpdated
2017-08-17 10:26:09,440 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event MovieRendering
2017-08-17 10:26:09,461 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Connecting
2017-08-17 10:26:09,483 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Startup
2017-08-17 10:26:09,506 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event MetadataAnalysisFinished
2017-08-17 10:26:09,529 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Disconnecting
2017-08-17 10:26:09,598 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Home
2017-08-17 10:26:09,608 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event ClientClosed
2017-08-17 10:26:09,642 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event EStop
2017-08-17 10:26:09,644 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event ('FileRemoved',)
2017-08-17 10:26:09,644 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event RegisteredMessageReceived
2017-08-17 10:26:09,645 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrintResumed
2017-08-17 10:26:09,645 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PostRollStart
2017-08-17 10:26:09,645 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Eject
2017-08-17 10:26:09,647 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:09,647 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event MovieFailed
2017-08-17 10:26:09,647 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Waiting
2017-08-17 10:26:09,648 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:09,648 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Upload
2017-08-17 10:26:09,648 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Cooling
2017-08-17 10:26:09,648 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Shutdown
2017-08-17 10:26:09,648 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Error
2017-08-17 10:26:09,648 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:09,650 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event CaptureFailed
2017-08-17 10:26:09,650 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Dwelling
2017-08-17 10:26:09,650 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:09,650 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event SlicingDone
2017-08-17 10:26:09,651 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:09,651 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event SlicingProfileAdded
2017-08-17 10:26:09,653 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event SlicingFailed
2017-08-17 10:26:09,663 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event ZChange
2017-08-17 10:26:09,663 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrinterProfileModified
2017-08-17 10:26:09,664 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrintStarted
2017-08-17 10:26:09,664 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrinterProfileAdded
2017-08-17 10:26:09,664 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrintPaused
2017-08-17 10:26:09,664 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event ClientOpened
2017-08-17 10:26:09,664 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Alert
2017-08-17 10:26:09,664 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event TransferDone
2017-08-17 10:26:09,664 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event CaptureStart
2017-08-17 10:26:09,664 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrintFailed
2017-08-17 10:26:09,664 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Connected
2017-08-17 10:26:09,665 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event MovieDone
2017-08-17 10:26:09,665 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PositionUpdate
2017-08-17 10:26:09,665 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event SlicingStarted
2017-08-17 10:26:09,665 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrinterProfileDeleted
2017-08-17 10:26:09,665 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event CaptureDone
2017-08-17 10:26:09,671 - tornado.access - INFO - 200 GET /api/files?recursive=true (127.0.0.1) 5.00ms
2017-08-17 10:26:09,678 - tornado.access - INFO - 200 GET /api/timelapse?unrendered=true (127.0.0.1) 6.00ms
2017-08-17 10:26:09,710 - tornado.access - INFO - 200 GET /api/settings (127.0.0.1) 29.00ms
2017-08-17 10:26:09,714 - octoprint.users - DEBUG - Logged in user: SessionUser(id=stormtitan,name=stormtitan,active=True,user=True,admin=True,session=yDfu2aMhrV,created=1502979969.71)
2017-08-17 10:26:09,717 - tornado.access - INFO - 200 POST /api/login (127.0.0.1) 5.00ms
2017-08-17 10:26:09,717 - tornado.access - INFO - 200 POST /api/login (127.0.0.1) 6.00ms
2017-08-17 10:26:09,750 - tornado.access - INFO - 200 GET /api/users (127.0.0.1) 3.00ms
2017-08-17 10:26:10,052 - tornado.access - INFO - 200 GET /api/system/commands (127.0.0.1) 3.00ms
2017-08-17 10:26:10,059 - tornado.access - INFO - 200 GET /plugin/softwareupdate/check (127.0.0.1) 6.00ms
2017-08-17 10:26:10,164 - tornado.access - INFO - 304 GET /plugin/announcements/channels (127.0.0.1) 105.00ms
2017-08-17 10:26:10,197 - tornado.access - INFO - 200 GET /api/settings (127.0.0.1) 31.00ms
2017-08-17 10:26:10,219 - tornado.access - INFO - 200 GET /api/plugin/pluginmanager (127.0.0.1) 20.00ms
2017-08-17 10:26:12,023 - tornado.access - INFO - 200 GET /plugin/discovery/discovery.xml (192.168.86.45) 5.00ms
2017-08-17 10:26:16,634 - octoprint.server.util.flask.PreemptiveCache - DEBUG - Updating timestamp and counter for / and {'query_string': 'l10n=en', 'path': u'/', 'base_url': 'http://localhost:5000/'}
2017-08-17 10:26:16,703 - octoprint.server.util.flask - DEBUG - Serving entry for / from cache (key: ui:_default:http://localhost:5000/:en)
2017-08-17 10:26:16,719 - tornado.access - INFO - 200 GET / (127.0.0.1) 89.00ms
2017-08-17 10:26:16,730 - octoprint.server.util.sockjs - INFO - Client connection closed: 127.0.0.1
2017-08-17 10:26:16,730 - octoprint.events - DEBUG - Firing event: ClientClosed (Payload: {'remoteAddress': '127.0.0.1'})
2017-08-17 10:26:16,730 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PowerOn
2017-08-17 10:26:16,730 - octoprint.events - DEBUG - Sending action to <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>>
2017-08-17 10:26:16,730 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event TransferStarted
2017-08-17 10:26:16,730 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event FileDeselected
2017-08-17 10:26:16,732 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PostRollEnd
2017-08-17 10:26:16,732 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event SlicingProfileDeleted
2017-08-17 10:26:16,733 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event SlicingProfileModified
2017-08-17 10:26:16,733 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrinterStateChanged
2017-08-17 10:26:16,733 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event ('FolderRemoved',)
2017-08-17 10:26:16,733 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PowerOff
2017-08-17 10:26:16,733 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event ('FileAdded',)
2017-08-17 10:26:16,733 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrintDone
2017-08-17 10:26:16,733 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event FileSelected
2017-08-17 10:26:16,733 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrintCancelled
2017-08-17 10:26:16,733 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event MetadataAnalysisStarted
2017-08-17 10:26:16,733 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event UpdatedFiles
2017-08-17 10:26:16,733 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event MetadataStatisticsUpdated
2017-08-17 10:26:16,734 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event ('FolderAdded',)
2017-08-17 10:26:16,734 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event SlicingCancelled
2017-08-17 10:26:16,734 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Disconnected
2017-08-17 10:26:16,734 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Conveyor
2017-08-17 10:26:16,734 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event SettingsUpdated
2017-08-17 10:26:16,734 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event MovieRendering
2017-08-17 10:26:16,736 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Connecting
2017-08-17 10:26:16,736 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Startup
2017-08-17 10:26:16,736 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event MetadataAnalysisFinished
2017-08-17 10:26:16,736 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Disconnecting
2017-08-17 10:26:16,736 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Home
2017-08-17 10:26:16,736 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event ClientClosed
2017-08-17 10:26:16,736 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event EStop
2017-08-17 10:26:16,736 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event ('FileRemoved',)
2017-08-17 10:26:16,736 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event RegisteredMessageReceived
2017-08-17 10:26:16,736 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrintResumed
2017-08-17 10:26:16,736 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PostRollStart
2017-08-17 10:26:16,736 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Eject
2017-08-17 10:26:16,737 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event MovieFailed
2017-08-17 10:26:16,737 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Waiting
2017-08-17 10:26:16,739 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Upload
2017-08-17 10:26:16,739 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Cooling
2017-08-17 10:26:16,739 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Shutdown
2017-08-17 10:26:16,739 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Error
2017-08-17 10:26:16,740 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event CaptureFailed
2017-08-17 10:26:16,740 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Dwelling
2017-08-17 10:26:16,740 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event SlicingDone
2017-08-17 10:26:16,740 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event SlicingProfileAdded
2017-08-17 10:26:16,740 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event SlicingFailed
2017-08-17 10:26:16,743 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event ZChange
2017-08-17 10:26:16,743 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrinterProfileModified
2017-08-17 10:26:16,743 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrintStarted
2017-08-17 10:26:16,743 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrinterProfileAdded
2017-08-17 10:26:16,743 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrintPaused
2017-08-17 10:26:16,743 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event ClientOpened
2017-08-17 10:26:16,743 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Alert
2017-08-17 10:26:16,744 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event TransferDone
2017-08-17 10:26:16,744 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event CaptureStart
2017-08-17 10:26:16,744 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrintFailed
2017-08-17 10:26:16,744 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event Connected
2017-08-17 10:26:16,746 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event MovieDone
2017-08-17 10:26:16,746 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PositionUpdate
2017-08-17 10:26:16,746 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event SlicingStarted
2017-08-17 10:26:16,746 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event PrinterProfileDeleted
2017-08-17 10:26:16,746 - octoprint.events - DEBUG - Unsubscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BE4A30>> for event CaptureDone
2017-08-17 10:26:16,894 - tornado.access - INFO - 200 GET /static/webassets/packed_libs.css?59a4290c (127.0.0.1) 2.00ms
2017-08-17 10:26:16,900 - tornado.access - INFO - 200 GET /static/webassets/packed_core.css?ac89acf1 (127.0.0.1) 2.00ms
2017-08-17 10:26:16,964 - tornado.access - INFO - 200 GET /static/webassets/packed_plugins.css?7a8dc852 (127.0.0.1) 2.00ms
2017-08-17 10:26:17,148 - tornado.access - INFO - 200 GET /static/webassets/packed_client.js?788179ad (127.0.0.1) 2.00ms
2017-08-17 10:26:17,158 - tornado.access - INFO - 200 GET /static/webassets/packed_core.js?abf24465 (127.0.0.1) 4.00ms
2017-08-17 10:26:17,174 - tornado.access - INFO - 200 GET /static/webassets/packed_libs.js?16a717e3 (127.0.0.1) 36.00ms
2017-08-17 10:26:17,200 - tornado.access - INFO - 200 GET /static/webassets/packed_plugins.js?2b1cd923 (127.0.0.1) 40.00ms
2017-08-17 10:26:18,188 - tornado.access - INFO - 200 GET /sockjs/info?t=1502979978186 (127.0.0.1) 1.00ms
2017-08-17 10:26:18,792 - octoprint.server.util.sockjs - INFO - New connection from client: 127.0.0.1
2017-08-17 10:26:18,801 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event PowerOn
2017-08-17 10:26:18,802 - octoprint.events - DEBUG - Firing event: ClientOpened (Payload: {'remoteAddress': '127.0.0.1'})
2017-08-17 10:26:18,802 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event TransferStarted
2017-08-17 10:26:18,888 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event FileDeselected
2017-08-17 10:26:18,901 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event PostRollEnd
2017-08-17 10:26:18,901 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event SlicingProfileDeleted
2017-08-17 10:26:18,901 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event SlicingProfileModified
2017-08-17 10:26:18,901 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event PrinterStateChanged
2017-08-17 10:26:18,901 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event ('FolderRemoved',)
2017-08-17 10:26:18,956 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event PowerOff
2017-08-17 10:26:19,029 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event ('FileAdded',)
2017-08-17 10:26:19,062 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event PrintDone
2017-08-17 10:26:19,117 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event FileSelected
2017-08-17 10:26:19,118 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event PrintCancelled
2017-08-17 10:26:19,131 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event MetadataAnalysisStarted
2017-08-17 10:26:19,131 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event UpdatedFiles
2017-08-17 10:26:19,131 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event MetadataStatisticsUpdated
2017-08-17 10:26:19,132 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event ('FolderAdded',)
2017-08-17 10:26:19,132 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event SlicingCancelled
2017-08-17 10:26:19,132 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event Disconnected
2017-08-17 10:26:19,134 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event Conveyor
2017-08-17 10:26:19,134 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event SettingsUpdated
2017-08-17 10:26:19,134 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event MovieRendering
2017-08-17 10:26:19,134 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event Connecting
2017-08-17 10:26:19,134 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event Startup
2017-08-17 10:26:19,134 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event MetadataAnalysisFinished
2017-08-17 10:26:19,134 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event Disconnecting
2017-08-17 10:26:19,135 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event Home
2017-08-17 10:26:19,135 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event ClientClosed
2017-08-17 10:26:19,135 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event EStop
2017-08-17 10:26:19,135 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event ('FileRemoved',)
2017-08-17 10:26:19,135 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event RegisteredMessageReceived
2017-08-17 10:26:19,135 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event PrintResumed
2017-08-17 10:26:19,137 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event PostRollStart
2017-08-17 10:26:19,137 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event Eject
2017-08-17 10:26:19,137 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event MovieFailed
2017-08-17 10:26:19,137 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event Waiting
2017-08-17 10:26:19,137 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event Upload
2017-08-17 10:26:19,137 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event Cooling
2017-08-17 10:26:19,138 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event Shutdown
2017-08-17 10:26:19,138 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event Error
2017-08-17 10:26:19,138 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event CaptureFailed
2017-08-17 10:26:19,138 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event Dwelling
2017-08-17 10:26:19,138 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event SlicingDone
2017-08-17 10:26:19,138 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event SlicingProfileAdded
2017-08-17 10:26:19,138 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event SlicingFailed
2017-08-17 10:26:19,138 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event ZChange
2017-08-17 10:26:19,140 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event PrinterProfileModified
2017-08-17 10:26:19,140 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event PrintStarted
2017-08-17 10:26:19,140 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event PrinterProfileAdded
2017-08-17 10:26:19,140 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event PrintPaused
2017-08-17 10:26:19,140 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event ClientOpened
2017-08-17 10:26:19,140 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event Alert
2017-08-17 10:26:19,141 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event TransferDone
2017-08-17 10:26:19,142 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event CaptureStart
2017-08-17 10:26:19,142 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event PrintFailed
2017-08-17 10:26:19,142 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event Connected
2017-08-17 10:26:19,142 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event MovieDone
2017-08-17 10:26:19,142 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event PositionUpdate
2017-08-17 10:26:19,144 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event SlicingStarted
2017-08-17 10:26:19,144 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event PrinterProfileDeleted
2017-08-17 10:26:19,144 - octoprint.events - DEBUG - Subscribed listener <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>> for event CaptureDone
2017-08-17 10:26:19,382 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:19,394 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:19,397 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:19,398 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:19,398 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:19,417 - tornado.access - INFO - 200 GET /api/connection (127.0.0.1) 228.00ms
2017-08-17 10:26:19,421 - tornado.access - INFO - 200 GET /api/printer/command/custom (127.0.0.1) 3.00ms
2017-08-17 10:26:19,456 - tornado.access - INFO - 200 GET /api/printerprofiles/_default (127.0.0.1) 30.00ms
2017-08-17 10:26:19,460 - tornado.access - INFO - 200 GET /api/timelapse?unrendered=true (127.0.0.1) 3.00ms
2017-08-17 10:26:19,502 - tornado.access - INFO - 200 GET /api/printerprofiles (127.0.0.1) 40.00ms
2017-08-17 10:26:19,507 - tornado.access - INFO - 200 GET /api/files?recursive=true (127.0.0.1) 5.00ms
2017-08-17 10:26:19,749 - tornado.access - INFO - 200 GET /api/settings (127.0.0.1) 30.00ms
2017-08-17 10:26:19,756 - tornado.access - INFO - 200 GET /api/timelapse?unrendered=true (127.0.0.1) 5.00ms
2017-08-17 10:26:19,765 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:19,767 - tornado.access - INFO - 200 GET /api/slicing (127.0.0.1) 6.00ms
2017-08-17 10:26:20,059 - tornado.access - INFO - 200 GET /api/settings (127.0.0.1) 29.00ms
2017-08-17 10:26:20,578 - octoprint.users - DEBUG - Logged in user: SessionUser(id=stormtitan,name=stormtitan,active=True,user=True,admin=True,session=yDfu2aMhrV,created=1502979969.71)
2017-08-17 10:26:20,578 - tornado.access - INFO - 200 POST /api/login (127.0.0.1) 4.00ms
2017-08-17 10:26:20,579 - tornado.access - INFO - 200 POST /api/login (127.0.0.1) 5.00ms
2017-08-17 10:26:20,586 - tornado.access - INFO - 200 GET /api/files?recursive=true (127.0.0.1) 5.00ms
2017-08-17 10:26:20,589 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:20,592 - tornado.access - INFO - 200 GET /api/slicing (127.0.0.1) 4.00ms
2017-08-17 10:26:20,599 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:20,601 - tornado.access - INFO - 200 GET /api/slicing (127.0.0.1) 5.00ms
2017-08-17 10:26:20,828 - tornado.access - INFO - 200 GET /api/users (127.0.0.1) 3.00ms
2017-08-17 10:26:20,927 - tornado.access - INFO - 200 GET /api/settings (127.0.0.1) 32.00ms
2017-08-17 10:26:21,053 - tornado.access - INFO - 304 GET /plugin/announcements/channels (127.0.0.1) 119.00ms
2017-08-17 10:26:21,065 - tornado.access - INFO - 304 GET /api/plugin/pluginmanager (127.0.0.1) 10.00ms
2017-08-17 10:26:21,081 - tornado.access - INFO - 304 GET /plugin/softwareupdate/check (127.0.0.1) 6.00ms
2017-08-17 10:26:21,089 - tornado.access - INFO - 200 GET /api/system/commands (127.0.0.1) 5.00ms
2017-08-17 10:26:23,351 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:23,351 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:23,354 - tornado.access - INFO - 204 POST /api/plugin/m33fio (127.0.0.1) 6.00ms
2017-08-17 10:26:23,355 - tornado.access - INFO - 200 POST /api/plugin/m33fio (127.0.0.1) 7.00ms
2017-08-17 10:26:23,392 - tornado.access - INFO - 200 GET /api/settings (127.0.0.1) 36.00ms
2017-08-17 10:26:23,638 - tornado.access - INFO - 200 GET /api/printerprofiles (127.0.0.1) 40.00ms
2017-08-17 10:26:23,717 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:23,720 - tornado.access - INFO - 200 GET /api/slicing (127.0.0.1) 4.00ms
2017-08-17 10:26:23,723 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:26:23,726 - tornado.access - INFO - 200 GET /api/slicing (127.0.0.1) 6.00ms
2017-08-17 10:26:26,848 - tornado.access - INFO - 200 POST /plugin/softwareupdate/update (127.0.0.1) 6.00ms
2017-08-17 10:26:26,846 - octoprint.plugins.softwareupdate - INFO - Starting update of octoprint to 1.3.4...
2017-08-17 10:26:26,849 - tornado.access - INFO - 200 POST /plugin/softwareupdate/update (127.0.0.1) 8.00ms
2017-08-17 10:26:27,572 - octoprint.plugins.softwareupdate.updaters.update_script - ERROR - Target: octoprint, error while executing update script, got returncode 1
Traceback (most recent call last):
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate\updaters\update_script.py", line 88, in perform_update
caller.checked_call(update_command, cwd=folder)
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\util\commandline.py", line 69, in checked_call
raise CommandlineError(returncode, stdout, stderr)
CommandlineError
2017-08-17 10:26:27,573 - octoprint.plugins.softwareupdate - ERROR - Update of octoprint can not be performed
Traceback (most recent call last):
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate\__init__.py", line 823, in _perform_update
update_result = updater.perform_update(target, populated_check, target_version, log_cb=self._log)
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate\updaters\update_script.py", line 91, in perform_update
raise UpdateError("Error while executing update script for %s", (e.stdout, e.stderr))
UpdateError
2017-08-17 10:29:18,901 - tornado.access - INFO - 204 POST /api/plugin/m33fio (127.0.0.1) 4.00ms
2017-08-17 10:29:18,901 - tornado.access - INFO - 200 POST /api/plugin/m33fio (127.0.0.1) 5.00ms
2017-08-17 10:29:35,535 - octoprint.server - INFO - Shutting down...
2017-08-17 10:29:36,085 - octoprint.events - INFO - Processing shutdown event, this will be our last event
2017-08-17 10:29:36,085 - octoprint.events - DEBUG - Firing event: Shutdown (Payload: None)
2017-08-17 10:29:36,089 - octoprint.events - DEBUG - Sending action to <bound method PrinterStateConnection._onEvent of <octoprint.server.util.sockjs.PrinterStateConnection object at 0x06BCE5B0>>
2017-08-17 10:29:36,115 - octoprint.events - INFO - Event loop shut down
2017-08-17 10:29:36,130 - octoprint.server - INFO - Goodbye!
2017-08-17 10:39:49,193 - octoprint.server - INFO - ******************************************************************************
2017-08-17 10:39:49,193 - octoprint.server - INFO - Starting OctoPrint 0+unknown
2017-08-17 10:39:49,193 - octoprint.server - INFO - ******************************************************************************
2017-08-17 10:39:49,239 - octoprint.plugin.core - INFO - Loading plugins from c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins, C:\Users\Johnda\AppData\Roaming\OctoPrint\plugins and installed plugin packages...
2017-08-17 10:39:49,986 - octoprint.plugins.discovery - INFO - pybonjour is not installed, Zeroconf Discovery won't be available
2017-08-17 10:39:49,986 - octoprint.plugin.core - INFO - Found 9 plugin(s) providing 9 mixin implementations, 9 hook handlers
2017-08-17 10:39:50,232 - octoprint.plugin.core - INFO - Loading plugins from c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins, C:\Users\Johnda\AppData\Roaming\OctoPrint\plugins and installed plugin packages...
2017-08-17 10:39:50,355 - octoprint.plugin.core - INFO - Found 9 plugin(s) providing 9 mixin implementations, 9 hook handlers
2017-08-17 10:39:50,367 - octoprint.filemanager.storage - INFO - Initializing the file metadata for C:\Users\Johnda\AppData\Roaming\OctoPrint\uploads...
2017-08-17 10:39:50,368 - octoprint.filemanager.storage - INFO - ... file metadata for C:\Users\Johnda\AppData\Roaming\OctoPrint\uploads initialized successfully.
2017-08-17 10:39:50,384 - octoprint.plugins.softwareupdate - INFO - Loaded version cache from disk
2017-08-17 10:39:51,109 - octoprint.util.pip - INFO - Using "c:\OctoPrint\oct\Scripts\python.exe -m pip" as command to invoke pip
2017-08-17 10:39:51,832 - octoprint.util.pip - INFO - Version of pip is 9.0.1
2017-08-17 10:39:51,834 - octoprint.util.pip - INFO - pip installs to c:\OctoPrint\oct\Lib\site-packages, --user flag needed => no, virtual env => yes
2017-08-17 10:39:51,834 - octoprint.plugin.core - INFO - Initialized 9 plugin implementation(s)
2017-08-17 10:39:51,835 - octoprint.plugin.core - INFO - 9 plugin(s) registered with the system:
| Announcement Plugin (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\announcements
| Core Wizard (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\corewizard
| CuraEngine (<= 15.04) (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\cura
| Discovery (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\discovery
| M33 Fio (1.21) = c:\OctoPrint\oct\lib\site-packages\octoprint_m33fio
| Plugin Manager (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\pluginmanager
| Software Update (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate
| Virtual Printer (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\virtual_printer
| Yamlpatcher (0.1.1) = c:\OctoPrint\oct\lib\site-packages\octoprint_yamlpatcher
2017-08-17 10:39:51,836 - octoprint.filemanager - INFO - Adding backlog items from all storage types to analysis queue...
2017-08-17 10:39:51,838 - octoprint.filemanager - INFO - Added 0 items from storage type "local" to analysis queue
2017-08-17 10:39:51,842 - octoprint.server - INFO - Reset webasset folder C:\Users\Johnda\AppData\Roaming\OctoPrint\generated\webassets...
2017-08-17 10:39:51,891 - octoprint.server - INFO - Reset webasset folder C:\Users\Johnda\AppData\Roaming\OctoPrint\generated\.webassets-cache...
2017-08-17 10:39:52,239 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance on Johnda-PC for SSDP
2017-08-17 10:39:52,243 - octoprint.server - INFO - Listening on http://0.0.0.0:5000
2017-08-17 10:39:52,433 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:39:52,474 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:39:53,740 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid
2017-08-17 10:39:53,763 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'query_string': 'l10n=en', 'path': '/', 'base_url': 'http://localhost:5000/'}
2017-08-17 10:39:53,802 - octoprint.plugins.pluginmanager - INFO - Loaded notices from disk, was still valid
2017-08-17 10:39:58,467 - octoprint.server.preemptive_cache - INFO - ... done in 4.70s
2017-08-17 10:41:29,200 - tornado.access - WARNING - 401 POST /api/plugin/m33fio (127.0.0.1) 3.00ms
2017-08-17 10:41:47,369 - octoprint.server.util.sockjs - INFO - New connection from client: 127.0.0.1
2017-08-17 10:41:48,747 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:41:48,757 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:41:48,780 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:41:48,785 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:41:48,786 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:41:50,789 - octoprint.server.util.sockjs - INFO - Client connection closed: 127.0.0.1
2017-08-17 10:41:52,959 - octoprint.server.util.sockjs - INFO - New connection from client: 127.0.0.1
2017-08-17 10:41:53,548 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:41:53,556 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:41:53,562 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:41:53,563 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:41:53,569 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:41:53,709 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:41:54,535 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:41:54,973 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:41:57,078 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:41:57,078 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:41:57,440 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:41:57,447 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:44:13,017 - octoprint.plugins.softwareupdate - INFO - Starting update of octoprint to 1.3.4...
2017-08-17 10:44:13,793 - octoprint.plugins.softwareupdate.updaters.update_script - ERROR - Target: octoprint, error while executing update script, got returncode 1
Traceback (most recent call last):
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate\updaters\update_script.py", line 88, in perform_update
caller.checked_call(update_command, cwd=folder)
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\util\commandline.py", line 69, in checked_call
raise CommandlineError(returncode, stdout, stderr)
CommandlineError
2017-08-17 10:44:13,796 - octoprint.plugins.softwareupdate - ERROR - Update of octoprint can not be performed
Traceback (most recent call last):
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate\__init__.py", line 823, in _perform_update
update_result = updater.perform_update(target, populated_check, target_version, log_cb=self._log)
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate\updaters\update_script.py", line 91, in perform_update
raise UpdateError("Error while executing update script for %s", (e.stdout, e.stderr))
UpdateError
2017-08-17 10:46:44,937 - octoprint.server - INFO - Shutting down...
2017-08-17 10:46:45,467 - octoprint.events - INFO - Processing shutdown event, this will be our last event
2017-08-17 10:46:45,471 - octoprint.events - INFO - Event loop shut down
2017-08-17 10:46:45,510 - octoprint.server - INFO - Goodbye!
2017-08-17 10:46:50,157 - octoprint.server - INFO - ******************************************************************************
2017-08-17 10:46:50,157 - octoprint.server - INFO - Starting OctoPrint 0+unknown
2017-08-17 10:46:50,157 - octoprint.server - INFO - Starting in SAFE MODE. Third party plugins will be disabled!
2017-08-17 10:46:50,157 - octoprint.server - INFO - ******************************************************************************
2017-08-17 10:46:50,203 - octoprint.plugin.core - INFO - Loading plugins from c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins, C:\Users\Johnda\AppData\Roaming\OctoPrint\plugins and installed plugin packages...
2017-08-17 10:46:50,937 - octoprint.plugins.discovery - INFO - pybonjour is not installed, Zeroconf Discovery won't be available
2017-08-17 10:46:50,938 - octoprint.plugin.core - INFO - Found 9 plugin(s) providing 7 mixin implementations, 4 hook handlers
2017-08-17 10:46:51,186 - octoprint.plugin.core - INFO - Loading plugins from c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins, C:\Users\Johnda\AppData\Roaming\OctoPrint\plugins and installed plugin packages...
2017-08-17 10:46:51,309 - octoprint.plugin.core - INFO - Found 9 plugin(s) providing 7 mixin implementations, 4 hook handlers
2017-08-17 10:46:51,322 - octoprint.filemanager.storage - INFO - Initializing the file metadata for C:\Users\Johnda\AppData\Roaming\OctoPrint\uploads...
2017-08-17 10:46:51,322 - octoprint.filemanager.storage - INFO - ... file metadata for C:\Users\Johnda\AppData\Roaming\OctoPrint\uploads initialized successfully.
2017-08-17 10:46:51,338 - octoprint.plugins.softwareupdate - INFO - Loaded version cache from disk
2017-08-17 10:46:52,072 - octoprint.util.pip - INFO - Using "c:\OctoPrint\oct\Scripts\python.exe -m pip" as command to invoke pip
2017-08-17 10:46:52,796 - octoprint.util.pip - INFO - Version of pip is 9.0.1
2017-08-17 10:46:52,796 - octoprint.util.pip - INFO - pip installs to c:\OctoPrint\oct\Lib\site-packages, --user flag needed => no, virtual env => yes
2017-08-17 10:46:52,796 - octoprint.plugin.core - INFO - Initialized 7 plugin implementation(s)
2017-08-17 10:46:52,799 - octoprint.plugin.core - INFO - 9 plugin(s) registered with the system:
| Announcement Plugin (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\announcements
| Core Wizard (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\corewizard
| CuraEngine (<= 15.04) (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\cura
| Discovery (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\discovery
| !M33 Fio (1.21) = c:\OctoPrint\oct\lib\site-packages\octoprint_m33fio
| Plugin Manager (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\pluginmanager
| Software Update (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate
| Virtual Printer (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\virtual_printer
| !Yamlpatcher (0.1.1) = c:\OctoPrint\oct\lib\site-packages\octoprint_yamlpatcher
2017-08-17 10:46:52,799 - octoprint.filemanager - INFO - Adding backlog items from all storage types to analysis queue...
2017-08-17 10:46:52,801 - octoprint.filemanager - INFO - Added 0 items from storage type "local" to analysis queue
2017-08-17 10:46:52,805 - octoprint.server - INFO - Reset webasset folder C:\Users\Johnda\AppData\Roaming\OctoPrint\generated\webassets...
2017-08-17 10:46:52,855 - octoprint.server - INFO - Reset webasset folder C:\Users\Johnda\AppData\Roaming\OctoPrint\generated\.webassets-cache...
2017-08-17 10:46:53,191 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance on Johnda-PC for SSDP
2017-08-17 10:46:53,191 - octoprint.server - INFO - Listening on http://0.0.0.0:5000
2017-08-17 10:46:53,233 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid
2017-08-17 10:46:53,269 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'query_string': 'l10n=en', 'path': '/', 'base_url': 'http://localhost:5000/'}
2017-08-17 10:46:53,377 - octoprint.plugins.pluginmanager - INFO - Loaded notices from disk, was still valid
2017-08-17 10:46:56,513 - octoprint.server.util.sockjs - INFO - New connection from client: 127.0.0.1
2017-08-17 10:46:56,950 - octoprint.server.preemptive_cache - INFO - ... done in 3.68s
2017-08-17 10:47:54,201 - tornado.access - WARNING - 404 POST /api/plugin/m33fio (127.0.0.1) 4.00ms
2017-08-17 10:48:06,956 - octoprint.server.util.sockjs - INFO - Client connection closed: 127.0.0.1
2017-08-17 10:48:08,553 - octoprint.server.util.sockjs - INFO - New connection from client: 127.0.0.1
2017-08-17 10:48:08,928 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:48:18,588 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
2017-08-17 10:48:25,381 - octoprint.plugins.softwareupdate - INFO - Starting update of octoprint to 1.3.4...
2017-08-17 10:48:26,114 - octoprint.plugins.softwareupdate.updaters.update_script - ERROR - Target: octoprint, error while executing update script, got returncode 1
Traceback (most recent call last):
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate\updaters\update_script.py", line 88, in perform_update
caller.checked_call(update_command, cwd=folder)
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\util\commandline.py", line 69, in checked_call
raise CommandlineError(returncode, stdout, stderr)
CommandlineError
2017-08-17 10:48:26,115 - octoprint.plugins.softwareupdate - ERROR - Update of octoprint can not be performed
Traceback (most recent call last):
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate\__init__.py", line 823, in _perform_update
update_result = updater.perform_update(target, populated_check, target_version, log_cb=self._log)
File "c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate\updaters\update_script.py", line 91, in perform_update
raise UpdateError("Error while executing update script for %s", (e.stdout, e.stderr))
UpdateError
2017-08-17 10:56:17,914 - octoprint.server - INFO - Shutting down...
2017-08-17 10:56:18,499 - octoprint.events - INFO - Processing shutdown event, this will be our last event
2017-08-17 10:56:18,506 - octoprint.events - INFO - Event loop shut down
2017-08-17 10:56:18,543 - octoprint.server - INFO - Goodbye!
2017-08-17 10:57:00,144 - octoprint.server - INFO - ******************************************************************************
2017-08-17 10:57:00,144 - octoprint.server - INFO - Starting OctoPrint 0+unknown
2017-08-17 10:57:00,144 - octoprint.server - INFO - Starting in SAFE MODE. Third party plugins will be disabled!
2017-08-17 10:57:00,144 - octoprint.server - INFO - ******************************************************************************
2017-08-17 10:57:01,410 - octoprint.plugin.core - INFO - Loading plugins from c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins, C:\Users\Johnda\AppData\Roaming\OctoPrint\plugins and installed plugin packages...
2017-08-17 10:57:08,394 - octoprint.plugins.discovery - INFO - pybonjour is not installed, Zeroconf Discovery won't be available
2017-08-17 10:57:08,394 - octoprint.plugin.core - INFO - Found 9 plugin(s) providing 7 mixin implementations, 4 hook handlers
2017-08-17 10:57:08,801 - octoprint.plugin.core - INFO - Loading plugins from c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins, C:\Users\Johnda\AppData\Roaming\OctoPrint\plugins and installed plugin packages...
2017-08-17 10:57:08,924 - octoprint.plugin.core - INFO - Found 9 plugin(s) providing 7 mixin implementations, 4 hook handlers
2017-08-17 10:57:08,940 - octoprint.filemanager.storage - INFO - Initializing the file metadata for C:\Users\Johnda\AppData\Roaming\OctoPrint\uploads...
2017-08-17 10:57:08,940 - octoprint.filemanager.storage - INFO - ... file metadata for C:\Users\Johnda\AppData\Roaming\OctoPrint\uploads initialized successfully.
2017-08-17 10:57:08,979 - octoprint.plugins.softwareupdate - INFO - Loaded version cache from disk
2017-08-17 10:57:13,901 - octoprint.util.pip - INFO - Using "c:\OctoPrint\oct\Scripts\python.exe -m pip" as command to invoke pip
2017-08-17 10:57:14,637 - octoprint.util.pip - INFO - Version of pip is 9.0.1
2017-08-17 10:57:14,637 - octoprint.util.pip - INFO - pip installs to c:\OctoPrint\oct\Lib\site-packages, --user flag needed => no, virtual env => yes
2017-08-17 10:57:14,638 - octoprint.plugin.core - INFO - Initialized 7 plugin implementation(s)
2017-08-17 10:57:14,638 - octoprint.plugin.core - INFO - 9 plugin(s) registered with the system:
| Announcement Plugin (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\announcements
| Core Wizard (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\corewizard
| CuraEngine (<= 15.04) (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\cura
| Discovery (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\discovery
| !M33 Fio (1.21) = c:\OctoPrint\oct\lib\site-packages\octoprint_m33fio
| Plugin Manager (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\pluginmanager
| Software Update (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\softwareupdate
| Virtual Printer (bundled) = c:\OctoPrint\oct\lib\site-packages\octoprint-0+unknown-py2.7.egg\octoprint\plugins\virtual_printer
| !Yamlpatcher (0.1.1) = c:\OctoPrint\oct\lib\site-packages\octoprint_yamlpatcher
2017-08-17 10:57:14,640 - octoprint.filemanager - INFO - Adding backlog items from all storage types to analysis queue...
2017-08-17 10:57:14,641 - octoprint.filemanager - INFO - Added 0 items from storage type "local" to analysis queue
2017-08-17 10:57:14,644 - octoprint.server - INFO - Reset webasset folder C:\Users\Johnda\AppData\Roaming\OctoPrint\generated\webassets...
2017-08-17 10:57:14,686 - octoprint.server - INFO - Reset webasset folder C:\Users\Johnda\AppData\Roaming\OctoPrint\generated\.webassets-cache...
2017-08-17 10:57:15,822 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance on Johnda-PC for SSDP
2017-08-17 10:57:15,869 - octoprint.server - INFO - Listening on http://0.0.0.0:5000
2017-08-17 10:57:16,065 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid
2017-08-17 10:57:16,125 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'query_string': 'l10n=en', 'path': '/', 'base_url': 'http://localhost:5000/'}
2017-08-17 10:57:16,361 - octoprint.plugins.pluginmanager - INFO - Loaded notices from disk, was still valid
2017-08-17 10:57:16,714 - octoprint.server.util.sockjs - INFO - New connection from client: 127.0.0.1
2017-08-17 10:57:25,838 - octoprint.server.preemptive_cache - INFO - ... done in 9.71s
2017-08-17 10:59:11,440 - octoprint.plugins.cura - INFO - Path to CuraEngine has not been configured yet or does not exist (currently set to None), Cura will not be selectable for slicing
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment