Failed firing before Cancelled

octoprint.log

2017-03-25 17:45:45,501 - octoprint.server - INFO - Starting OctoPrint 1.3.2 (master branch)
2017-03-25 17:45:45,501 - octoprint.server - INFO - ******************************************************************************
2017-03-25 17:45:45,568 - octoprint.plugin.core - INFO - Loading plugins from /home/pi/oprint/lib/python2.7/site-packages/OctoPrint-1.3.2-py2.7.egg/octoprint/plugins, /home/pi/.octoprint/plugins and installed plugin packages...
2017-03-25 17:45:47,039 - octoprint.plugin.core - INFO - Found 10 plugin(s) providing 10 mixin implementations, 8 hook handlers
2017-03-25 17:45:47,053 - octoprint.plugin.core - INFO - Loading plugins from /home/pi/oprint/lib/python2.7/site-packages/OctoPrint-1.3.2-py2.7.egg/octoprint/plugins, /home/pi/.octoprint/plugins and installed plugin packages...
2017-03-25 17:45:47,311 - octoprint.plugin.core - INFO - Found 10 plugin(s) providing 10 mixin implementations, 8 hook handlers
2017-03-25 17:45:47,317 - octoprint.filemanager.storage - INFO - Initializing the file metadata for /home/pi/.octoprint/uploads...
2017-03-25 17:45:47,388 - octoprint.filemanager.storage - INFO - ... file metadata for /home/pi/.octoprint/uploads initialized successfully.
2017-03-25 17:45:47,457 - octoprint.plugins.softwareupdate - INFO - Loaded version cache from disk
2017-03-25 17:45:49,830 - octoprint.util.pip - INFO - Using "/home/pi/oprint/bin/python -m pip" as command to invoke pip
2017-03-25 17:45:52,202 - octoprint.util.pip - INFO - Version of pip is 9.0.1
2017-03-25 17:45:52,203 - octoprint.util.pip - INFO - pip installs to /home/pi/oprint/lib/python2.7/site-packages, --user flag needed => no, virtual env => yes
2017-03-25 17:45:52,215 - octoprint.plugin.core - INFO - Initialized 10 plugin implementation(s)
2017-03-25 17:45:52,221 - octoprint.plugin.core - INFO - 10 plugin(s) registered with the system:
|  Announcement Plugin (bundled) = /home/pi/oprint/lib/python2.7/site-packages/OctoPrint-1.3.2-py2.7.egg/octoprint/plugins/announcements
|  Core Wizard (bundled) = /home/pi/oprint/lib/python2.7/site-packages/OctoPrint-1.3.2-py2.7.egg/octoprint/plugins/corewizard
|  CuraEngine (<= 15.04) (bundled) = /home/pi/oprint/lib/python2.7/site-packages/OctoPrint-1.3.2-py2.7.egg/octoprint/plugins/cura
|  Discovery (bundled) = /home/pi/oprint/lib/python2.7/site-packages/OctoPrint-1.3.2-py2.7.egg/octoprint/plugins/discovery
|  Fullscreen Plugin (0.0.1) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_fullscreen
|  TestPlugin (0.1.0) = /home/pi/.octoprint/plugins/OctoPrint-TestPlugin/octoprint_TestPlugin
|  Plugin Manager (bundled) = /home/pi/oprint/lib/python2.7/site-packages/OctoPrint-1.3.2-py2.7.egg/octoprint/plugins/pluginmanager
|  Software Update (bundled) = /home/pi/oprint/lib/python2.7/site-packages/OctoPrint-1.3.2-py2.7.egg/octoprint/plugins/softwareupdate
|  TouchUI (0.3.6) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_touchui
|  Virtual Printer (bundled) = /home/pi/oprint/lib/python2.7/site-packages/OctoPrint-1.3.2-py2.7.egg/octoprint/plugins/virtual_printer
2017-03-25 17:45:52,222 - octoprint.filemanager - INFO - Adding backlog items from all storage types to analysis queue...
2017-03-25 17:45:52,231 - octoprint.filemanager - INFO - Added 0 items from storage type "local" to analysis queue
2017-03-25 17:45:52,234 - octoprint.server - INFO - Reset webasset folder /home/pi/.octoprint/generated/webassets...
2017-03-25 17:45:52,248 - octoprint.server - INFO - Reset webasset folder /home/pi/.octoprint/generated/.webassets-cache...
2017-03-25 17:45:52,617 - octoprint.plugins.TestPlugin - INFO - Event: Startup, Payload: {}
2017-03-25 17:45:52,691 - octoprint.plugins.TestPlugin - INFO - Event: Connecting, Payload: {}
2017-03-25 17:45:52,761 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance "Original Prusa i3 MK2" for _http._tcp
2017-03-25 17:45:52,772 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance "Original Prusa i3 MK2" for _octoprint._tcp
2017-03-25 17:45:52,775 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance "Original Prusa i3 MK2" for SSDP
2017-03-25 17:45:52,794 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid
2017-03-25 17:45:52,818 - octoprint.server - INFO - Listening on http://127.0.0.1:5000
2017-03-25 17:45:52,888 - octoprint.server - INFO - Preemptively caching / (ui _default) for {'query_string': 'l10n=en', 'path': '/', 'base_url': 'http://octopi.local/'}
2017-03-25 17:45:55,303 - octoprint.plugins.TestPlugin - INFO - Event: Connected, Payload: {'baudrate': 115200, 'port': '/dev/ttyACM0'}
2017-03-25 17:45:56,288 - octoprint.util.comm - INFO - Printer reports firmware name "Marlin V1.0.2; Sprinter/grbl mashup for gen6"
2017-03-25 17:45:56,744 - octoprint.server.util.sockjs - INFO - New connection from client: 192.168.1.52
2017-03-25 17:46:03,846 - octoprint.server.util.sockjs - INFO - Client connection closed: 192.168.1.52
2017-03-25 17:46:06,051 - octoprint.server.util.sockjs - INFO - New connection from client: 192.168.1.52
2017-03-25 17:46:07,638 - octoprint.server.util.sockjs - INFO - New connection from client: 192.168.1.52
2017-03-25 17:46:10,089 - octoprint.plugins.TestPlugin - INFO - Event: PrintStarted, Payload: {'origin': 'local', 'path': u'test.gcode', 'name': u'test.gcode', 'file': u'/home/pi/.octoprint/uploads/test.gcode', 'filename': u'test.gcode'}
2017-03-25 17:46:17,601 - octoprint.plugins.TestPlugin - INFO - Event: PrintFailed, Payload: {'origin': 'local', 'path': u'test.gcode', 'name': u'test.gcode', 'file': u'/home/pi/.octoprint/uploads/test.gcode', 'filename': u'test.gcode'}
2017-03-25 17:47:19,081 - octoprint.plugins.TestPlugin - INFO - Event: PrintCancelled, Payload: {'origin': 'local', 'name': u'test.gcode', 'filename': u'test.gcode', 'file': u'/home/pi/.octoprint/uploads/test.gcode', 'position': {'e': 0.0, 't': 0, 'f': None, 'y': 0.0, 'x': 0.0, 'z': 0.0}, 'path': u'test.gcode'}