Duet3 6XD based 3D printer freezes mid-print, then continues
-
Hi!
I am experiencing an issue, where my 3D printer performs well during the majority of the print, then at some point, it stops (both movements and extrusion), and after 5-10 seconds continues as if nothing happened. This can happen more than once, but the gaps between occurrences are fairly large, ie. 10-30 minutes.
This is not related to one specific gcode file (gcode looks alright) or part printed, and it occurs at different heights. My only suspicion is that the printer is processing a certain length of gcode and stops when it gets a new 'batch'.
I saw some similar posts asking about microstepping settings, here are mine:
M350 X32 Y32 Z32 E16 I0 ; microstepping with/without interpolation
Best regards,
AW -
@awitc what firmware version are you running?
best grab an M122 output when the issue next occurs -
M122 === Diagnostics === RepRapFirmware for Duet 3 MB6XD version 3.4.6 (2023-07-21 14:11:58) running on Duet 3 MB6XD v1.0 (SBC mode) Board ID: 08DLM-956DA-M24S4-7JKD0-3SJ6P-1BJLU Used output buffers: 1 of 40 (15 max) === RTOS === Static ram: 151692 Dynamic ram: 67564 of which 0 recycled Never used RAM 128416, free system stack 154 words Tasks: SBC(ready,0.7%,487) HEAT(notifyWait,0.1%,346) Move(notifyWait,0.3%,267) CanReceiv(notifyWait,0.0%,798) CanSender(notifyWait,0.0%,335) CanClock(delaying,0.0%,352) MAIN(running,98.8%,1125) IDLE(ready,0.1%,29), total 100.0% Owned mutexes: HTTP(MAIN) === Platform === Last reset 00:02:50 ago, cause: software Last software reset at 2023-09-06 11:57, reason: User, GCodes spinning, available RAM 128416, slot 1 Software reset code 0x0003 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00400000 BFAR 0x00000000 SP 0x00000000 Task SBC Freestk 0 n/a Error status: 0x00 Step timer max interval 18721 MCU temperature: min 36.3, current 36.6, max 36.8 Supply voltage: min 23.9, current 23.9, max 24.0, under voltage events: 0, over voltage events: 0, power good: yes 12V rail voltage: min 11.8, current 11.9, max 12.3, under voltage events: 0 Heap OK, handles allocated/used 99/3, heap memory allocated/used/recyclable 2048/44/0, gc cycles 0 Events: 0 queued, 0 completed Driver 0: ok Driver 1: ok Driver 2: ok Driver 3: ok Driver 4: ok Driver 5: ok Date/time: 2023-09-06 12:00:47 Slowest loop: 53.01ms; fastest: 0.04ms === Storage === Free file entries: 10 SD card 0 not detected, interface speed: 37.5MBytes/sec SD card longest read time 0.0ms, write time 0.0ms, max retries 0 === Move === DMs created 125, segments created 6, maxWait 60052ms, bed compensation in use: none, comp offset 0.000 === MainDDARing === Scheduled moves 291, completed 291, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 2], CDDA state -1 === AuxDDARing === Scheduled moves 0, completed 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1 === Heat === Bed heaters 8 -1 -1 -1 -1 -1 -1 -1 -1 -1 -1 -1, chamber heaters -1 -1 -1 -1, ordering errs 0 Heater 1 is on, I-accum = 0.3 Heater 2 is on, I-accum = 0.3 Heater 3 is on, I-accum = 0.3 Heater 4 is on, I-accum = 0.0 Heater 5 is on, I-accum = 0.0 Heater 6 is on, I-accum = 0.0 Heater 8 is on, I-accum = 0.1 === GCodes === Segments left: 0 Movement lock held by null HTTP* is doing "M122" in state(s) 0 Telnet is idle in state(s) 0 File* is doing "G1 X211.673004 Y236.014999 Z2.770000 E0.691060" in state(s) 0 USB is idle in state(s) 0 Aux is idle in state(s) 0 Trigger* is idle in state(s) 0 Queue* is idle in state(s) 0 LCD is idle in state(s) 0 SBC is idle in state(s) 0 Daemon* is doing "G4 S1" in state(s) 0 0, running macro Aux2 is idle in state(s) 0 Autopause is idle in state(s) 0 Code queue is empty === CAN === Messages queued 1177, received 2085, lost 0, boc 0 Longest wait 1ms for reply type 6013, peak Tx sync delay 8, free buffers 50 (min 49), ts 649/649/0 Tx timeouts 0,0,0,0,0,0 === SBC interface === Transfer state: 5, failed transfers: 0, checksum errors: 0 RX/TX seq numbers: 7327/7327 SPI underruns 0, overruns 0 State: 5, disconnects: 0, timeouts: 0 total, 0 by SBC, IAP RAM available 0x2b55c Buffer RX/TX: 1704/3216-0, open files: 0 === Duet Control Server === Duet Control Server v3.4.6 File /opt/dsf/sd/gcodes/correct_temps.gcode is selected, processing HTTP: Buffered code: M25 ==> 24 bytes File: Buffered code: G1 X211.673 Y236.015 Z2.77 E0.69106 Buffered code: G1 X211.01 Y235.162 Z2.78 E0.67377 Buffered code: G1 X210.404 Y234.269 Z2.79 E0.67305 Buffered code: G1 X209.849 Y233.331 Z2.8 E0.67972 Buffered code: G1 X209.358 Y232.367 Z2.81 E0.67469 Buffered code: G1 X208.929 Y231.375 Z2.82 E0.67404 Buffered code: G1 X208.555 Y230.336 Z2.83 E0.68868 Buffered code: G1 X208.256 Y229.308 Z2.84 E0.66768 Buffered code: G1 X208.017 Y228.242 Z2.85 E0.68132 Buffered code: G1 X207.848 Y227.172 Z2.86 E0.67558 Buffered code: G1 X207.745 Y226.087 Z2.87 E0.67971 Buffered code: G1 X207.711 Y225 Z2.88 E0.67824 Buffered code: G1 X207.745 Y223.912 Z2.89 E0.67887 Buffered code: G1 X207.847 Y222.831 Z2.9 E0.67716 Buffered code: G1 X208.016 Y221.76 Z2.91 E0.6762 Buffered code: G1 X208.255 Y220.694 Z2.92 E0.68132 Buffered code: G1 X208.554 Y219.666 Z2.93 E0.66768 Buffered code: G1 X208.928 Y218.627 Z2.94 E0.68868 Buffered code: G1 X209.357 Y217.635 Z2.95 E0.67404 Buffered code: G1 X209.848 Y216.671 Z2.96 E0.67469 Buffered code: G1 X210.403 Y215.733 Z2.97 E0.67972 Buffered code: G1 X211.009 Y214.84 Z2.98 E0.67305 Buffered code: G1 X211.672 Y213.987 Z2.99 E0.67377 Buffered code: G1 X212.404 Y213.154 Z3 E0.69158 Buffered code: ;LAYER:2 Buffered code: ;MESH:budVase.stl Buffered code: G1 X213.15 Y212.399 Z3.01 E0.66194 ==> 1488 bytes Pending code: G1 X213.977 Y211.661 Z3.02 E0.69126 Pending code: G1 X214.828 Y210.992 Z3.029 E0.67509 Pending code: G1 X215.718 Y210.38 Z3.039 E0.67362 Daemon: Buffered code: G4 S1 ==> 32 bytes Executing macro daemon.g, started by system Number of flush requests: 1 > Next stack level Code buffer space: 1704 Configured SPI speed: 8000000Hz, TfrRdy pin glitches: 0 Full transfers per second: 39.45, max time between full transfers: 38.9ms, max pin wait times: 34.1ms/0.1ms Codes per second: 2.73 Maximum length of RX/TX data transfers: 3778/1664
-
After a second occurence during the same print:
M122 === Diagnostics === RepRapFirmware for Duet 3 MB6XD version 3.4.6 (2023-07-21 14:11:58) running on Duet 3 MB6XD v1.0 (SBC mode) Board ID: 08DLM-956DA-M24S4-7JKD0-3SJ6P-1BJLU Used output buffers: 1 of 40 (15 max) === RTOS === Static ram: 151692 Dynamic ram: 67564 of which 0 recycled Never used RAM 128416, free system stack 154 words Tasks: SBC(ready,0.8%,487) HEAT(notifyWait,0.1%,346) Move(notifyWait,1.4%,250) CanReceiv(notifyWait,0.0%,798) CanSender(notifyWait,0.0%,335) CanClock(delaying,0.0%,349) MAIN(running,97.7%,1125) IDLE(ready,0.0%,29), total 100.0% Owned mutexes: HTTP(MAIN) === Platform === Last reset 00:10:45 ago, cause: software Last software reset at 2023-09-06 11:57, reason: User, GCodes spinning, available RAM 128416, slot 1 Software reset code 0x0003 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00400000 BFAR 0x00000000 SP 0x00000000 Task SBC Freestk 0 n/a Error status: 0x00 Step timer max interval 18554 MCU temperature: min 36.5, current 37.4, max 37.6 Supply voltage: min 23.9, current 23.9, max 24.0, under voltage events: 0, over voltage events: 0, power good: yes 12V rail voltage: min 11.8, current 11.9, max 12.3, under voltage events: 0 Heap OK, handles allocated/used 99/3, heap memory allocated/used/recyclable 2048/44/0, gc cycles 0 Events: 0 queued, 0 completed Driver 0: ok Driver 1: ok Driver 2: ok Driver 3: ok Driver 4: ok Driver 5: ok Date/time: 2023-09-06 12:08:42 Slowest loop: 49.69ms; fastest: 0.04ms === Storage === Free file entries: 10 SD card 0 not detected, interface speed: 37.5MBytes/sec SD card longest read time 0.0ms, write time 0.0ms, max retries 0 === Move === DMs created 125, segments created 6, maxWait 69618ms, bed compensation in use: none, comp offset 0.000 === MainDDARing === Scheduled moves 5478, completed 5451, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 2], CDDA state 3 === AuxDDARing === Scheduled moves 0, completed 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1 === Heat === Bed heaters 8 -1 -1 -1 -1 -1 -1 -1 -1 -1 -1 -1, chamber heaters -1 -1 -1 -1, ordering errs 0 Heater 1 is on, I-accum = 0.2 Heater 2 is on, I-accum = 0.1 Heater 3 is on, I-accum = 0.2 Heater 4 is on, I-accum = 0.0 Heater 5 is on, I-accum = 0.0 Heater 6 is on, I-accum = 0.0 Heater 8 is on, I-accum = 0.2 === GCodes === Segments left: 1 Movement lock held by null HTTP* is doing "M122" in state(s) 0 Telnet is idle in state(s) 0 File* is doing "G1 X217.852005 Y226.837006 Z56.861000 E0.577180" in state(s) 0 USB is idle in state(s) 0 Aux is idle in state(s) 0 Trigger* is idle in state(s) 0 Queue* is idle in state(s) 0 LCD is idle in state(s) 0 SBC is idle in state(s) 0 Daemon* is doing "G4 S1" in state(s) 0 0, running macro Aux2 is idle in state(s) 0 Autopause is idle in state(s) 0 Code queue is empty === CAN === Messages queued 4277, received 7604, lost 0, boc 0 Longest wait 0ms for reply type 0, peak Tx sync delay 9, free buffers 50 (min 50), ts 2376/2376/0 Tx timeouts 0,0,0,0,0,0 === SBC interface === Transfer state: 5, failed transfers: 0, checksum errors: 0 RX/TX seq numbers: 26042/26042 SPI underruns 0, overruns 0 State: 5, disconnects: 0, timeouts: 0 total, 0 by SBC, IAP RAM available 0x2b55c Buffer RX/TX: 1512/2968-0, open files: 0 === Duet Control Server === Duet Control Server v3.4.6 File /opt/dsf/sd/gcodes/correct_temps.gcode is selected, processing File: Buffered code: G1 X217.852 Y226.837 Z56.861 E0.57718 Buffered code: G1 X217.681 Y225.923 Z56.881 E0.58002 Buffered code: G1 X217.639 Y225.463 Z56.891 E0.28813 Buffered code: G1 X217.641 Y224.539 Z56.911 E0.57637 Buffered code: G1 X217.761 Y223.613 Z56.931 E0.58244 Buffered code: G1 X217.863 Y223.164 Z56.94 E0.2872 Buffered code: G1 X218.152 Y222.289 Z56.96 E0.5748 Buffered code: G1 X218.545 Y221.46 Z56.98 E0.57227 Buffered code: G1 X219.051 Y220.667 Z57 E0.58677 Buffered code: ;LAYER:56 Buffered code: ;MESH:budVase.stl Buffered code: G1 X219.647 Y219.972 Z57.02 E0.5711 Buffered code: G1 X219.976 Y219.627 Z57.03 E0.29736 Buffered code: G1 X220.677 Y219.052 Z57.05 E0.56555 Buffered code: G1 X221.455 Y218.562 Z57.07 E0.57353 Buffered code: G1 X221.871 Y218.365 Z57.08 E0.28712 Buffered code: G1 X222.73 Y218.026 Z57.1 E0.57604 Buffered code: G1 X223.621 Y217.8 Z57.121 E0.5734 Buffered code: G1 X224.536 Y217.673 Z57.141 E0.57622 Buffered code: G1 X225.452 Y217.675 Z57.161 E0.57138 Buffered code: G1 X226.373 Y217.792 Z57.181 E0.57911 Buffered code: G1 X227.266 Y218.036 Z57.201 E0.57745 Buffered code: G1 X228.121 Y218.378 Z57.221 E0.57441 Buffered code: G1 X228.533 Y218.578 Z57.231 E0.28568 Buffered code: G1 X229.309 Y219.072 Z57.251 E0.57381 Buffered code: G1 X230.027 Y219.672 Z57.272 E0.58367 Buffered code: G1 X230.324 Y219.983 Z57.281 E0.26824 ==> 1488 bytes Pending code: G1 X230.922 Y220.694 Z57.302 E0.57953 Pending code: G1 X231.412 Y221.472 Z57.322 E0.57353 Pending code: G1 X231.611 Y221.883 Z57.332 E0.28484 Daemon: Buffered code: G4 S1 ==> 32 bytes Executing macro daemon.g, started by system Number of flush requests: 1 > Next stack level Code buffer space: 1376 Configured SPI speed: 8000000Hz, TfrRdy pin glitches: 0 Full transfers per second: 39.38, max time between full transfers: 47.7ms, max pin wait times: 47.1ms/2.2ms Codes per second: 11.33 Maximum length of RX/TX data transfers: 3778/1664
-
@awitc one for @chrishamm
-
-
Thanks for the replies, I have ordered a new SD card, it has 200/90 MB/s speeds:
Will give an update after I get the card.
-
I've changed the SD card for the new one, however, during the first test print the issue occured again, here is the M122 result, done right after it paused and resumed:
8.09.2023, 12:34:59 M122 === Diagnostics === RepRapFirmware for Duet 3 MB6XD version 3.4.6 (2023-07-21 14:11:58) running on Duet 3 MB6XD v1.0 (SBC mode) Board ID: 08DLM-956DA-M24S4-7JKD0-3SJ6P-1BJLU Used output buffers: 1 of 40 (15 max) === RTOS === Static ram: 151692 Dynamic ram: 67564 of which 0 recycled Never used RAM 128416, free system stack 154 words Tasks: SBC(ready,0.6%,487) HEAT(notifyWait,0.1%,346) Move(notifyWait,0.2%,252) CanReceiv(notifyWait,0.0%,798) CanSender(notifyWait,0.0%,335) CanClock(delaying,0.0%,349) MAIN(running,99.0%,1232) IDLE(ready,0.1%,29), total 100.0% Owned mutexes: HTTP(MAIN) === Platform === Last reset 00:20:18 ago, cause: software Last software reset at 2023-09-08 12:14, reason: User, GCodes spinning, available RAM 131648, slot 1 Software reset code 0x0003 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00400000 BFAR 0x00000000 SP 0x00000000 Task SBC Freestk 0 n/a Error status: 0x00 Step timer max interval 18681 MCU temperature: min 37.3, current 39.0, max 39.1 Supply voltage: min 23.9, current 23.9, max 24.0, under voltage events: 0, over voltage events: 0, power good: yes 12V rail voltage: min 11.8, current 12.2, max 12.4, under voltage events: 0 Heap OK, handles allocated/used 99/3, heap memory allocated/used/recyclable 2048/54/10, gc cycles 0 Events: 0 queued, 0 completed Driver 0: ok Driver 1: ok Driver 2: ok Driver 3: ok Driver 4: ok Driver 5: ok Date/time: 2023-09-08 12:34:58 Slowest loop: 55.53ms; fastest: 0.03ms === Storage === Free file entries: 10 SD card 0 not detected, interface speed: 37.5MBytes/sec SD card longest read time 0.0ms, write time 0.0ms, max retries 0 === Move === DMs created 125, segments created 6, maxWait 551121ms, bed compensation in use: none, comp offset 0.000 === MainDDARing === Scheduled moves 1345, completed 1320, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 1], CDDA state 3 === AuxDDARing === Scheduled moves 0, completed 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1 === Heat === Bed heaters 8 -1 -1 -1 -1 -1 -1 -1 -1 -1 -1 -1, chamber heaters -1 -1 -1 -1, ordering errs 0 Heater 1 is on, I-accum = 0.3 Heater 2 is on, I-accum = 0.2 Heater 3 is on, I-accum = 0.3 Heater 4 is on, I-accum = 0.0 Heater 5 is on, I-accum = 0.0 Heater 6 is on, I-accum = 0.0 Heater 8 is on, I-accum = 0.1 === GCodes === Segments left: 1 Movement lock held by null HTTP* is doing "M122" in state(s) 0 Telnet is idle in state(s) 0 File* is doing "G1 X244.630997 Y217.218002 Z13.319000 E0.823970" in state(s) 0 USB is idle in state(s) 0 Aux is idle in state(s) 0 Trigger* is idle in state(s) 0 Queue* is idle in state(s) 0 LCD is idle in state(s) 0 SBC is idle in state(s) 0 Daemon* is doing "G4 S30" in state(s) 0 0, running macro Aux2 is idle in state(s) 0 Autopause is idle in state(s) 0 Code queue is empty === CAN === Messages queued 10972, received 19471, lost 0, boc 0 Longest wait 1ms for reply type 6018, peak Tx sync delay 389, free buffers 50 (min 49), ts 6091/6090/0 Tx timeouts 0,0,0,0,0,0 === SBC interface === Transfer state: 5, failed transfers: 0, checksum errors: 0 RX/TX seq numbers: 33732/33732 SPI underruns 0, overruns 0 State: 5, disconnects: 1, timeouts: 1 total, 1 by SBC, IAP RAM available 0x2b584 Buffer RX/TX: 3616/1704-3688, open files: 0 === Duet Control Server === Duet Control Server v3.4.6 File /opt/dsf/sd/gcodes/CFFFP_budVase.gcode is selected, processing File: Buffered code: G1 X244.631 Y217.218 Z13.319 E0.82397 Buffered code: G1 X245.087 Y218.482 Z13.33 E0.83802 Buffered code: G1 X245.455 Y219.748 Z13.34 E0.82221 Buffered code: G1 X245.745 Y221.039 Z13.349 E0.82518 Buffered code: G1 X245.954 Y222.354 Z13.36 E0.83039 Buffered code: G1 X246.08 Y223.673 Z13.369 E0.82633 Buffered code: G1 X246.122 Y225 Z13.379 E0.82799 Buffered code: G1 X246.082 Y226.327 Z13.389 E0.82795 Buffered code: G1 X245.958 Y227.647 Z13.399 E0.82684 Buffered code: G1 X245.751 Y228.962 Z13.41 E0.8302 Buffered code: G1 X245.464 Y230.253 Z13.419 E0.82478 Buffered code: G1 X245.096 Y231.522 Z13.429 E0.82401 Buffered code: G1 X244.642 Y232.786 Z13.44 E0.8376 Buffered code: G1 X244.117 Y234 Z13.45 E0.82487 Buffered code: G1 X243.524 Y235.166 Z13.459 E0.81581 Buffered code: G1 X242.837 Y236.33 Z13.47 E0.84293 Buffered code: G1 X242.102 Y237.413 Z13.479 E0.81626 Buffered code: G1 X241.275 Y238.48 Z13.49 E0.84191 Buffered code: G1 X240.412 Y239.46 Z13.499 E0.81437 Buffered code: G1 X239.469 Y240.408 Z13.509 E0.8339 Buffered code: G1 X238.476 Y241.283 Z13.519 E0.8254 Buffered code: G1 X237.416 Y242.106 Z13.53 E0.83693 Buffered code: G1 X236.334 Y242.842 Z13.539 E0.81609 Buffered code: G1 X235.17 Y243.532 Z13.55 E0.84389 Buffered code: G1 X234.004 Y244.127 Z13.559 E0.81637 Buffered code: G1 X232.79 Y244.653 Z13.569 E0.82512 Buffered code: G1 X231.527 Y245.109 Z13.58 E0.83743 ==> 1512 bytes Pending code: G1 X230.257 Y245.479 Z13.59 E0.82496 Pending code: G1 X228.966 Y245.768 Z13.599 E0.82505 Pending code: G1 X227.649 Y245.978 Z13.61 E0.83172 Pending code: G1 X226.328 Y246.104 Z13.62 E0.82757 Pending code: G1 X225 Y246.146 Z13.63 E0.82861 Daemon: Buffered code: G4 S30 ; wait 30 seconds Buffered code: M106 P3 S0 ; disable fans Buffered code: G4 S1 ==> 104 bytes Executing macro daemon.g, started by system Number of flush requests: 1 > Next stack level Code buffer space: 1856 Configured SPI speed: 8000000Hz, TfrRdy pin glitches: 0 Full transfers per second: 38.67, max time between full transfers: 74.3ms, max pin wait times: 64.8ms/5.6ms Codes per second: 1.87 Maximum length of RX/TX data transfers: 3772/1392
-
I tried such microsteps:
M350 X16 Y16 Z16 E16 I1
but the same problem, back to back, in short time interval, in the middle of the print. Also I find the printer to be way louder in this interpolation mode.
-
-
I might have tracked the issue down, asked a question with more information here. If my daemon.g was the culprit, sorry for the waste of time.
-