Octoprint will not remain paused

What is the problem?
I am unable to keep OctoPrint paused (using the M0 command) when printing a complex part (approx 8MB Gcode file) to insert a component into the part. The amount of time the printer remains paused appears to be random. The last time that this happened, the printer remained paused for approximately 2 minutes before automatically resuming while I was half way inserting the components into the printed part.

What did you already try to solve it?

  • Added M0 as a "Long Running Command" in OctoPrint - Seems to have helped keep stepper motors on while paused.
  • Done a number to pause test prints, trialing if adding M85 S3600 (extending the inactive time of the printer) would make a difference - did not make a difference.
  • Numerous tests with gcode specifically to test pausing (a small square with a pause every 5 layers) - the printer behaves fine in this case, will pause up to 30 minutes consistently until timeout which is different behaviour to the part I am trying to print.

Logs (octoprint.log, serial.log or output on terminal tab at a minimum, browser error console if UI issue ... no logs, no support!)
octoprint.log (108.0 KB)

Log attached, the failed pause is at 2020-01-03 05:41:54
Running successful pause test from 2020-01-03 10:33:03

Additional information about your setup (OctoPrint version, OctoPi version, printer, firmware, browser, operating system, ... as much data as possible)

OctoPrint 1.3.12
Enclosure Plugin
Telegram Plugin
Control via OctoRemote
Prusa i3 Mk3s 3.8.1 Firmware

Gcode extract which is failing:

;TYPE:CUSTOM
;added code by post processing
;script: PauseAtHeight.py
;current layer: 190
M83 ; switch to relative E values for any needed retraction
G1 F1500 E-1
G1 F300 Z58.3 ; move up a millimeter to get out of the way
G1 F9000 X245 Y205
M104 S0 ; standby temperature
M0 ; Do the actual pause
M109 S245 ; resume temperature
G1 F1500 E1
G1 F199.998 E1.5
G1 F1500 E-1
G1 F9000 X8 Y8
G1 F300 Z57.3 ; move back down to resume height
G1 F1500 E1
G1 F4800 ; restore extrusion feedrate
M82 ; switch back to absolute E values
G92 E166.98357

Gcode which works:

;TYPE:CUSTOM
;added code by post processing
;script: PauseAtHeight.py
;current layer: 5
M83 ; switch to relative E values for any needed retraction
G1 F300 Z2.8 ; move up a millimeter to get out of the way
G1 F9000 X190 Y190
G1 F300 Z15 ; too close to bed--move to at least 15mm
M104 S0 ; standby temperature
M117 Paused next 8
M0 ; Do the actual pause
M109 S245 ; resume temperature
G1 F300 Z2.8
G1 F9000 X8 Y8
G1 F300 Z1.8 ; move back down to resume height
G1 F1800 ; restore extrusion feedrate
M82 ; switch back to absolute E values
G92 E286.03857
;TYPE:CUSTOM
;added code by post processing
;script: PauseAtHeight.py
;current layer: 8
M83 ; switch to relative E values for any needed retraction
G1 F300 Z3.7 ; move up a millimeter to get out of the way
G1 F9000 X190 Y190
G1 F300 Z15 ; too close to bed--move to at least 15mm
M104 S0 ; standby temperature
M117 paused next 10
M0 ; Do the actual pause
M109 S245 ; resume temperature
G1 F300 Z3.7
G1 F9000 X8 Y8
G1 F300 Z2.7 ; move back down to resume height
G1 F1800 ; restore extrusion feedrate
M82 ; switch back to absolute E values
G92 E448.84635
;TYPE:CUSTOM
;added code by post processing
;script: PauseAtHeight.py
;current layer: 10
M83 ; switch to relative E values for any needed retraction
G1 F300 Z4.3 ; move up a millimeter to get out of the way
G1 F9000 X190 Y190
G1 F300 Z15 ; too close to bed--move to at least 15mm
M104 S0 ; standby temperature
M117 paused next 13
M0 ; Do the actual pause
M109 S245 ; resume temperature
G1 F300 Z4.3
G1 F9000 X8 Y8
G1 F300 Z3.3 ; move back down to resume height
G1 F1800 ; restore extrusion feedrate
M82 ; switch back to absolute E values
G92 E557.38565

I don't have any experience with pausing a print but I read M25 works.
You might try it :slight_smile:

Possibly useful reading.

1 Like

Thanks for the suggestion, I had looked into M25, but according to the Prusa Gcode commands, it only works with an SD card print.

Thanks for the info, but I'm trying to initiate the pause through Gcode, and I'm not looking for the printer to pause for hours. 30 minutes is enough time.

I might add that printing the file from an SD card, the behavior is fine. It only happens when using Octoprint.

Any other ideas??

Tried the print again and this time the printer again only paused for about 7 minutes or so. I recorded a serial log this time.

Any ideas what's going on here? I didn't see anything coming from the Prusa printer in the serial log below is the communication around the pause (the log file was too large to upload)

2020-01-04 01:47:02,299 - Recv: ok T:245.6 /245.0 B:104.8 /105.0 T0:245.6 /245.0 @:30 B@:85 P:75.1 A:54.3
2020-01-04 01:47:02,309 - Send: N79168 G0 F10800 X197.35 Y91.296 Z3*51
2020-01-04 01:47:02,323 - Recv: ok
2020-01-04 01:47:02,329 - Send: N79169 G0 X80.875 Y67.675*47
2020-01-04 01:47:02,721 - Recv: ok
2020-01-04 01:47:02,728 - Send: N79170 M83*16
2020-01-04 01:47:02,733 - Recv: ok
2020-01-04 01:47:02,740 - Send: N79171 G1 F1500 E-2*57
2020-01-04 01:47:02,750 - Recv: ok
2020-01-04 01:47:02,756 - Send: N79172 G1 F300 Z4*57
2020-01-04 01:47:03,253 - Recv: ok
2020-01-04 01:47:03,260 - Send: N79173 G1 F9000 X240 Y200*73
2020-01-04 01:47:04,478 - Recv: ok
2020-01-04 01:47:04,486 - Send: N79174 G1 F300 Z15*15
2020-01-04 01:47:04,712 - Recv: ok
2020-01-04 01:47:04,719 - Send: N79175 M104 S0*104
2020-01-04 01:47:04,728 - Recv: ok
2020-01-04 01:47:04,734 - Changing monitoring state from "Printing" to "Pausing"
2020-01-04 01:47:04,749 - Send: N79176 M400*41
2020-01-04 01:47:04,761 - Send: N79177 M114*40
2020-01-04 01:47:06,857 - Recv: echo:busy: processing
2020-01-04 01:47:08,923 - Recv: echo:busy: processing
2020-01-04 01:47:09,427 - Recv: ok
2020-01-04 01:47:09,435 - Recv: X:240.00 Y:200.00 Z:15.00 E:128.21 Count X: 239.65 Y:199.85 Z:15.39 E:134.31
2020-01-04 01:47:09,507 - Recv: ok
2020-01-04 01:47:09,508 - Changing monitoring state from "Pausing" to "Paused"
2020-01-04 01:47:12,178 - Send: M105
2020-01-04 01:47:12,193 - Recv: ok T:242.3 /0.0 B:104.9 /105.0 T0:242.3 /0.0 @:0 B@:76 P:74.8 A:54.3
2020-01-04 01:47:17,180 - Send: M105
2020-01-04 01:47:17,194 - Recv: ok T:238.0 /0.0 B:104.9 /105.0 T0:238.0 /0.0 @:0 B@:70 P:74.5 A:54.3
2020-01-04 01:47:22,195 - Send: M105
2020-01-04 01:47:22,206 - Recv: ok T:233.8 /0.0 B:104.9 /105.0 T0:233.8 /0.0 @:0 B@:67 P:74.2 A:54.3
2020-01-04 01:47:27,197 - Send: M105
2020-01-04 01:47:27,212 - Recv: ok T:229.3 /0.0 B:104.9 /105.0 T0:229.3 /0.0 @:0 B@:74 P:73.8 A:54.2
2020-01-04 01:47:32,200 - Send: M105
2020-01-04 01:47:32,215 - Recv: ok T:225.6 /0.0 B:105.1 /105.0 T0:225.6 /0.0 @:0 B@:51 P:73.4 A:54.1
2020-01-04 01:47:37,203 - Send: M105
2020-01-04 01:47:37,220 - Recv: ok T:221.3 /0.0 B:105.2 /105.0 T0:221.3 /0.0 @:0 B@:42 P:73.0 A:54.2
2020-01-04 01:47:42,205 - Send: M105
2020-01-04 01:47:42,218 - Recv: ok T:217.4 /0.0 B:105.2 /105.0 T0:217.4 /0.0 @:0 B@:51 P:72.5 A:54.1
2020-01-04 01:47:47,208 - Send: M105
2020-01-04 01:47:47,224 - Recv: ok T:213.7 /0.0 B:105.1 /105.0 T0:213.7 /0.0 @:0 B@:72 P:72.2 A:54.1
2020-01-04 01:47:52,210 - Send: M105
2020-01-04 01:47:52,225 - Recv: ok T:210.3 /0.0 B:105.0 /105.0 T0:210.3 /0.0 @:0 B@:71 P:71.8 A:54.1
2020-01-04 01:47:57,213 - Send: M105
2020-01-04 01:47:57,232 - Recv: ok T:206.4 /0.0 B:105.0 /105.0 T0:206.4 /0.0 @:0 B@:70 P:71.5 A:54.2
2020-01-04 01:48:02,215 - Send: M105
2020-01-04 01:48:02,230 - Recv: ok T:202.8 /0.0 B:105.1 /105.0 T0:202.8 /0.0 @:0 B@:53 P:71.1 A:54.2
2020-01-04 01:48:07,218 - Send: M105
2020-01-04 01:48:07,237 - Recv: ok T:199.0 /0.0 B:105.2 /105.0 T0:199.0 /0.0 @:0 B@:45 P:70.7 A:54.1
2020-01-04 01:48:12,220 - Send: M105
2020-01-04 01:48:12,236 - Recv: ok T:196.0 /0.0 B:105.2 /105.0 T0:196.0 /0.0 @:0 B@:45 P:70.4 A:54.1
2020-01-04 01:48:17,224 - Send: M105
2020-01-04 01:48:17,246 - Recv: ok T:193.1 /0.0 B:105.1 /105.0 T0:193.1 /0.0 @:0 B@:52 P:70.1 A:54.1
2020-01-04 01:48:22,226 - Send: M105
2020-01-04 01:48:22,241 - Recv: ok T:189.7 /0.0 B:105.1 /105.0 T0:189.7 /0.0 @:0 B@:52 P:69.7 A:54.0
2020-01-04 01:48:27,228 - Send: M105
2020-01-04 01:48:27,242 - Recv: ok T:186.9 /0.0 B:105.0 /105.0 T0:186.9 /0.0 @:0 B@:67 P:69.4 A:53.9
2020-01-04 01:48:32,231 - Send: M105
2020-01-04 01:48:32,247 - Recv: ok T:183.7 /0.0 B:105.0 /105.0 T0:183.7 /0.0 @:0 B@:63 P:69.1 A:53.8
2020-01-04 01:48:37,234 - Send: M105
2020-01-04 01:48:37,248 - Recv: ok T:180.7 /0.0 B:105.1 /105.0 T0:180.7 /0.0 @:0 B@:52 P:68.8 A:53.7
2020-01-04 01:48:42,238 - Send: M105
2020-01-04 01:48:42,253 - Recv: ok T:177.8 /0.0 B:105.1 /105.0 T0:177.8 /0.0 @:0 B@:45 P:68.5 A:53.7
2020-01-04 01:48:47,240 - Send: M105
2020-01-04 01:48:47,254 - Recv: ok T:175.2 /0.0 B:105.1 /105.0 T0:175.2 /0.0 @:0 B@:51 P:68.2 A:53.7
2020-01-04 01:48:52,243 - Send: M105
2020-01-04 01:48:52,259 - Recv: ok T:172.4 /0.0 B:105.0 /105.0 T0:172.4 /0.0 @:0 B@:57 P:67.9 A:53.6
2020-01-04 01:48:57,246 - Send: M105
2020-01-04 01:48:57,263 - Recv: ok T:169.6 /0.0 B:105.0 /105.0 T0:169.6 /0.0 @:0 B@:57 P:67.7 A:53.6
2020-01-04 01:49:02,249 - Send: M105
2020-01-04 01:49:02,264 - Recv: ok T:167.2 /0.0 B:105.0 /105.0 T0:167.2 /0.0 @:0 B@:62 P:67.4 A:53.4
2020-01-04 01:49:07,251 - Send: M105
2020-01-04 01:49:07,265 - Recv: ok T:164.8 /0.0 B:105.0 /105.0 T0:164.8 /0.0 @:0 B@:49 P:67.1 A:53.4
2020-01-04 01:49:12,256 - Send: M105
2020-01-04 01:49:12,271 - Recv: ok T:162.2 /0.0 B:105.0 /105.0 T0:162.2 /0.0 @:0 B@:52 P:66.9 A:53.6
2020-01-04 01:49:17,261 - Send: M105
2020-01-04 01:49:17,277 - Recv: ok T:159.7 /0.0 B:105.0 /105.0 T0:159.7 /0.0 @:0 B@:59 P:66.6 A:53.3
2020-01-04 01:49:22,264 - Send: M105
2020-01-04 01:49:22,277 - Recv: ok T:157.4 /0.0 B:104.9 /105.0 T0:157.4 /0.0 @:0 B@:68 P:66.3 A:53.3
2020-01-04 01:49:27,267 - Send: M105
2020-01-04 01:49:27,290 - Recv: ok T:155.2 /0.0 B:104.9 /105.0 T0:155.2 /0.0 @:0 B@:64 P:66.1 A:53.3
2020-01-04 01:49:32,269 - Send: M105
2020-01-04 01:49:32,284 - Recv: ok T:152.9 /0.0 B:105.0 /105.0 T0:152.9 /0.0 @:0 B@:51 P:65.8 A:53.1
2020-01-04 01:49:37,272 - Send: M105
2020-01-04 01:49:37,289 - Recv: ok T:150.6 /0.0 B:105.1 /105.0 T0:150.6 /0.0 @:0 B@:35 P:65.6 A:53.1
2020-01-04 01:49:42,274 - Send: M105
2020-01-04 01:49:42,289 - Recv: ok T:148.5 /0.0 B:105.0 /105.0 T0:148.5 /0.0 @:0 B@:59 P:65.3 A:53.1
2020-01-04 01:49:47,277 - Send: M105
2020-01-04 01:49:47,293 - Recv: ok T:146.4 /0.0 B:105.0 /105.0 T0:146.4 /0.0 @:0 B@:52 P:65.0 A:53.1
2020-01-04 01:49:52,280 - Send: M105
2020-01-04 01:49:52,294 - Recv: ok T:144.3 /0.0 B:104.9 /105.0 T0:144.3 /0.0 @:0 B@:65 P:64.8 A:53.1
2020-01-04 01:49:57,284 - Send: M105
2020-01-04 01:49:57,303 - Recv: ok T:142.2 /0.0 B:104.9 /105.0 T0:142.2 /0.0 @:0 B@:67 P:64.6 A:52.9
2020-01-04 01:50:02,303 - Send: M105
2020-01-04 01:50:02,317 - Recv: ok T:140.1 /0.0 B:105.0 /105.0 T0:140.1 /0.0 @:0 B@:51 P:64.4 A:52.9
2020-01-04 01:50:07,305 - Send: M105
2020-01-04 01:50:07,321 - Recv: ok T:138.3 /0.0 B:105.0 /105.0 T0:138.3 /0.0 @:0 B@:56 P:64.2 A:52.9
2020-01-04 01:50:12,308 - Send: M105
2020-01-04 01:50:12,319 - Recv: ok T:136.5 /0.0 B:105.0 /105.0 T0:136.5 /0.0 @:0 B@:61 P:64.0 A:52.9
2020-01-04 01:50:17,311 - Send: M105
2020-01-04 01:50:17,327 - Recv: ok T:134.6 /0.0 B:105.0 /105.0 T0:134.6 /0.0 @:0 B@:65 P:63.7 A:52.7
2020-01-04 01:50:22,313 - Send: M105
2020-01-04 01:50:22,330 - Recv: ok T:132.9 /0.0 B:104.9 /105.0 T0:132.9 /0.0 @:0 B@:63 P:63.5 A:52.7
2020-01-04 01:50:27,315 - Send: M105
2020-01-04 01:50:27,330 - Recv: ok T:131.0 /0.0 B:105.0 /105.0 T0:131.0 /0.0 @:0 B@:56 P:63.3 A:52.7
2020-01-04 01:50:32,318 - Send: M105
2020-01-04 01:50:32,334 - Recv: ok T:129.3 /0.0 B:105.0 /105.0 T0:129.3 /0.0 @:0 B@:57 P:63.1 A:52.7
2020-01-04 01:50:37,320 - Send: M105
2020-01-04 01:50:37,332 - Recv: ok T:127.6 /0.0 B:105.0 /105.0 T0:127.6 /0.0 @:0 B@:57 P:62.9 A:52.8
2020-01-04 01:50:42,323 - Send: M105
2020-01-04 01:50:42,341 - Recv: ok T:126.0 /0.0 B:105.1 /105.0 T0:126.0 /0.0 @:0 B@:50 P:62.6 A:52.6
2020-01-04 01:50:47,333 - Send: M105
2020-01-04 01:50:47,347 - Recv: ok T:124.4 /0.0 B:105.0 /105.0 T0:124.4 /0.0 @:0 B@:60 P:62.4 A:52.4
2020-01-04 01:50:52,335 - Send: M105
2020-01-04 01:50:52,346 - Recv: ok T:122.8 /0.0 B:105.0 /105.0 T0:122.8 /0.0 @:0 B@:66 P:62.1 A:52.5
2020-01-04 01:50:57,337 - Send: M105
2020-01-04 01:50:57,349 - Recv: ok T:121.1 /0.0 B:104.9 /105.0 T0:121.1 /0.0 @:0 B@:63 P:61.9 A:52.5
2020-01-04 01:51:02,341 - Send: M105
2020-01-04 01:51:02,356 - Recv: ok T:119.6 /0.0 B:104.9 /105.0 T0:119.6 /0.0 @:0 B@:64 P:61.7 A:52.4
2020-01-04 01:51:07,344 - Send: M105
2020-01-04 01:51:07,361 - Recv: ok T:118.2 /0.0 B:104.9 /105.0 T0:118.2 /0.0 @:0 B@:59 P:61.6 A:52.4
2020-01-04 01:51:12,346 - Send: M105
2020-01-04 01:51:12,360 - Recv: ok T:116.8 /0.0 B:105.0 /105.0 T0:116.8 /0.0 @:0 B@:52 P:61.4 A:52.4
2020-01-04 01:51:17,349 - Send: M105
2020-01-04 01:51:17,367 - Recv: ok T:115.4 /0.0 B:105.0 /105.0 T0:115.4 /0.0 @:0 B@:50 P:61.2 A:52.4
2020-01-04 01:51:22,353 - Send: M105
2020-01-04 01:51:22,368 - Recv: ok T:114.0 /0.0 B:105.0 /105.0 T0:114.0 /0.0 @:0 B@:66 P:61.1 A:52.3
2020-01-04 01:51:27,356 - Send: M105
2020-01-04 01:51:27,370 - Recv: ok T:112.6 /0.0 B:105.0 /105.0 T0:112.6 /0.0 @:0 B@:60 P:60.9 A:52.2
2020-01-04 01:51:32,358 - Send: M105
2020-01-04 01:51:32,373 - Recv: ok T:111.3 /0.0 B:105.0 /105.0 T0:111.3 /0.0 @:0 B@:56 P:60.8 A:52.2
2020-01-04 01:51:37,361 - Send: M105
2020-01-04 01:51:37,377 - Recv: ok T:109.9 /0.0 B:105.0 /105.0 T0:109.9 /0.0 @:0 B@:53 P:60.6 A:52.1
2020-01-04 01:51:42,363 - Send: M105
2020-01-04 01:51:42,378 - Recv: ok T:108.7 /0.0 B:105.0 /105.0 T0:108.7 /0.0 @:0 B@:52 P:60.5 A:52.2
2020-01-04 01:51:47,365 - Send: M105
2020-01-04 01:51:47,375 - Recv: ok T:107.5 /0.0 B:105.1 /105.0 T0:107.5 /0.0 @:0 B@:43 P:60.4 A:52.0
2020-01-04 01:51:52,367 - Send: M105
2020-01-04 01:51:52,381 - Recv: ok T:106.2 /0.0 B:105.0 /105.0 T0:106.2 /0.0 @:0 B@:62 P:60.2 A:52.1
2020-01-04 01:51:57,369 - Send: M105
2020-01-04 01:51:57,384 - Recv: ok T:105.1 /0.0 B:105.0 /105.0 T0:105.1 /0.0 @:0 B@:62 P:60.0 A:52.2
2020-01-04 01:52:02,373 - Send: M105
2020-01-04 01:52:02,386 - Recv: ok T:103.8 /0.0 B:105.0 /105.0 T0:103.8 /0.0 @:0 B@:50 P:59.9 A:52.1
2020-01-04 01:52:07,380 - Send: M105
2020-01-04 01:52:07,393 - Recv: ok T:102.7 /0.0 B:105.0 /105.0 T0:102.7 /0.0 @:0 B@:50 P:59.7 A:51.9
2020-01-04 01:52:10,019 - Changing monitoring state from "Paused" to "Resuming"
2020-01-04 01:52:10,104 - Changing monitoring state from "Resuming" to "Printing"
2020-01-04 01:52:10,114 - Send: N79178 M109 S245*107
2020-01-04 01:52:11,121 - Recv: T:101.8 E:0 W:?
2020-01-04 01:52:12,124 - Recv: T:101.7 E:0 W:?
2020-01-04 01:52:13,128 - Recv: T:102.1 E:0 W:?
2020-01-04 01:52:14,127 - Recv: T:103.1 E:0 W:?
2020-01-04 01:52:15,131 - Recv: T:104.9 E:0 W:?
2020-01-04 01:52:16,134 - Recv: T:106.8 E:0 W:?
2020-01-04 01:52:17,134 - Recv: T:108.8 E:0 W:?
2020-01-04 01:52:18,137 - Recv: T:111.5 E:0 W:?
2020-01-04 01:52:19,137 - Recv: T:113.7 E:0 W:?
2020-01-04 01:52:20,146 - Recv: T:116.5 E:0 W:?
2020-01-04 01:52:21,144 - Recv: T:118.8 E:0 W:?
2020-01-04 01:52:22,143 - Recv: T:121.0 E:0 W:?
2020-01-04 01:52:23,147 - Recv: T:124.0 E:0 W:?
2020-01-04 01:52:24,150 - Recv: T:126.3 E:0 W:?
2020-01-04 01:52:25,151 - Recv: T:128.5 E:0 W:?
2020-01-04 01:52:26,153 - Recv: T:131.3 E:0 W:?
2020-01-04 01:52:27,153 - Recv: T:133.6 E:0 W:?
2020-01-04 01:52:28,156 - Recv: T:136.4 E:0 W:?
2020-01-04 01:52:29,160 - Recv: T:138.5 E:0 W:?
2020-01-04 01:52:30,159 - Recv: T:140.7 E:0 W:?
2020-01-04 01:52:31,163 - Recv: T:143.6 E:0 W:?
2020-01-04 01:52:32,166 - Recv: T:145.9 E:0 W:?
2020-01-04 01:52:33,165 - Recv: T:148.0 E:0 W:?
2020-01-04 01:52:34,169 - Recv: T:150.7 E:0 W:?
2020-01-04 01:52:35,173 - Recv: T:152.9 E:0 W:?
2020-01-04 01:52:36,173 - Recv: T:155.0 E:0 W:?
2020-01-04 01:52:37,177 - Recv: T:157.7 E:0 W:?
2020-01-04 01:52:38,179 - Recv: T:159.5 E:0 W:?
2020-01-04 01:52:39,183 - Recv: T:162.3 E:0 W:?
2020-01-04 01:52:40,183 - Recv: T:164.5 E:0 W:?
2020-01-04 01:52:41,187 - Recv: T:166.5 E:0 W:?
2020-01-04 01:52:42,189 - Recv: T:168.8 E:0 W:?
2020-01-04 01:52:43,206 - Recv: T:170.9 E:0 W:?
2020-01-04 01:52:44,210 - Recv: T:173.0 E:0 W:?
2020-01-04 01:52:45,209 - Recv: T:175.7 E:0 W:?
2020-01-04 01:52:46,213 - Recv: T:177.6 E:0 W:?
2020-01-04 01:52:47,216 - Recv: T:180.0 E:0 W:?
2020-01-04 01:52:48,215 - Recv: T:182.2 E:0 W:?
2020-01-04 01:52:49,219 - Recv: T:184.3 E:0 W:?
2020-01-04 01:52:50,222 - Recv: T:186.9 E:0 W:?
2020-01-04 01:52:51,222 - Recv: T:188.7 E:0 W:?
2020-01-04 01:52:52,225 - Recv: T:190.7 E:0 W:?
2020-01-04 01:52:53,225 - Recv: T:193.3 E:0 W:?
2020-01-04 01:52:54,229 - Recv: T:195.1 E:0 W:?
2020-01-04 01:52:55,232 - Recv: T:196.8 E:0 W:?
2020-01-04 01:52:56,231 - Recv: T:199.1 E:0 W:?
2020-01-04 01:52:57,235 - Recv: T:201.1 E:0 W:?
2020-01-04 01:52:58,238 - Recv: T:203.5 E:0 W:?
2020-01-04 01:52:59,238 - Recv: T:205.6 E:0 W:?
2020-01-04 01:53:00,241 - Recv: T:207.5 E:0 W:?
2020-01-04 01:53:01,241 - Recv: T:209.8 E:0 W:?
2020-01-04 01:53:02,244 - Recv: T:211.9 E:0 W:?
2020-01-04 01:53:03,248 - Recv: T:214.1 E:0 W:?
2020-01-04 01:53:04,247 - Recv: T:216.3 E:0 W:?
2020-01-04 01:53:05,252 - Recv: T:218.1 E:0 W:?
2020-01-04 01:53:06,255 - Recv: T:219.9 E:0 W:?
2020-01-04 01:53:07,258 - Recv: T:222.2 E:0 W:?
2020-01-04 01:53:08,257 - Recv: T:224.1 E:0 W:?
2020-01-04 01:53:09,262 - Recv: T:226.4 E:0 W:?
2020-01-04 01:53:10,265 - Recv: T:228.1 E:0 W:?
2020-01-04 01:53:11,268 - Recv: T:229.3 E:0 W:?
2020-01-04 01:53:12,269 - Recv: T:231.4 E:0 W:?
2020-01-04 01:53:13,271 - Recv: T:232.5 E:0 W:?
2020-01-04 01:53:14,272 - Recv: T:234.1 E:0 W:?
2020-01-04 01:53:15,274 - Recv: T:235.4 E:0 W:?
2020-01-04 01:53:16,279 - Recv: T:236.6 E:0 W:?
2020-01-04 01:53:17,278 - Recv: T:238.3 E:0 W:?
2020-01-04 01:53:18,282 - Recv: T:238.5 E:0 W:?
2020-01-04 01:53:19,285 - Recv: T:239.4 E:0 W:?
2020-01-04 01:53:20,285 - Recv: T:240.1 E:0 W:?
2020-01-04 01:53:21,288 - Recv: T:241.5 E:0 W:?
2020-01-04 01:53:22,288 - Recv: T:242.0 E:0 W:?
2020-01-04 01:53:23,291 - Recv: T:243.3 E:0 W:?
2020-01-04 01:53:24,295 - Recv: T:243.5 E:0 W:?
2020-01-04 01:53:25,294 - Recv: T:244.1 E:0 W:2
2020-01-04 01:53:26,298 - Recv: T:244.8 E:0 W:1
2020-01-04 01:53:27,301 - Recv: T:245.8 E:0 W:0
2020-01-04 01:53:27,649 - Recv: ok
2020-01-04 01:53:27,657 - Send: N79179 G1 F1500 E2*28
2020-01-04 01:53:27,665 - Recv: ok
2020-01-04 01:53:27,672 - Send: N79180 G1 F199.998 E2.2*37
2020-01-04 01:53:27,681 - Recv: ok
2020-01-04 01:53:27,689 - Send: N79181 G1 F1500 E-2*54
2020-01-04 01:53:27,698 - Recv: ok
2020-01-04 01:53:27,704 - Send: N79182 G1 F300 Z4*54
2020-01-04 01:53:27,936 - Recv: ok
2020-01-04 01:53:27,943 - Send: N79183 G1 F9000 X80.875 Y67.675*69
2020-01-04 01:53:27,981 - Recv: ok
2020-01-04 01:53:27,988 - Send: N79184 G1 F300 Z3*55
2020-01-04 01:53:28,004 - Recv: ok
2020-01-04 01:53:28,012 - Send: N79185 G1 F1500 E2*31
2020-01-04 01:53:28,021 - Recv: ok
2020-01-04 01:53:28,028 - Send: N79186 G1 F2100*76
2020-01-04 01:53:28,419 - Recv: ok
2020-01-04 01:53:28,427 - Send: N79187 M82*25
2020-01-04 01:53:28,435 - Recv: ok

I see this at the M0:

INFO - Pausing print job due to command M0
INFO - Not sending M0 to printer, it's configured as a blocked command
INFO - Print job paused - origin: local, path: 1_x_75mm_Filter_Module_Rev3_-_Gcode_Rev1.gcode, owner: pi, user: None

That appears to explain why M0 doesn't work in the log you sent.

There's no octoprint.log with this one, but I do see there's no M0 that occurs in this serial log. That would make sense if it isn't filtered out, and seems to be another indication that your first assertion was not done.

What does this mean? It works for some prints but not for others, or it works for prints with a fixed pause time and not for prints with an open-ended pause time?

Thanks for the input everyone. To make things easier I'll put the Octoprint.log and Serial.log in here so that they can be seen side by side:

Octoprint.log

2020-01-04 01:47:04,732 - octoprint.util.comm - INFO - Pausing print job due to command M0
2020-01-04 01:47:04,736 - octoprint.util.comm - INFO - Changing monitoring state from "Printing" to "Pausing"
2020-01-04 01:47:04,748 - octoprint.util.comm - INFO - Not sending M0 to printer, it's configured as a blocked command
2020-01-04 01:47:09,455 - octoprint.printer.standard.job - INFO - Print job paused - origin: local, path: 75-CARB_Body_Rev_3_x_1_Cover_Rev_2_x_1_-_Gcode_Rev_1.gcode, owner: pi, user: None
2020-01-04 01:47:09,484 - octoprint.plugins.telegram - INFO - Sending a message: Paused printing 75-CARB_Body_Rev_3_x_1_Cover_Rev_2_x_1_-_Gcode_Rev_1.gcode at 16%%. 11:11:14 remaining. with_image=False with_gif=False chatID= 669769055
2020-01-04 01:47:09,513 - octoprint.util.comm - INFO - Changing monitoring state from "Pausing" to "Paused"
2020-01-04 01:52:10,020 - octoprint.util.comm - INFO - Changing monitoring state from "Paused" to "Resuming"
2020-01-04 01:52:10,051 - octoprint.printer.standard.job - INFO - Print job resumed - origin: local, path: 75-CARB_Body_Rev_3_x_1_Cover_Rev_2_x_1_-_Gcode_Rev_1.gcode, owner: pi, user: None
2020-01-04 01:52:10,078 - octoprint.plugins.telegram - INFO - Sending a message: Resumed printing 75-CARB_Body_Rev_3_x_1_Cover_Rev_2_x_1_-_Gcode_Rev_1.gcode at 16%%. 11:11:14 remaining. with_image=False with_gif=False chatID= 669769055
2020-01-04 01:52:10,102 - octoprint.plugins.enclosure - INFO - Turning gpio to control temperature off.
2020-01-04 01:52:10,105 - octoprint.util.comm - INFO - Changing monitoring state from "Resuming" to "Printing"
2020-01-04 01:53:34,256 - octoprint.server.util.sockjs - INFO - New connection from client: ::ffff:192.168.20.18
2020-01-04 01:53:34,666 - octoprint.server.util.sockjs - INFO - User pi logged in on the socket from client ::ffff:192.168.20.18
2020-01-04 01:53:39,940 - octoprint.util.comm - INFO - Changing monitoring state from "Printing" to "Cancelling"
2020-01-04 01:53:39,946 - octoprint.util.comm - INFO - Force-sending M108 to the printer

Serial.log

2020-01-04 01:47:04,734 - Changing monitoring state from "Printing" to "Pausing"
2020-01-04 01:47:04,749 - Send: N79176 M400*41
2020-01-04 01:47:04,761 - Send: N79177 M114*40
2020-01-04 01:47:06,857 - Recv: echo:busy: processing
2020-01-04 01:47:08,923 - Recv: echo:busy: processing
2020-01-04 01:47:09,427 - Recv: ok
2020-01-04 01:47:09,435 - Recv: X:240.00 Y:200.00 Z:15.00 E:128.21 Count X: 239.65 Y:199.85 Z:15.39 E:134.31
2020-01-04 01:47:09,507 - Recv: ok
2020-01-04 01:47:09,508 - Changing monitoring state from "Pausing" to "Paused"
2020-01-04 01:47:12,178 - Send: M105
2020-01-04 01:47:12,193 - Recv: ok T:242.3 /0.0 B:104.9 /105.0 T0:242.3 /0.0 @:0 B@:76 P:74.8 A:54.3
2020-01-04 01:47:17,180 - Send: M105
2020-01-04 01:47:17,194 - Recv: ok T:238.0 /0.0 B:104.9 /105.0 T0:238.0 /0.0 @:0 B@:70 P:74.5 A:54.3
2020-01-04 01:47:22,195 - Send: M105
2020-01-04 01:47:22,206 - Recv: ok T:233.8 /0.0 B:104.9 /105.0 T0:233.8 /0.0 @:0 B@:67 P:74.2 A:54.3
2020-01-04 01:47:27,197 - Send: M105
2020-01-04 01:47:27,212 - Recv: ok T:229.3 /0.0 B:104.9 /105.0 T0:229.3 /0.0 @:0 B@:74 P:73.8 A:54.2
2020-01-04 01:47:32,200 - Send: M105
2020-01-04 01:47:32,215 - Recv: ok T:225.6 /0.0 B:105.1 /105.0 T0:225.6 /0.0 @:0 B@:51 P:73.4 A:54.1
2020-01-04 01:47:37,203 - Send: M105
2020-01-04 01:47:37,220 - Recv: ok T:221.3 /0.0 B:105.2 /105.0 T0:221.3 /0.0 @:0 B@:42 P:73.0 A:54.2
2020-01-04 01:47:42,205 - Send: M105
2020-01-04 01:47:42,218 - Recv: ok T:217.4 /0.0 B:105.2 /105.0 T0:217.4 /0.0 @:0 B@:51 P:72.5 A:54.1
2020-01-04 01:47:47,208 - Send: M105
2020-01-04 01:47:47,224 - Recv: ok T:213.7 /0.0 B:105.1 /105.0 T0:213.7 /0.0 @:0 B@:72 P:72.2 A:54.1
2020-01-04 01:47:52,210 - Send: M105
2020-01-04 01:47:52,225 - Recv: ok T:210.3 /0.0 B:105.0 /105.0 T0:210.3 /0.0 @:0 B@:71 P:71.8 A:54.1
2020-01-04 01:47:57,213 - Send: M105
2020-01-04 01:47:57,232 - Recv: ok T:206.4 /0.0 B:105.0 /105.0 T0:206.4 /0.0 @:0 B@:70 P:71.5 A:54.2
2020-01-04 01:48:02,215 - Send: M105
2020-01-04 01:48:02,230 - Recv: ok T:202.8 /0.0 B:105.1 /105.0 T0:202.8 /0.0 @:0 B@:53 P:71.1 A:54.2
2020-01-04 01:48:07,218 - Send: M105
2020-01-04 01:48:07,237 - Recv: ok T:199.0 /0.0 B:105.2 /105.0 T0:199.0 /0.0 @:0 B@:45 P:70.7 A:54.1
2020-01-04 01:48:12,220 - Send: M105
2020-01-04 01:48:12,236 - Recv: ok T:196.0 /0.0 B:105.2 /105.0 T0:196.0 /0.0 @:0 B@:45 P:70.4 A:54.1
2020-01-04 01:48:17,224 - Send: M105
2020-01-04 01:48:17,246 - Recv: ok T:193.1 /0.0 B:105.1 /105.0 T0:193.1 /0.0 @:0 B@:52 P:70.1 A:54.1
2020-01-04 01:48:22,226 - Send: M105
2020-01-04 01:48:22,241 - Recv: ok T:189.7 /0.0 B:105.1 /105.0 T0:189.7 /0.0 @:0 B@:52 P:69.7 A:54.0
2020-01-04 01:48:27,228 - Send: M105
2020-01-04 01:48:27,242 - Recv: ok T:186.9 /0.0 B:105.0 /105.0 T0:186.9 /0.0 @:0 B@:67 P:69.4 A:53.9
2020-01-04 01:48:32,231 - Send: M105
2020-01-04 01:48:32,247 - Recv: ok T:183.7 /0.0 B:105.0 /105.0 T0:183.7 /0.0 @:0 B@:63 P:69.1 A:53.8
2020-01-04 01:48:37,234 - Send: M105
2020-01-04 01:48:37,248 - Recv: ok T:180.7 /0.0 B:105.1 /105.0 T0:180.7 /0.0 @:0 B@:52 P:68.8 A:53.7
2020-01-04 01:48:42,238 - Send: M105
2020-01-04 01:48:42,253 - Recv: ok T:177.8 /0.0 B:105.1 /105.0 T0:177.8 /0.0 @:0 B@:45 P:68.5 A:53.7
2020-01-04 01:48:47,240 - Send: M105
2020-01-04 01:48:47,254 - Recv: ok T:175.2 /0.0 B:105.1 /105.0 T0:175.2 /0.0 @:0 B@:51 P:68.2 A:53.7
2020-01-04 01:48:52,243 - Send: M105
2020-01-04 01:48:52,259 - Recv: ok T:172.4 /0.0 B:105.0 /105.0 T0:172.4 /0.0 @:0 B@:57 P:67.9 A:53.6
2020-01-04 01:48:57,246 - Send: M105
2020-01-04 01:48:57,263 - Recv: ok T:169.6 /0.0 B:105.0 /105.0 T0:169.6 /0.0 @:0 B@:57 P:67.7 A:53.6
2020-01-04 01:49:02,249 - Send: M105
2020-01-04 01:49:02,264 - Recv: ok T:167.2 /0.0 B:105.0 /105.0 T0:167.2 /0.0 @:0 B@:62 P:67.4 A:53.4
2020-01-04 01:49:07,251 - Send: M105
2020-01-04 01:49:07,265 - Recv: ok T:164.8 /0.0 B:105.0 /105.0 T0:164.8 /0.0 @:0 B@:49 P:67.1 A:53.4
2020-01-04 01:49:12,256 - Send: M105
2020-01-04 01:49:12,271 - Recv: ok T:162.2 /0.0 B:105.0 /105.0 T0:162.2 /0.0 @:0 B@:52 P:66.9 A:53.6
2020-01-04 01:49:17,261 - Send: M105
2020-01-04 01:49:17,277 - Recv: ok T:159.7 /0.0 B:105.0 /105.0 T0:159.7 /0.0 @:0 B@:59 P:66.6 A:53.3
2020-01-04 01:49:22,264 - Send: M105
2020-01-04 01:49:22,277 - Recv: ok T:157.4 /0.0 B:104.9 /105.0 T0:157.4 /0.0 @:0 B@:68 P:66.3 A:53.3
2020-01-04 01:49:27,267 - Send: M105
2020-01-04 01:49:27,290 - Recv: ok T:155.2 /0.0 B:104.9 /105.0 T0:155.2 /0.0 @:0 B@:64 P:66.1 A:53.3
2020-01-04 01:49:32,269 - Send: M105
2020-01-04 01:49:32,284 - Recv: ok T:152.9 /0.0 B:105.0 /105.0 T0:152.9 /0.0 @:0 B@:51 P:65.8 A:53.1
2020-01-04 01:49:37,272 - Send: M105
2020-01-04 01:49:37,289 - Recv: ok T:150.6 /0.0 B:105.1 /105.0 T0:150.6 /0.0 @:0 B@:35 P:65.6 A:53.1
2020-01-04 01:49:42,274 - Send: M105
2020-01-04 01:49:42,289 - Recv: ok T:148.5 /0.0 B:105.0 /105.0 T0:148.5 /0.0 @:0 B@:59 P:65.3 A:53.1
2020-01-04 01:49:47,277 - Send: M105
2020-01-04 01:49:47,293 - Recv: ok T:146.4 /0.0 B:105.0 /105.0 T0:146.4 /0.0 @:0 B@:52 P:65.0 A:53.1
2020-01-04 01:49:52,280 - Send: M105
2020-01-04 01:49:52,294 - Recv: ok T:144.3 /0.0 B:104.9 /105.0 T0:144.3 /0.0 @:0 B@:65 P:64.8 A:53.1
2020-01-04 01:49:57,284 - Send: M105
2020-01-04 01:49:57,303 - Recv: ok T:142.2 /0.0 B:104.9 /105.0 T0:142.2 /0.0 @:0 B@:67 P:64.6 A:52.9
2020-01-04 01:50:02,303 - Send: M105
2020-01-04 01:50:02,317 - Recv: ok T:140.1 /0.0 B:105.0 /105.0 T0:140.1 /0.0 @:0 B@:51 P:64.4 A:52.9
2020-01-04 01:50:07,305 - Send: M105
2020-01-04 01:50:07,321 - Recv: ok T:138.3 /0.0 B:105.0 /105.0 T0:138.3 /0.0 @:0 B@:56 P:64.2 A:52.9
2020-01-04 01:50:12,308 - Send: M105
2020-01-04 01:50:12,319 - Recv: ok T:136.5 /0.0 B:105.0 /105.0 T0:136.5 /0.0 @:0 B@:61 P:64.0 A:52.9
2020-01-04 01:50:17,311 - Send: M105
2020-01-04 01:50:17,327 - Recv: ok T:134.6 /0.0 B:105.0 /105.0 T0:134.6 /0.0 @:0 B@:65 P:63.7 A:52.7
2020-01-04 01:50:22,313 - Send: M105
2020-01-04 01:50:22,330 - Recv: ok T:132.9 /0.0 B:104.9 /105.0 T0:132.9 /0.0 @:0 B@:63 P:63.5 A:52.7
2020-01-04 01:50:27,315 - Send: M105
2020-01-04 01:50:27,330 - Recv: ok T:131.0 /0.0 B:105.0 /105.0 T0:131.0 /0.0 @:0 B@:56 P:63.3 A:52.7
2020-01-04 01:50:32,318 - Send: M105
2020-01-04 01:50:32,334 - Recv: ok T:129.3 /0.0 B:105.0 /105.0 T0:129.3 /0.0 @:0 B@:57 P:63.1 A:52.7
2020-01-04 01:50:37,320 - Send: M105
2020-01-04 01:50:37,332 - Recv: ok T:127.6 /0.0 B:105.0 /105.0 T0:127.6 /0.0 @:0 B@:57 P:62.9 A:52.8
2020-01-04 01:50:42,323 - Send: M105
2020-01-04 01:50:42,341 - Recv: ok T:126.0 /0.0 B:105.1 /105.0 T0:126.0 /0.0 @:0 B@:50 P:62.6 A:52.6
2020-01-04 01:50:47,333 - Send: M105
2020-01-04 01:50:47,347 - Recv: ok T:124.4 /0.0 B:105.0 /105.0 T0:124.4 /0.0 @:0 B@:60 P:62.4 A:52.4
2020-01-04 01:50:52,335 - Send: M105
2020-01-04 01:50:52,346 - Recv: ok T:122.8 /0.0 B:105.0 /105.0 T0:122.8 /0.0 @:0 B@:66 P:62.1 A:52.5
2020-01-04 01:50:57,337 - Send: M105
2020-01-04 01:50:57,349 - Recv: ok T:121.1 /0.0 B:104.9 /105.0 T0:121.1 /0.0 @:0 B@:63 P:61.9 A:52.5
2020-01-04 01:51:02,341 - Send: M105
2020-01-04 01:51:02,356 - Recv: ok T:119.6 /0.0 B:104.9 /105.0 T0:119.6 /0.0 @:0 B@:64 P:61.7 A:52.4
2020-01-04 01:51:07,344 - Send: M105
2020-01-04 01:51:07,361 - Recv: ok T:118.2 /0.0 B:104.9 /105.0 T0:118.2 /0.0 @:0 B@:59 P:61.6 A:52.4
2020-01-04 01:51:12,346 - Send: M105
2020-01-04 01:51:12,360 - Recv: ok T:116.8 /0.0 B:105.0 /105.0 T0:116.8 /0.0 @:0 B@:52 P:61.4 A:52.4
2020-01-04 01:51:17,349 - Send: M105
2020-01-04 01:51:17,367 - Recv: ok T:115.4 /0.0 B:105.0 /105.0 T0:115.4 /0.0 @:0 B@:50 P:61.2 A:52.4
2020-01-04 01:51:22,353 - Send: M105
2020-01-04 01:51:22,368 - Recv: ok T:114.0 /0.0 B:105.0 /105.0 T0:114.0 /0.0 @:0 B@:66 P:61.1 A:52.3
2020-01-04 01:51:27,356 - Send: M105
2020-01-04 01:51:27,370 - Recv: ok T:112.6 /0.0 B:105.0 /105.0 T0:112.6 /0.0 @:0 B@:60 P:60.9 A:52.2
2020-01-04 01:51:32,358 - Send: M105
2020-01-04 01:51:32,373 - Recv: ok T:111.3 /0.0 B:105.0 /105.0 T0:111.3 /0.0 @:0 B@:56 P:60.8 A:52.2
2020-01-04 01:51:37,361 - Send: M105
2020-01-04 01:51:37,377 - Recv: ok T:109.9 /0.0 B:105.0 /105.0 T0:109.9 /0.0 @:0 B@:53 P:60.6 A:52.1
2020-01-04 01:51:42,363 - Send: M105
2020-01-04 01:51:42,378 - Recv: ok T:108.7 /0.0 B:105.0 /105.0 T0:108.7 /0.0 @:0 B@:52 P:60.5 A:52.2
2020-01-04 01:51:47,365 - Send: M105
2020-01-04 01:51:47,375 - Recv: ok T:107.5 /0.0 B:105.1 /105.0 T0:107.5 /0.0 @:0 B@:43 P:60.4 A:52.0
2020-01-04 01:51:52,367 - Send: M105
2020-01-04 01:51:52,381 - Recv: ok T:106.2 /0.0 B:105.0 /105.0 T0:106.2 /0.0 @:0 B@:62 P:60.2 A:52.1
2020-01-04 01:51:57,369 - Send: M105
2020-01-04 01:51:57,384 - Recv: ok T:105.1 /0.0 B:105.0 /105.0 T0:105.1 /0.0 @:0 B@:62 P:60.0 A:52.2
2020-01-04 01:52:02,373 - Send: M105
2020-01-04 01:52:02,386 - Recv: ok T:103.8 /0.0 B:105.0 /105.0 T0:103.8 /0.0 @:0 B@:50 P:59.9 A:52.1
2020-01-04 01:52:07,380 - Send: M105
2020-01-04 01:52:07,393 - Recv: ok T:102.7 /0.0 B:105.0 /105.0 T0:102.7 /0.0 @:0 B@:50 P:59.7 A:51.9
2020-01-04 01:52:10,019 - Changing monitoring state from "Paused" to "Resuming"
2020-01-04 01:52:10,104 - Changing monitoring state from "Resuming" to "Printing"
2020-01-04 01:52:10,114 - Send: N79178 M109 S245*107
2020-01-04 01:52:11,121 - Recv: T:101.8 E:0 W:?
2020-01-04 01:52:12,124 - Recv: T:101.7 E:0 W:?
2020-01-04 01:52:13,128 - Recv: T:102.1 E:0 W:?
2020-01-04 01:52:14,127 - Recv: T:103.1 E:0 W:?
2020-01-04 01:52:15,131 - Recv: T:104.9 E:0 W:?
2020-01-04 01:52:16,134 - Recv: T:106.8 E:0 W:?
2020-01-04 01:52:17,134 - Recv: T:108.8 E:0 W:?
2020-01-04 01:52:18,137 - Recv: T:111.5 E:0 W:?
2020-01-04 01:52:19,137 - Recv: T:113.7 E:0 W:?
2020-01-04 01:52:20,146 - Recv: T:116.5 E:0 W:?
2020-01-04 01:52:21,144 - Recv: T:118.8 E:0 W:?
2020-01-04 01:52:22,143 - Recv: T:121.0 E:0 W:?
2020-01-04 01:52:23,147 - Recv: T:124.0 E:0 W:?
2020-01-04 01:52:24,150 - Recv: T:126.3 E:0 W:?
2020-01-04 01:52:25,151 - Recv: T:128.5 E:0 W:?
2020-01-04 01:52:26,153 - Recv: T:131.3 E:0 W:?
2020-01-04 01:52:27,153 - Recv: T:133.6 E:0 W:?
2020-01-04 01:52:28,156 - Recv: T:136.4 E:0 W:?
2020-01-04 01:52:29,160 - Recv: T:138.5 E:0 W:?
2020-01-04 01:52:30,159 - Recv: T:140.7 E:0 W:?
2020-01-04 01:52:31,163 - Recv: T:143.6 E:0 W:?
2020-01-04 01:52:32,166 - Recv: T:145.9 E:0 W:?
2020-01-04 01:52:33,165 - Recv: T:148.0 E:0 W:?
2020-01-04 01:52:34,169 - Recv: T:150.7 E:0 W:?
2020-01-04 01:52:35,173 - Recv: T:152.9 E:0 W:?
2020-01-04 01:52:36,173 - Recv: T:155.0 E:0 W:?
2020-01-04 01:52:37,177 - Recv: T:157.7 E:0 W:?
2020-01-04 01:52:38,179 - Recv: T:159.5 E:0 W:?
2020-01-04 01:52:39,183 - Recv: T:162.3 E:0 W:?
2020-01-04 01:52:40,183 - Recv: T:164.5 E:0 W:?
2020-01-04 01:52:41,187 - Recv: T:166.5 E:0 W:?
2020-01-04 01:52:42,189 - Recv: T:168.8 E:0 W:?
2020-01-04 01:52:43,206 - Recv: T:170.9 E:0 W:?
2020-01-04 01:52:44,210 - Recv: T:173.0 E:0 W:?
2020-01-04 01:52:45,209 - Recv: T:175.7 E:0 W:?
2020-01-04 01:52:46,213 - Recv: T:177.6 E:0 W:?
2020-01-04 01:52:47,216 - Recv: T:180.0 E:0 W:?
2020-01-04 01:52:48,215 - Recv: T:182.2 E:0 W:?
2020-01-04 01:52:49,219 - Recv: T:184.3 E:0 W:?
2020-01-04 01:52:50,222 - Recv: T:186.9 E:0 W:?
2020-01-04 01:52:51,222 - Recv: T:188.7 E:0 W:?
2020-01-04 01:52:52,225 - Recv: T:190.7 E:0 W:?
2020-01-04 01:52:53,225 - Recv: T:193.3 E:0 W:?
2020-01-04 01:52:54,229 - Recv: T:195.1 E:0 W:?
2020-01-04 01:52:55,232 - Recv: T:196.8 E:0 W:?
2020-01-04 01:52:56,231 - Recv: T:199.1 E:0 W:?
2020-01-04 01:52:57,235 - Recv: T:201.1 E:0 W:?
2020-01-04 01:52:58,238 - Recv: T:203.5 E:0 W:?
2020-01-04 01:52:59,238 - Recv: T:205.6 E:0 W:?
2020-01-04 01:53:00,241 - Recv: T:207.5 E:0 W:?
2020-01-04 01:53:01,241 - Recv: T:209.8 E:0 W:?
2020-01-04 01:53:02,244 - Recv: T:211.9 E:0 W:?
2020-01-04 01:53:03,248 - Recv: T:214.1 E:0 W:?
2020-01-04 01:53:04,247 - Recv: T:216.3 E:0 W:?
2020-01-04 01:53:05,252 - Recv: T:218.1 E:0 W:?
2020-01-04 01:53:06,255 - Recv: T:219.9 E:0 W:?
2020-01-04 01:53:07,258 - Recv: T:222.2 E:0 W:?
2020-01-04 01:53:08,257 - Recv: T:224.1 E:0 W:?
2020-01-04 01:53:09,262 - Recv: T:226.4 E:0 W:?
2020-01-04 01:53:10,265 - Recv: T:228.1 E:0 W:?
2020-01-04 01:53:11,268 - Recv: T:229.3 E:0 W:?
2020-01-04 01:53:12,269 - Recv: T:231.4 E:0 W:?
2020-01-04 01:53:13,271 - Recv: T:232.5 E:0 W:?
2020-01-04 01:53:14,272 - Recv: T:234.1 E:0 W:?
2020-01-04 01:53:15,274 - Recv: T:235.4 E:0 W:?
2020-01-04 01:53:16,279 - Recv: T:236.6 E:0 W:?
2020-01-04 01:53:17,278 - Recv: T:238.3 E:0 W:?
2020-01-04 01:53:18,282 - Recv: T:238.5 E:0 W:?
2020-01-04 01:53:19,285 - Recv: T:239.4 E:0 W:?
2020-01-04 01:53:20,285 - Recv: T:240.1 E:0 W:?
2020-01-04 01:53:21,288 - Recv: T:241.5 E:0 W:?
2020-01-04 01:53:22,288 - Recv: T:242.0 E:0 W:?
2020-01-04 01:53:23,291 - Recv: T:243.3 E:0 W:?
2020-01-04 01:53:24,295 - Recv: T:243.5 E:0 W:?
2020-01-04 01:53:25,294 - Recv: T:244.1 E:0 W:2
2020-01-04 01:53:26,298 - Recv: T:244.8 E:0 W:1
2020-01-04 01:53:27,301 - Recv: T:245.8 E:0 W:0
2020-01-04 01:53:27,649 - Recv: ok
2020-01-04 01:53:27,657 - Send: N79179 G1 F1500 E2*28
2020-01-04 01:53:27,665 - Recv: ok
2020-01-04 01:53:27,672 - Send: N79180 G1 F199.998 E2.2*37
2020-01-04 01:53:27,681 - Recv: ok
2020-01-04 01:53:27,689 - Send: N79181 G1 F1500 E-2*54
2020-01-04 01:53:27,698 - Recv: ok
2020-01-04 01:53:27,704 - Send: N79182 G1 F300 Z4*54
2020-01-04 01:53:27,936 - Recv: ok
2020-01-04 01:53:27,943 - Send: N79183 G1 F9000 X80.875 Y67.675*69
2020-01-04 01:53:27,981 - Recv: ok
2020-01-04 01:53:27,988 - Send: N79184 G1 F300 Z3*55
2020-01-04 01:53:28,004 - Recv: ok
2020-01-04 01:53:28,012 - Send: N79185 G1 F1500 E2*31
2020-01-04 01:53:28,021 - Recv: ok
2020-01-04 01:53:28,028 - Send: N79186 G1 F2100*76
2020-01-04 01:53:28,419 - Recv: ok
2020-01-04 01:53:28,427 - Send: N79187 M82*25
2020-01-04 01:53:28,435 - Recv: ok
2020-01-04 01:53:28,442 - Send: N79188 G92 E130.20617*86
2020-01-04 01:53:28,447 - Recv: ok
2020-01-04 01:53:28,454 - Send: N79189 G0 X80.875 Y67.675 Z3.3*117
2020-01-04 01:53:28,470 - Recv: ok
2020-01-04 01:53:28,478 - Send: N79190 M205 X8 Y8*35
2020-01-04 01:53:28,484 - Recv: ok
2020-01-04 01:53:28,491 - Send: N79191 G1 F600 Z2.7*46
2020-01-04 01:53:28,517 - Recv: ok
2020-01-04 01:53:28,524 - Send: N79192 G1 F2100 E131.00617*1
2020-01-04 01:53:30,704 - Recv: echo:busy: processing

I have tried before removing M0 as a blocked command in OctoPrint thinking it would sort out the issue, but it didn't make any difference so I put M0 back as a blocked command.

My understanding is that the Prusa printer doesn't do the pause, OctoPrint does - OctoPrint should just stop sending commands to the printer whist in the paused state?

It works with the code I produced for testing, but not with the gcode of the part I actually want to print. This confuses me as well. If I run my test gcode - which is just a small square which has been sliced with exactly the same settings (just more pause points through the height), the printer does not auto resume. It will sit there paused until I resume the print, up to half an hour or more. I can't understand how that could be possible.

Actually, there is one difference come to think of it. In the test I put a LCD message (with M117 command), in the actual part gcode, there is no M117. Surely that couldn't be the source of this issue??

Gcode extracts of the test print and the part I am having problems with are below.

Pause Gcode at pause point

;TYPE:CUSTOM
;added code by post processing
;script: PauseAtHeight.py
;current layer: 5
M83 ; switch to relative E values for any needed retraction
G1 F300 Z2.8 ; move up a millimeter to get out of the way
G1 F9000 X190 Y190
G1 F300 Z15 ; too close to bed--move to at least 15mm
M104 S0 ; standby temperature
M117 Paused next 8
M0 ; Do the actual pause
M109 S245 ; resume temperature
G1 F300 Z2.8
G1 F9000 X8 Y8
G1 F300 Z1.8 ; move back down to resume height
G1 F1800 ; restore extrusion feedrate
M82 ; switch back to absolute E values
G92 E286.03857

Actual print Gcode at pause point

;TYPE:CUSTOM
;added code by post processing
;script: PauseAtHeight.py
;current layer: 8
M83 ; switch to relative E values for any needed retraction
G1 F1500 E-2
G1 F300 Z4 ; move up a millimeter to get out of the way
G1 F9000 X240 Y200
G1 F300 Z15 ; too close to bed--move to at least 15mm
M104 S0 ; standby temperature
M0 ; Do the actual pause
M109 S245 ; resume temperature
G1 F1500 E2
G1 F199.998 E2.2
G1 F1500 E-2
G1 F300 Z4
G1 F9000 X80.875 Y67.675
G1 F300 Z3 ; move back down to resume height
G1 F1500 E2
G1 F2100 ; restore extrusion feedrate
M82 ; switch back to absolute E values
G92 E130.20617

Prusa has it's own pause code: M601
https://reprap.org/wiki/G-code#M601:_Pause_print

1 Like

Thanks Ewald,
So I should supplement M0 for M601? Also I suppose it shouldn't be a blocked command by OctoPrint and sent through to the Prusa printer?

Looks like using M601 instead of M0 does the trick. I set OctoPrint to not block this command and also that it is a long running command.

Thanks for everyone's input.

1 Like

Not sure if this is applicable but in this post Here there is a discussion of problems with pause to change filament on a Prusa Mk3.

That's what I was suggesting, that someone who seems to be a moderator on the Prusa forum was hinting at (and in other threads describing) why Prusa doesn't want you to do pauses, presumably.