[Solved?] OctoPrint pausing when I try to print


#1

When I try to print anything. OctoPrint will pause. Just like the bug in 1.3.8

I have disabled log position on pause and log position on resume.

OctoPrint version 1.3.9

OctoPi version 0.15.1

Creality cr-10s

Log

2018-09-20 06:29:05,393 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 06:29:05,405 - octoprint.server - INFO - --- Log roll over detected ---------------------------------------------------

2018-09-20 06:29:05,406 - octoprint.server - INFO - OctoPrint 1.3.9

2018-09-20 06:29:05,409 - octoprint.plugin.core - INFO - 15 plugin(s) registered with the system:

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

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

| Bed Leveling Plugin (2.1.1) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_CR10_Leveling

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

| CuraEngine (<= 15.04) (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/cura

| Detailed Progress Plugin (0.1.4) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_detailedprogress

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

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

| M73-Progress-Plugin (0.1.0) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_m73progress

| Nautilus (1.20) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_nautilus

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

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

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

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

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

2018-09-20 06:29:05,436 - octoprint.environment - INFO - Detected environment is Python 2.7.13 under Linux (linux2). Details:

| hardware:

| cores: 4

| freq: 1400.0

| ram: 918192128

| os:

| id: linux

| platform: linux2

| plugins:

| octopi_support:

| model: unknown

| revision: a020d3

| version: 0.15.1

| python:

| pip: 10.0.1

| version: 2.7.13

| virtualenv: /home/pi/oprint

2018-09-20 06:29:05,437 - octoprint.server - INFO - ------------------------------------------------------------------------------

2018-09-20 06:43:30,891 - octoprint.plugins.discovery - WARNING - Can't determine address to user for client ('10.1.1.85', 57708), not sending a M-SEARCH reply

2018-09-20 06:44:05,395 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 06:59:05,397 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 07:14:05,399 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 07:29:05,400 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 07:44:05,404 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 07:59:05,406 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 08:14:05,408 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 08:29:05,412 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 08:44:05,414 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 08:53:36,650 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:10.1.1.183

2018-09-20 08:53:46,322 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:10.1.1.183

2018-09-20 08:59:05,417 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 09:14:05,419 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 09:29:05,422 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 09:44:05,423 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 09:59:05,425 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 10:14:05,426 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 10:29:05,429 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 10:44:05,432 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 10:59:05,435 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 11:14:05,438 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 11:29:05,440 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 11:44:05,443 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 11:59:05,446 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 12:14:05,448 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 12:29:05,451 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 12:44:05,453 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 12:53:01,113 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:10.1.1.183

2018-09-20 12:53:04,356 - octoprint.plugins.announcements - INFO - Loaded channel _important from https://octoprint.org/feeds/important.xml in 1.8s

2018-09-20 12:53:06,195 - octoprint.plugins.announcements - INFO - Loaded channel _releases from https://octoprint.org/feeds/releases.xml in 1.5s

2018-09-20 12:53:07,946 - octoprint.plugins.announcements - INFO - Loaded channel _blog from https://octoprint.org/feeds/octoblog.xml in 1.6s

2018-09-20 12:53:09,971 - octoprint.plugins.announcements - INFO - Loaded channel _plugins from https://plugins.octoprint.org/feed.xml in 1.9s

2018-09-20 12:53:11,752 - octoprint.plugins.announcements - INFO - Loaded channel _octopi from https://octoprint.org/feeds/octopi.xml in 1.6s

2018-09-20 12:53:12,375 - octoprint.util.comm - INFO - Changing monitoring state from "Printing" to "Cancelling"

2018-09-20 12:53:12,390 - octoprint.filemanager.analysis - INFO - Starting analysis of local:deadpool.gcode

2018-09-20 12:53:12,396 - octoprint.filemanager.analysis - INFO - Invoking analysis command: /home/pi/oprint/bin/python2 -m octoprint analysis gcode --speed-x=6000 --speed-y=6000 --max-t=10 --throttle=0.0 --throttle-lines=100 /home/pi/.octoprint/uploads/deadpool.gcode

2018-09-20 12:53:12,437 - octoprint.plugins.detailedprogress - INFO - Printing stopped. Detailed progress stopped.

2018-09-20 12:53:15,559 - octoprint.util.comm - INFO - Changing monitoring state from "Cancelling" to "Operational"

2018-09-20 12:53:15,570 - octoprint.plugins.detailedprogress - INFO - Printing stopped. Detailed progress stopped.

2018-09-20 12:53:15,574 - octoprint.plugins.nautilus - INFO - >>>> Sending notification type [error] to 3 device(s)

2018-09-20 12:55:20,061 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:10.1.1.183

2018-09-20 12:57:16,405 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:10.1.1.183

2018-09-20 12:57:26,762 - octoprint.server.api.system - INFO - Performing command for core:shutdown: sudo shutdown -h now

2018-09-20 12:57:27,006 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:10.1.1.183

2018-09-20 12:57:27,296 - octoprint.server - INFO - Shutting down...

2018-09-20 12:57:28,075 - octoprint.events - INFO - Processing shutdown event, this will be our last event

2018-09-20 12:57:28,077 - octoprint.events - INFO - Event loop shut down

2018-09-20 12:57:28,552 - octoprint.server - INFO - Goodbye!

2018-09-20 12:57:41,274 - octoprint.startup - INFO - ******************************************************************************

2018-09-20 12:57:41,279 - octoprint.startup - INFO - Starting OctoPrint 1.3.9

2018-09-20 12:57:41,284 - octoprint.startup - INFO - ******************************************************************************

2018-09-20 12:57:41,481 - octoprint.util.connectivity_checker - INFO - Connectivity changed from offline to online

2018-09-20 12:57:44,186 - octoprint.startup - INFO - Blacklist processing done

2018-09-20 12:57:44,293 - octoprint.plugin.core - INFO - Loading plugins from /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins, /home/pi/.octoprint/plugins and installed plugin packages...

2018-09-20 12:57:48,616 - octoprint.plugin.core - INFO - Found 15 plugin(s) providing 15 mixin implementations, 15 hook handlers

2018-09-20 12:57:48,855 - octoprint.server.heartbeat - INFO - Starting server heartbeat, 900.0s interval

2018-09-20 12:57:48,932 - octoprint.server - INFO - Intermediary server started

2018-09-20 12:57:48,934 - octoprint.plugin.core - INFO - Loading plugins from /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins, /home/pi/.octoprint/plugins and installed plugin packages...

2018-09-20 12:57:50,194 - octoprint.plugin.core - INFO - Found 15 plugin(s) providing 15 mixin implementations, 15 hook handlers

2018-09-20 12:57:50,279 - octoprint.filemanager.storage - INFO - Initializing the file metadata for /home/pi/.octoprint/uploads...

2018-09-20 12:57:51,956 - octoprint.filemanager.storage - INFO - ... file metadata for /home/pi/.octoprint/uploads initialized successfully.

2018-09-20 12:57:52,003 - octoprint.plugins.nautilus - INFO - 3 device(s) will receive notifications...

2018-09-20 12:57:52,004 - octoprint.plugins.nautilus - INFO - Nautilus for OctoPrint, started.

2018-09-20 12:57:52,311 - octoprint.plugins.softwareupdate - INFO - Loaded version cache from disk

2018-09-20 12:57:56,124 - octoprint.util.pip - INFO - Using "/home/pi/oprint/bin/python2 -m pip" as command to invoke pip

2018-09-20 12:57:59,214 - octoprint.util.pip - INFO - Version of pip is 10.0.1

2018-09-20 12:57:59,217 - octoprint.util.pip - INFO - pip installs to /home/pi/oprint/lib/python2.7/site-packages (writable -> yes), --user flag needed -> no, virtual env -> yes

2018-09-20 12:57:59,219 - octoprint.util.pip - INFO - ==> pip ok -> yes

2018-09-20 12:57:59,226 - octoprint.plugin.core - INFO - Initialized 15 plugin implementation(s)

2018-09-20 12:57:59,252 - octoprint.plugin.core - INFO - 15 plugin(s) registered with the system:

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

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

| Bed Leveling Plugin (2.1.1) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_CR10_Leveling

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

| CuraEngine (<= 15.04) (bundled) = /home/pi/oprint/lib/python2.7/site-packages/octoprint/plugins/cura

| Detailed Progress Plugin (0.1.4) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_detailedprogress

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

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

| M73-Progress-Plugin (0.1.0) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_m73progress

| Nautilus (1.20) = /home/pi/oprint/local/lib/python2.7/site-packages/octoprint_nautilus

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

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

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

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

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

2018-09-20 12:57:59,296 - octoprint.environment - INFO - Detected environment is Python 2.7.13 under Linux (linux2). Details:

| hardware:

| cores: 4

| freq: 1400.0

| ram: 918192128

| os:

| id: linux

| platform: linux2

| plugins:

| octopi_support:

| model: unknown

| revision: a020d3

| version: 0.15.1

| python:

| pip: 10.0.1

| version: 2.7.13

| virtualenv: /home/pi/oprint

2018-09-20 12:57:59,318 - octoprint.server - INFO - Reset webasset folder /home/pi/.octoprint/generated/webassets...

2018-09-20 12:57:59,351 - octoprint.server - INFO - Reset webasset folder /home/pi/.octoprint/generated/.webassets-cache...

2018-09-20 12:57:59,820 - octoprint.server - INFO - Shutting down intermediary server...

2018-09-20 12:58:00,023 - octoprint.server - INFO - Intermediary server shut down

2018-09-20 12:58:00,028 - octoprint.events - INFO - Processing startup event, this is our first event

2018-09-20 12:58:00,029 - octoprint.events - INFO - Adding 1 events to queue that were held back before startup event

2018-09-20 12:58:00,037 - octoprint.filemanager - INFO - Adding backlog items from all storage types to analysis queue...

2018-09-20 12:58:00,104 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid

2018-09-20 16:52:58,232 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 16:52:58,266 - octoprint.filemanager.analysis - INFO - Starting analysis of local:deadpool.gcode

2018-09-20 16:52:58,271 - octoprint.filemanager.analysis - INFO - Invoking analysis command: /home/pi/oprint/bin/python2 -m octoprint analysis gcode --speed-x=6000 --speed-y=6000 --max-t=10 --throttle=0.01 --throttle-lines=100 /home/pi/.octoprint/uploads/deadpool.gcode

2018-09-20 16:52:58,276 - octoprint.filemanager - INFO - Added 1 items from storage type "local" to analysis queue

2018-09-20 16:52:58,937 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance on octopi for _http._tcp

2018-09-20 16:52:58,964 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance on octopi for _octoprint._tcp

2018-09-20 16:52:58,978 - octoprint.plugins.discovery - INFO - Registered OctoPrint instance on octopi for SSDP

2018-09-20 16:52:59,005 - octoprint.server - INFO - Listening on http://127.0.0.1:5000

2018-09-20 16:52:59,016 - octoprint.plugins.nautilus - INFO - Logging level is INFO.

2018-09-20 16:52:59,020 - octoprint.plugins.nautilus - INFO - M117 message will be ignored (Detailed Progress plugin)...

2018-09-20 16:52:59,347 - octoprint.plugins.pluginmanager - INFO - Loaded plugin repository data from disk, was still valid

2018-09-20 16:53:00,469 - octoprint.server.preemptive_cache - INFO - Preemptively caching / (ui _default) for {'query_string': 'l10n=en', 'path': '/', 'base_url': 'http://10.1.1.82/'}

2018-09-20 16:53:00,507 - octoprint.plugins.pluginmanager - INFO - Loaded plugin notices data from https://plugins.octoprint.org/notices.json

2018-09-20 16:53:02,244 - octoprint.plugins.pluginmanager - INFO - Loaded plugin notices data from https://plugins.octoprint.org/notices.json

2018-09-20 16:53:07,400 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:10.1.1.115

2018-09-20 16:53:15,596 - octoprint.util.comm - INFO - Changing monitoring state from "Offline" to "Detecting serial port"

2018-09-20 16:53:15,929 - octoprint.util.comm - INFO - Changing monitoring state from "Detecting serial port" to "Opening serial port"

2018-09-20 16:53:15,996 - octoprint.util.comm - INFO - Changing monitoring state from "Opening serial port" to "Detecting baudrate"

2018-09-20 16:53:17,024 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0

2018-09-20 16:53:17,034 - octoprint.util.comm - INFO - Changing monitoring state from "Detecting baudrate" to "Operational"

2018-09-20 16:53:17,054 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0

2018-09-20 16:53:23,027 - octoprint.util.comm - INFO - Got a resend request from the printer: requested line = 1, current line = 3

| Last lines in terminal:

| Recv: echo: G29 S3 X3 Y4 Z-0.24000

| Recv: echo: G29 S3 X4 Y4 Z-0.24000

| Recv: echo: G29 S3 X5 Y4 Z-0.31500

| Recv: echo: G29 S3 X1 Y5 Z-0.09000

| Recv: echo: G29 S3 X2 Y5 Z0.00000

| Recv: echo: G29 S3 X3 Y5 Z-0.18000

| Recv: echo: G29 S3 X4 Y5 Z-0.16500

| Recv: echo: G29 S3 X5 Y5 Z-0.16500

| Recv: echo:Material heatup parameters:

| Recv: echo: M145 S0 H200 B60 F0

| Recv: echo: M145 S1 H240 B80 F0

| Recv: echo:PID settings:

| Recv: echo: M301 P19.56 I1.57 D60.88

| Recv: echo:SD card ok

| Recv: ok

| Send: N1 M115*39

| Recv: ok

| Send: N2 M21*18

| Recv: Error:Line Number is not Last Line Number+1, Last Line: 0

| Recv: Resend: 1

2018-09-20 16:53:23,035 - octoprint.util.comm - INFO - Printer reports firmware name "Marlin 1.1.8 (Github)"

2018-09-20 16:54:01,351 - octoprint.server.preemptive_cache - INFO - ... done in 60.88s

2018-09-20 16:54:31,286 - octoprint.filemanager.analysis - INFO - Starting analysis of local:deadpool.gcode

2018-09-20 16:54:31,291 - octoprint.filemanager.analysis - INFO - Invoking analysis command: /home/pi/oprint/bin/python2 -m octoprint analysis gcode --speed-x=6000 --speed-y=6000 --max-t=10 --throttle=0.0 --throttle-lines=100 /home/pi/.octoprint/uploads/deadpool.gcode

2018-09-20 16:54:45,597 - octoprint.util.comm - INFO - Changing monitoring state from "Operational" to "Printing"

2018-09-20 16:54:45,619 - octoprint.plugins.detailedprogress - INFO - Printing started. Detailed progress started.

2018-09-20 16:54:45,626 - octoprint.util.comm - INFO - M110 detected, setting current line number to 0

2018-09-20 16:54:47,808 - octoprint.util.comm - INFO - Printer seems to support the busy protocol, telling it to set the busy interval to our "communicationBusy" timeout - 1s = 2s

2018-09-20 16:55:16,855 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:10.1.1.115

2018-09-20 16:59:15,047 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:10.1.1.183

2018-09-20 17:01:50,752 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:10.1.1.183

2018-09-20 17:01:52,678 - tornado.access - WARNING - 403 GET /api/plugin/octopi_support (::ffff:10.1.1.183) 20.97ms

2018-09-20 17:01:52,740 - tornado.access - WARNING - 403 GET /api/printerprofiles (::ffff:10.1.1.183) 18.42ms

2018-09-20 17:01:52,774 - tornado.access - WARNING - 403 GET /api/timelapse?unrendered=true (::ffff:10.1.1.183) 20.21ms

2018-09-20 17:01:52,807 - tornado.access - WARNING - 403 GET /api/connection (::ffff:10.1.1.183) 23.99ms

2018-09-20 17:01:52,840 - tornado.access - WARNING - 403 GET /api/printer/command/custom (::ffff:10.1.1.183) 18.11ms

2018-09-20 17:01:52,872 - tornado.access - WARNING - 403 GET /api/slicing (::ffff:10.1.1.183) 23.11ms

2018-09-20 17:01:52,901 - tornado.access - WARNING - 403 GET /api/system/commands (::ffff:10.1.1.183) 18.50ms

2018-09-20 17:01:52,929 - tornado.access - WARNING - 403 GET /api/settings (::ffff:10.1.1.183) 18.11ms

2018-09-20 17:01:52,960 - tornado.access - WARNING - 403 GET /api/files?recursive=true (::ffff:10.1.1.183) 21.25ms

2018-09-20 17:01:52,992 - tornado.access - WARNING - 403 GET /api/users (::ffff:10.1.1.183) 20.70ms

2018-09-20 17:01:54,082 - tornado.access - WARNING - 403 GET /api/plugin/action_command_prompt (::ffff:10.1.1.183) 22.14ms

2018-09-20 17:01:54,111 - tornado.access - WARNING - 403 GET /api/plugin/printer_safety_check (::ffff:10.1.1.183) 19.68ms

2018-09-20 17:01:54,137 - tornado.access - WARNING - 403 GET /plugin/softwareupdate/check (::ffff:10.1.1.183) 16.65ms

2018-09-20 17:01:54,189 - tornado.access - WARNING - 403 GET /api/plugin/pluginmanager (::ffff:10.1.1.183) 18.43ms

2018-09-20 17:01:54,240 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:10.1.1.183

2018-09-20 17:01:59,503 - tornado.access - WARNING - 403 GET /plugin/announcements/channels (::ffff:10.1.1.183) 16.43ms

2018-09-20 17:07:58,234 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 17:19:07,991 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:10.1.1.183

2018-09-20 17:19:16,091 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:10.1.1.183

2018-09-20 17:19:27,519 - octoprint.server.util.sockjs - WARNING - Could not send message to client ::ffff:10.1.1.183: 'NoneType' object has no attribute 'send_pack'

2018-09-20 17:19:27,527 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:10.1.1.183

2018-09-20 17:22:58,237 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 17:31:50,294 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:10.1.1.183

2018-09-20 17:32:00,798 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:10.1.1.183

2018-09-20 17:37:58,238 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 17:52:58,240 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 18:07:58,242 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 18:22:58,244 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 18:37:58,246 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 18:52:58,247 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 19:07:58,249 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 19:22:58,251 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 19:37:58,254 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 19:52:58,256 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 20:07:58,258 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 20:22:58,260 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 20:31:55,880 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:10.1.1.183

2018-09-20 20:32:55,802 - octoprint.server.util.sockjs - WARNING - Could not send message to client ::ffff:10.1.1.183: 'NoneType' object has no attribute 'send_pack'

2018-09-20 20:32:55,809 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:10.1.1.183

2018-09-20 20:33:30,193 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:10.1.1.183

2018-09-20 20:33:30,512 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:10.1.1.183

2018-09-20 20:33:30,924 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:10.1.1.183

2018-09-20 20:33:34,428 - octoprint.plugins.announcements - INFO - Loaded channel _important from https://octoprint.org/feeds/important.xml in 2.0s

2018-09-20 20:33:36,528 - octoprint.plugins.announcements - INFO - Loaded channel _releases from https://octoprint.org/feeds/releases.xml in 1.6s

2018-09-20 20:33:38,199 - octoprint.plugins.announcements - INFO - Loaded channel _blog from https://octoprint.org/feeds/octoblog.xml in 1.5s

2018-09-20 20:33:40,119 - octoprint.plugins.announcements - INFO - Loaded channel _plugins from https://plugins.octoprint.org/feed.xml in 1.8s

2018-09-20 20:33:42,018 - octoprint.plugins.announcements - INFO - Loaded channel _octopi from https://octoprint.org/feeds/octopi.xml in 1.7s

2018-09-20 20:35:51,462 - octoprint.util.comm - INFO - Changing monitoring state from "Printing" to "Cancelling"

2018-09-20 20:35:51,472 - octoprint.filemanager.analysis - INFO - Starting analysis of local:deadpool.gcode

2018-09-20 20:35:51,483 - octoprint.filemanager.analysis - INFO - Invoking analysis command: /home/pi/oprint/bin/python2 -m octoprint analysis gcode --speed-x=6000 --speed-y=6000 --max-t=10 --throttle=0.0 --throttle-lines=100 /home/pi/.octoprint/uploads/deadpool.gcode

2018-09-20 20:35:51,534 - octoprint.plugins.detailedprogress - INFO - Printing stopped. Detailed progress stopped.

2018-09-20 20:35:54,902 - octoprint.plugins.detailedprogress - INFO - Printing stopped. Detailed progress stopped.

2018-09-20 20:35:54,905 - octoprint.plugins.nautilus - INFO - >>>> Sending notification type [error] to 3 device(s)

2018-09-20 20:37:58,263 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 20:40:05,723 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:10.1.1.183

2018-09-20 20:45:01,860 - octoprint.filemanager.analysis - INFO - Analysis of entry local:deadpool.gcode finished, needed 550.39s

2018-09-20 20:52:58,265 - octoprint.server.heartbeat - INFO - Server heartbeat <3

2018-09-20 20:54:35,639 - tornado.access - WARNING - 403 GET /api/printerprofiles (::ffff:10.1.1.183) 23.91ms

2018-09-20 20:54:35,670 - tornado.access - WARNING - 403 GET /api/settings (::ffff:10.1.1.183) 22.92ms

2018-09-20 20:54:35,689 - tornado.access - WARNING - 403 GET /api/slicing (::ffff:10.1.1.183) 10.93ms

2018-09-20 20:54:35,705 - tornado.access - WARNING - 403 GET /api/timelapse?unrendered=true (::ffff:10.1.1.183) 12.16ms

2018-09-20 20:54:35,716 - tornado.access - WARNING - 404 GET /apple-touch-icon-120x120-precomposed.png (::ffff:10.1.1.183) 6.19ms

2018-09-20 20:54:35,730 - tornado.access - WARNING - 403 GET /plugin/softwareupdate/check (::ffff:10.1.1.183) 10.09ms

2018-09-20 20:54:35,745 - tornado.access - WARNING - 403 GET /plugin/announcements/channels (::ffff:10.1.1.183) 10.09ms

2018-09-20 20:54:35,765 - tornado.access - WARNING - 403 GET /api/plugin/pluginmanager (::ffff:10.1.1.183) 15.72ms

2018-09-20 20:54:35,793 - tornado.access - WARNING - 404 GET /apple-touch-icon-120x120.png (::ffff:10.1.1.183) 11.85ms

2018-09-20 20:54:35,853 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:10.1.1.183

2018-09-20 20:57:41,307 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:10.1.1.183

2018-09-20 21:01:34,367 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:10.1.1.183

2018-09-20 21:01:50,987 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:10.1.1.183

2018-09-20 21:06:00,484 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:10.1.1.140

2018-09-20 21:06:13,218 - octoprint.server.util.sockjs - INFO - Client connection closed: ::ffff:10.1.1.140

Sent from Mail for Windows 10


#2

Try it in Safe Mode and see if it's happier. If so, then troubleshoot your plugins.


#3

I reinstalled OctoPrint and it failed. Bad memory card. Tried another memory card. Installed fine.
Installed Detailed Progress and Nautilus add-on.
Tried a 6 hour print. Paused again after 5 hours.
Am trying again with those addons removed.


#4

When you determine whether or not a particular plugin is causing problems, please report back here your findings. I'm sure everyone would like to know.


#5

Completed a 6 hour print. No pausing.
Now trying with just nautilus installed.


#6

No pause with just nautilus installed.


#7

It's starting to sound like Detailed Progress. If it were me, I'd go add an issue to their repository to tell them of your findings.


#8

I installed Detailed Progress and it didn't pause???


#9

Make sure you're using the same part, right? The pausing is a known issue for delta printers (since the Arduino board inside the printer needs to do a lot of conversions) and for even cartesian printers in some cases.

(It's also entirely possible that the code in your Detailed Progress plugin was updated since the last time you installed it.)