Octoprint won`t start a print from SD Card

Hey there,
I recently installed the newest Version of Octoprint to my Raspberry Pi 3B+. I´m loading my prints to my SD Card using Cura. So I´m not uploading them via Octoprint because this is too slow in my opinion (7mb gcode takes about 40 min) Everytime I start a print job with Octoprint from the SD Card it starts and cancels the print immediately.
Here´s the log:

2020-04-28 20:30:22,199 - octoprint.server.heartbeat - INFO - Server heartbeat <3
2020-04-28 20:32:26,021 - octoprint.printer.standard.job - INFO - Print job selected - origin: sdcard, path: neu/04_gec~1.gco, owner: Chris, user: Chris
2020-04-28 20:32:26,029 - octoprint.util.comm - INFO - Changing monitoring state from "Operational" to "Starting print from SD"
2020-04-28 20:32:26,032 - octoprint.printer.standard.job - INFO - Print job started - origin: sdcard, path: neu/04_gec~1.gco, owner: Chris, user: Chris
2020-04-28 20:32:26,057 - octoprint.util.comm - INFO - Changing monitoring state from "Starting print from SD" to "Printing from SD"
2020-04-28 20:32:28,165 - octoprint.util.comm - INFO - Changing monitoring state from "Printing from SD" to "Cancelling"
2020-04-28 20:32:28,172 - octoprint.util.comm - INFO - Force-sending M108 to the printer
2020-04-28 20:32:28,191 - octoprint.printer.standard.job - INFO - Print job cancelled - origin: sdcard, path: neu/04_gec~1.gco, owner: Chris, user: None
2020-04-28 20:32:28,309 - octoprint.util.comm - INFO - Changing monitoring state from "Cancelling" to "Operational"
2020-04-28 20:32:36,890 - octoprint.util.comm - INFO - Changing monitoring state from "Operational" to "Starting print from SD"
2020-04-28 20:32:36,899 - octoprint.printer.standard.job - INFO - Print job started - origin: sdcard, path: neu/04_gec~1.gco, owner: Chris, user: Chris
2020-04-28 20:32:36,957 - octoprint.util.comm - INFO - Changing monitoring state from "Starting print from SD" to "Printing from SD"
2020-04-28 20:32:39,179 - octoprint.util.comm - INFO - Changing monitoring state from "Printing from SD" to "Cancelling"
2020-04-28 20:32:39,190 - octoprint.util.comm - INFO - Force-sending M108 to the printer
2020-04-28 20:32:39,200 - octoprint.printer.standard.job - INFO - Print job cancelled - origin: sdcard, path: neu/04_gec~1.gco, owner: Chris, user: None
2020-04-28 20:32:39,264 - octoprint.util.comm - INFO - Changing monitoring state from "Cancelling" to "Operational"

Maybe someone could help me please :slight_smile:

Not much to see in this log
Please upload the serial.log

1 Like

Hey there,
sorry for my late answer (was asking yesterday evening so i wasn´t able to answer during night time :sweat_smile:)
Here´s the serial.log

2020-04-29 07:51:53,050 - Enabling serial logging
2020-04-29 07:51:53,791 - Recv:  T:19.26 /0.00 B:19.26 /0.00 @:0 B@:0
2020-04-29 07:51:55,778 - Recv:  T:19.34 /0.00 B:19.30 /0.00 @:0 B@:0
2020-04-29 07:51:57,783 - Recv:  T:19.37 /0.00 B:19.26 /0.00 @:0 B@:0
2020-04-29 07:51:59,787 - Recv:  T:19.34 /0.00 B:19.26 /0.00 @:0 B@:0
2020-04-29 07:52:01,790 - Recv:  T:19.26 /0.00 B:19.30 /0.00 @:0 B@:0
2020-04-29 07:52:03,793 - Recv:  T:19.34 /0.00 B:19.22 /0.00 @:0 B@:0
2020-04-29 07:52:05,795 - Recv:  T:19.37 /0.00 B:19.26 /0.00 @:0 B@:0
2020-04-29 07:52:07,538 - Send: M23 /bereit~1/04_f95_1.gco
2020-04-29 07:52:07,549 - Recv: echo:Now fresh file: /bereit~1/04_f95_1.gco
2020-04-29 07:52:07,559 - Recv: File opened: 04_f95_1.gco Size: 1017012
2020-04-29 07:52:07,562 - Recv: File selected
2020-04-29 07:52:07,580 - Changing monitoring state from "Operational" to "Starting print from SD"
2020-04-29 07:52:07,608 - Recv: ok
2020-04-29 07:52:07,613 - Send: M23 /bereit~1/04_f95_1.gco
2020-04-29 07:52:07,624 - Recv: echo:Now fresh file: /bereit~1/04_f95_1.gco
2020-04-29 07:52:07,627 - Recv: open failed, File: bereit~1.
2020-04-29 07:52:07,628 - Recv: ok
2020-04-29 07:52:07,630 - Send: M24
2020-04-29 07:52:07,635 - Recv: ok
2020-04-29 07:52:07,636 - Changing monitoring state from "Starting print from SD" to "Printing from SD"
2020-04-29 07:52:07,806 - Recv:  T:19.30 /0.00 B:19.26 /0.00 @:0 B@:0
2020-04-29 07:52:08,503 - Send: M27
2020-04-29 07:52:08,510 - Recv: Not SD printing
2020-04-29 07:52:08,512 - Recv: ok
2020-04-29 07:52:09,504 - Send: M27
2020-04-29 07:52:09,516 - Recv: Not SD printing
2020-04-29 07:52:09,518 - Recv: ok
2020-04-29 07:52:09,807 - Recv:  T:19.30 /0.00 B:19.26 /0.00 @:0 B@:0
2020-04-29 07:52:10,506 - Send: M27
2020-04-29 07:52:10,512 - Recv: Not SD printing
2020-04-29 07:52:10,517 - Changing monitoring state from "Printing from SD" to "Cancelling"
2020-04-29 07:52:10,627 - Recv: ok
2020-04-29 07:52:10,632 - Send: M108
2020-04-29 07:52:10,636 - Recv: ok
2020-04-29 07:52:10,640 - Send: M84
2020-04-29 07:52:10,645 - Recv: ok
2020-04-29 07:52:10,647 - Send: M104 T0 S0
2020-04-29 07:52:10,652 - Recv: ok
2020-04-29 07:52:10,654 - Send: M140 S0
2020-04-29 07:52:10,659 - Recv: ok
2020-04-29 07:52:10,661 - Send: M106 S0
2020-04-29 07:52:10,665 - Recv: ok
2020-04-29 07:52:10,667 - Changing monitoring state from "Cancelling" to "Operational"
2020-04-29 07:52:11,507 - Send: M27
2020-04-29 07:52:11,514 - Recv: Not SD printing
2020-04-29 07:52:11,516 - Recv: ok
2020-04-29 07:52:11,808 - Recv:  T:19.37 /0.00 B:19.37 /0.00 @:0 B@:0
2020-04-29 07:52:12,508 - Send: M27
2020-04-29 07:52:12,514 - Recv: Not SD printing
2020-04-29 07:52:12,516 - Recv: ok
2020-04-29 07:52:13,510 - Send: M27
2020-04-29 07:52:13,521 - Recv: Not SD printing
2020-04-29 07:52:13,524 - Recv: ok
2020-04-29 07:52:13,810 - Recv:  T:19.26 /0.00 B:19.34 /0.00 @:0 B@:0
2020-04-29 07:52:14,511 - Send: M27
2020-04-29 07:52:14,517 - Recv: Not SD printing
2020-04-29 07:52:14,519 - Recv: ok
2020-04-29 07:52:15,512 - Send: M27
2020-04-29 07:52:15,523 - Recv: Not SD printing
2020-04-29 07:52:15,526 - Recv: ok
2020-04-29 07:52:15,811 - Recv:  T:19.37 /0.00 B:19.34 /0.00 @:0 B@:0
2020-04-29 07:52:16,513 - Send: M27
2020-04-29 07:52:16,520 - Recv: Not SD printing
2020-04-29 07:52:16,522 - Recv: ok
2020-04-29 07:52:17,514 - Send: M27
2020-04-29 07:52:17,528 - Recv: Not SD printing
2020-04-29 07:52:17,531 - Recv: ok
2020-04-29 07:52:17,811 - Recv:  T:19.26 /0.00 B:19.34 /0.00 @:0 B@:0
2020-04-29 07:52:18,516 - Send: M27
2020-04-29 07:52:18,522 - Recv: Not SD printing
2020-04-29 07:52:18,524 - Recv: ok
2020-04-29 07:52:19,517 - Send: M27
2020-04-29 07:52:19,527 - Recv: Not SD printing
2020-04-29 07:52:19,529 - Recv: ok
2020-04-29 07:52:19,814 - Recv:  T:19.34 /0.00 B:19.37 /0.00 @:0 B@:0
2020-04-29 07:52:20,518 - Send: M27
2020-04-29 07:52:20,525 - Recv: Not SD printing
2020-04-29 07:52:20,527 - Recv: ok
2020-04-29 07:52:21,519 - Send: M27
2020-04-29 07:52:21,530 - Recv: Not SD printing
2020-04-29 07:52:21,533 - Recv: ok
2020-04-29 07:52:21,814 - Recv:  T:19.30 /0.00 B:19.26 /0.00 @:0 B@:0
2020-04-29 07:52:22,193 - Changing monitoring state from "Operational" to "Starting print from SD"
2020-04-29 07:52:22,224 - Send: M23 /bereit~1/04_f95_1.gco
2020-04-29 07:52:22,235 - Recv: echo:Now fresh file: /bereit~1/04_f95_1.gco
2020-04-29 07:52:22,238 - Recv: open failed, File: bereit~1.
2020-04-29 07:52:22,239 - Recv: ok
2020-04-29 07:52:22,246 - Send: M24
2020-04-29 07:52:22,253 - Recv: ok
2020-04-29 07:52:22,255 - Changing monitoring state from "Starting print from SD" to "Printing from SD"
2020-04-29 07:52:22,520 - Send: M27
2020-04-29 07:52:22,525 - Recv: Not SD printing
2020-04-29 07:52:22,526 - Recv: ok
2020-04-29 07:52:23,522 - Send: M27
2020-04-29 07:52:23,537 - Recv: Not SD printing
2020-04-29 07:52:23,540 - Recv: ok
2020-04-29 07:52:23,815 - Recv:  T:19.26 /0.00 B:19.34 /0.00 @:0 B@:0
2020-04-29 07:52:24,523 - Send: M27
2020-04-29 07:52:24,530 - Recv: Not SD printing
2020-04-29 07:52:24,535 - Changing monitoring state from "Printing from SD" to "Cancelling"
2020-04-29 07:52:24,590 - Recv: ok
2020-04-29 07:52:24,596 - Send: M108
2020-04-29 07:52:24,603 - Recv: ok
2020-04-29 07:52:24,607 - Send: M84
2020-04-29 07:52:24,612 - Recv: ok
2020-04-29 07:52:24,616 - Send: M104 T0 S0
2020-04-29 07:52:24,622 - Recv: ok
2020-04-29 07:52:24,626 - Send: M140 S0
2020-04-29 07:52:24,631 - Recv: ok
2020-04-29 07:52:24,633 - Send: M106 S0
2020-04-29 07:52:24,638 - Recv: ok
2020-04-29 07:52:24,641 - Changing monitoring state from "Cancelling" to "Operational"
2020-04-29 07:52:25,525 - Send: M27
2020-04-29 07:52:25,531 - Recv: Not SD printing
2020-04-29 07:52:25,534 - Recv: ok
2020-04-29 07:52:25,815 - Recv:  T:19.30 /0.00 B:19.26 /0.00 @:0 B@:0
2020-04-29 07:52:26,526 - Send: M27
2020-04-29 07:52:26,542 - Recv: Not SD printing
2020-04-29 07:52:26,544 - Recv: ok
2020-04-29 07:52:27,531 - Send: M27
2020-04-29 07:52:27,538 - Recv: Not SD printing
2020-04-29 07:52:27,571 - Recv: ok
2020-04-29 07:52:27,815 - Recv:  T:19.34 /0.00 B:19.30 /0.00 @:0 B@:0
2020-04-29 07:52:28,532 - Send: M27
2020-04-29 07:52:28,538 - Recv: Not SD printing
2020-04-29 07:52:28,541 - Recv: ok
2020-04-29 07:52:29,535 - Send: M27
2020-04-29 07:52:29,542 - Recv: Not SD printing
2020-04-29 07:52:29,549 - Recv: ok
2020-04-29 07:52:29,816 - Recv:  T:19.18 /0.00 B:19.26 /0.00 @:0 B@:0
2020-04-29 07:52:30,536 - Send: M27
2020-04-29 07:52:30,543 - Recv: Not SD printing
2020-04-29 07:52:30,545 - Recv: ok
2020-04-29 07:52:31,538 - Send: M27
2020-04-29 07:52:31,549 - Recv: Not SD printing
2020-04-29 07:52:31,552 - Recv: ok
2020-04-29 07:52:31,816 - Recv:  T:19.34 /0.00 B:19.30 /0.00 @:0 B@:0
2020-04-29 07:52:32,539 - Send: M27
2020-04-29 07:52:32,545 - Recv: Not SD printing
2020-04-29 07:52:32,548 - Recv: ok
2020-04-29 07:52:33,540 - Send: M27
2020-04-29 07:52:33,551 - Recv: Not SD printing
2020-04-29 07:52:33,553 - Recv: ok
2020-04-29 07:52:33,827 - Recv:  T:19.30 /0.00 B:19.34 /0.00 @:0 B@:0
2020-04-29 07:52:34,542 - Send: M27
2020-04-29 07:52:34,547 - Recv: Not SD printing
2020-04-29 07:52:34,549 - Recv: ok
2020-04-29 07:52:35,545 - Send: M27
2020-04-29 07:52:35,556 - Recv: Not SD printing
2020-04-29 07:52:35,558 - Recv: ok
2020-04-29 07:52:35,827 - Recv:  T:19.37 /0.00 B:19.30 /0.00 @:0 B@:0
2020-04-29 07:52:36,546 - Send: M27
2020-04-29 07:52:36,552 - Recv: Not SD printing
2020-04-29 07:52:36,554 - Recv: ok
2020-04-29 07:52:37,548 - Send: M27
2020-04-29 07:52:37,559 - Recv: Not SD printing
2020-04-29 07:52:37,562 - Recv: ok
2020-04-29 07:52:37,828 - Recv:  T:19.34 /0.00 B:19.30 /0.00 @:0 B@:0
2020-04-29 07:52:38,549 - Send: M27
2020-04-29 07:52:38,555 - Recv: Not SD printing
2020-04-29 07:52:38,558 - Recv: ok
2020-04-29 07:52:39,551 - Send: M27
2020-04-29 07:52:39,562 - Recv: Not SD printing
2020-04-29 07:52:39,566 - Recv: ok
2020-04-29 07:52:39,830 - Recv:  T:19.22 /0.00 B:19.26 /0.00 @:0 B@:0
2020-04-29 07:52:40,552 - Send: M27
2020-04-29 07:52:40,559 - Recv: Not SD printing
2020-04-29 07:52:40,561 - Recv: ok
2020-04-29 07:52:41,553 - Send: M27
2020-04-29 07:52:41,565 - Recv: Not SD printing
2020-04-29 07:52:41,568 - Recv: ok
2020-04-29 07:52:41,829 - Recv:  T:19.26 /0.00 B:19.22 /0.00 @:0 B@:0

Thanks for your quick response to my topic

No worries :wink:

It seems like your printer confuses the folder bereit* with the file name.
Try it without folders - put the gcode file right in the root directory of the sd card.
I would also delete all folders (just to be sure)

1 Like

Now it all works just fine. Thanks a lot for your help :smile:

1 Like

I have the same issue with Marlin 1.1.9 and Octoprint 1.5.0 on a Creality 1.1.5 board. I understand moving the files out of a folder is a workaround, but is there a solution to be able to load a file within a folder on the SD card? I keep my bed leveling files in a separate folder for neatness, but cannot load them without the same errors, so moving them to the root directory isn't a viable option for me. Also, is this an OctoPrint bug or a firmware bug? I'd like to report it if so, but don't want to was anyone's time by putting it in the wrong one.

It's not an OctoPrint bug (unless your issue is different, in which case sigh as you should have provided the log too), since the log above indicates the error on the receiving end.

Before you report firmware bugs, you'll need to upgrade to the latest versions of the firmware. Marlin 1.1.9 is quite old, and if you report a bug I guarantee that will be the first thing anyone asks.

Just out of curiosity, are the folder names on the SD card short?
If not, what happens if they are renamed to be short?

(I believe short is 8 characters or less, i.e. 8.3 format for filenames and 8 for folder names)