1LC - extruder randomly stopping/reversing - ≤3.5.0-rc1

Exerqtor · 8 Dec 2023, 19:00

Starting up a new post about this since this issue (1 & 2) apparently isn't fully patched out (or have been re-introduced in rc1).

I started mentioning this in the "random reboot/crash thread", but for the sake of trying to keep that thread on track that I've moved this issue over to this thread.

HW/SW setup: Duet Mini 5+ v1.02, Duet 1LC v1.2 running RRF 3.5.0-rc1+ in standalone mode, FW retraction, Pressure advance & Input shaping enabled

@Exerqtor said in Reboots/crashes - RRF 3.5.0-rc1:

@dc42

Had something interesting just happen, while running a print on that new build you gave me earlier today (with the WiFi module disabled), I suddenly got what seems to be the same toolboard bug that was intruduced and patched out a whille back where it stops extruding and ends up retracting instead!

I ran a M122 & M122 B121 while this was happening before i canceled the print:

 M122
=== Diagnostics ===
RepRapFirmware for Duet 3 Mini 5+ version 3.5.0-rc.1+ (2023-12-07 09:49:06) running on Duet 3 Mini5plus WiFi (standalone mode)
Board ID: XNHXF-HR6KL-K65J0-409N2-K9W1Z-RV2MZ
Used output buffers: 1 of 40 (40 max)
=== RTOS ===
Static ram: 102844
Dynamic ram: 128036 of which 0 recycled
Never used RAM 5752, free system stack 118 words
Tasks: NETWORK(1,ready,77.5%,195) HEAT(3,nWait,0.2%,328) Move(4,nWait,11.5%,241) CanReceiv(6,nWait,0.4%,774) CanSender(5,nWait,0.3%,327) CanClock(7,delaying,0.1%,350) TMC(4,nWait,5.7%,74) MAIN(1,running,150.3%,580) IDLE(0,ready,0.7%,29) AIN(4,delaying,6.6%,264), total 253.2%
Owned mutexes: WiFi(NETWORK)
=== Platform ===
Last reset 07:24:04 ago, cause: software
Last software reset at 2023-12-07 06:59, reason: AssertionFailed, Gcodes spinning, available RAM 13540, slot 0
Software reset code 0x4123 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00000000 BFAR 0xe000ed38 SP 0x20011fbc Task NETW Freestk 495 ok
Stack: 00000913 000af408 0002de53 2002bed4 2002be01 000001a8 2002c100 20031d28 2002c118 2001e888 a5a5a5a5 a5a5a5a5 362e303d 00000000 00000000 00000000 20031d34 00000800 20035a28 2002c100 20018678 2002bf9d 20018678 2001e888 000300db 00000000 00000000
Error status: 0x04
Aux0 errors 0,1,0
MCU revision 3, ADC conversions started 26644948, completed 26644948, timed out 0, errs 0
MCU temperature: min 39.5, current 46.2, max 47.0
Supply voltage: min 5.1, current 24.0, max 24.6, under voltage events: 0, over voltage events: 0, power good: yes
Heap OK, handles allocated/used 198/34, heap memory allocated/used/recyclable 2048/1260/776, gc cycles 1354
Events: 1 queued, 1 completed
Driver 0: ok, SG min 0, read errors 0, write errors 1, ifcnt 76, reads 25633, writes 82, timeouts 0, DMA errors 0, CC errors 0
Driver 1: ok, SG min 0, read errors 0, write errors 1, ifcnt 76, reads 25632, writes 83, timeouts 0, DMA errors 0, CC errors 0
Driver 2: standstill, SG min 0, read errors 0, write errors 1, ifcnt 192, reads 25677, writes 38, timeouts 0, DMA errors 0, CC errors 0
Driver 3: standstill, SG min 0, read errors 0, write errors 1, ifcnt 192, reads 25677, writes 37, timeouts 0, DMA errors 0, CC errors 0
Driver 4: standstill, SG min 0, read errors 0, write errors 1, ifcnt 189, reads 25678, writes 37, timeouts 0, DMA errors 0, CC errors 0
Driver 5: not present
Driver 6: not present
Date/time: 2023-12-07 18:33:40
Cache data hit count 4294967295
Slowest loop: 235.32ms; fastest: 0.09ms
=== Storage ===
Free file entries: 16
SD card 0 detected, interface speed: 22.5MBytes/sec
SD card longest read time 10.0ms, write time 30.2ms, max retries 0
=== Move ===
DMs created 83, segments created 47, maxWait 2831509ms, bed compensation in use: mesh, height map offset 0.000, ebfmin 0.00, ebfmax 0.00
next step interrupt due in 17 ticks, enabled
Moves shaped first try 37104, on retry 9435, too short 18092, wrong shape 217112, maybepossible 5892
=== DDARing 0 ===
Scheduled moves 72372, completed 72332, hiccups 0, stepErrors 0, LaErrors 1446, Underruns [0, 0, 2], CDDA state 3
=== DDARing 1 ===
Scheduled moves 0, completed 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1
=== Heat ===
Bed heaters 0 -1 -1 -1, chamber heaters -1 -1 -1 -1, ordering errs 0
Heater 0 is on, I-accum = 0.4
Heater 1 is on, I-accum = 0.0
=== GCodes ===
Movement locks held by null, null
HTTP is idle in state(s) 0
Telnet is idle in state(s) 0
File is doing "G1 X175.056 Y124.432 E.01578" 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
File2 is idle in state(s) 0, sync state 1
Queue2 is idle in state(s) 0
Q0 segments left 1, axes/extruders owned 0x0000807
Queue 0 has 'M106 S255' for move 72370
Q1 segments left 0, axes/extruders owned 0x0000000
Code queue 1 is empty
=== Filament sensors ===
in 0 notIn 0
Extruder 0 sensor: no filament
=== CAN ===
Messages queued 581746, received 549305, lost 0, errs 1, boc 0
Longest wait 3ms for reply type 6029, peak Tx sync delay 533, free buffers 26 (min 24), ts 133223/133222/0
Tx timeouts 0,0,0,0,0,0
=== Network ===
Slowest loop: 205.33ms; fastest: 0.00ms
Responder states: MQTT(0) HTTP(0) HTTP(0) HTTP(0) HTTP(0) FTP(0) Telnet(0)
HTTP sessions: 2 of 8
=== WiFi ===
Interface state: active
Module is connected to access point 
Failed messages: pending 0, notrdy 0, noresp 0
Firmware version 2.1beta4
MAC address c4:5b:be:ce:91:93
Module reset reason: Power up, Vcc 3.37, flash size 2097152, free heap 42960
WiFi IP address 192.168.10.x
Signal strength -58dBm, channel 6, mode 802.11n, reconnections 0
Clock register 00002001
Socket states: 0 0 0 0 0 0 0 0

 M122 B121
Diagnostics for board 121:
Duet TOOL1LC rev 1.1 or later firmware version 3.5.0-rc.1+ (2023-11-21 09:48:16)
Bootloader ID: SAMC21 bootloader version 2.4 (2021-12-10)
All averaging filters OK
Never used RAM 2364, free system stack 89 words
Tasks: Move(3,nWait,2.3%,71) HEAT(2,nWait,2.6%,91) CanAsync(5,nWait,0.0%,55) CanRecv(3,nWait,0.6%,77) CanClock(5,nWait,0.1%,67) ACCEL(3,nWait,0.0%,53) TMC(2,delaying,22.2%,57) MAIN(1,running,37.1%,316) IDLE(0,ready,0.0%,27) AIN(2,delaying,35.0%,114), total 100.0%
Last reset 07:24:21 ago, cause: software
Last software reset data not available
Driver 0: pos 0, 568.8 steps/mm, standstill, SG min 0, read errors 4, write errors 1, ifcnt 94, reads 57047, writes 26, timeouts 10, DMA errors 0, CC errors 0, failedOp 0x6c, steps req 0 done 39783642
Moves scheduled 283066, completed 283066, in progress 0, hiccups 839, segs 51, step errors 0, maxPrep 1124, maxOverdue 5537, maxInc 1554, mcErrs 0, gcmErrs 0, ebfmin -1.00 max inf
Peak sync jitter -3/15, peak Rx sync delay 267, resyncs 0/0, no timer interrupt scheduled
VIN voltage: min 6.3, current 24.0, max 34.7
MCU temperature: min 53.8C, current 76.8C, max 78.8C
Last sensors broadcast 0x00000012 found 2 57 ticks ago, 0 ordering errs, loop time 0
CAN messages queued 549472, send timeouts 7, received 582102, lost 0, errs 40685, boc 0, free buffers 18, min 17, error reg 110000
Last cancelled message type 4519 dest 0
dup 0, oos 0/0/0/0, bm 0, wbm 0, rxMotionDelay 396, adv 31230/74659
Accelerometer: LIS3DH, status: 00
Inductive sensor: not found
I2C bus errors 0, naks 6, contentions 0, other errors 0
=== Filament sensors ===
Interrupt 5726621 to 0us, poll 4 to 2846us
Driver 0: ok

I tried pausing, manually extruding while paused via PanelDue which did work, resumed and it still wouldn't extrude while printing (did this 2-3 times before canceling).

@Exerqtor said in Reboots crashes - RRF 3.5.0-rc1:

I just tried the same print again, and the extruder going backwards issue is 100% back with the newest build you gave me. This time it "stopped" extruding at a totally different time (earlier) than before.

EDIT 1: I've reverted to this build now. Trying the same print another time to see if it completes on that.

EDIT 2: Turns out it shits the bed on that build to.

Here is some M122 reports while the print is going with the issue ongoing:

 M122
=== Diagnostics ===
RepRapFirmware for Duet 3 Mini 5+ version 3.5.0-rc.1+ (2023-12-06 12:09:26) running on Duet 3 Mini5plus WiFi (standalone mode)
Board ID: XNHXF-HR6KL-K65J0-409N2-K9W1Z-RV2MZ
Used output buffers: 14 of 40 (40 max)
=== RTOS ===
Static ram: 102844
Dynamic ram: 128692 of which 0 recycled
Never used RAM 5312, free system stack 122 words
Tasks: NETWORK(2,nWait,23.3%,173) HEAT(3,nWait,0.0%,328) Move(4,nWait,2.6%,243) CanReceiv(6,nWait,0.1%,797) CanSender(5,nWait,0.1%,336) CanClock(7,delaying,0.0%,350) TMC(4,nWait,0.8%,74) MAIN(1,running,68.0%,601) IDLE(0,ready,4.2%,29) AIN(4,delaying,1.0%,264), total 100.0%
Owned mutexes: WiFi(NETWORK)
=== Platform ===
Last reset 00:16:32 ago, cause: software
Last software reset at 2023-12-08 10:42, reason: User, Gcodes spinning, available RAM 13108, slot 0
Software reset code 0x0003 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00000000 BFAR 0xe000ed38 SP 0x00000000 Task MAIN Freestk 0 n/a
Error status: 0x04
Aux0 errors 0,0,0
MCU revision 3, ADC conversions started 992190, completed 992188, timed out 0, errs 0
MCU temperature: min 46.0, current 46.2, max 46.7
Supply voltage: min 23.7, current 24.0, max 24.4, under voltage events: 0, over voltage events: 0, power good: yes
Heap OK, handles allocated/used 198/28, heap memory allocated/used/recyclable 2048/1144/744, gc cycles 1563
Events: 1 queued, 1 completed
Driver 0: ok, SG min 0, read errors 0, write errors 0, ifcnt 245, reads 6087, writes 0, timeouts 0, DMA errors 0, CC errors 0
Driver 1: ok, SG min 0, read errors 0, write errors 0, ifcnt 245, reads 6087, writes 0, timeouts 0, DMA errors 0, CC errors 0
Driver 2: ok, SG min 0, read errors 0, write errors 0, ifcnt 42, reads 6087, writes 0, timeouts 0, DMA errors 0, CC errors 0
Driver 3: ok, SG min 0, read errors 0, write e ok, SG min 0, read errors 0, write errors 0, ifcnt 42, reads 6086, writes 0, timeouts 0rrors 0, ifcnt 45, reads 6087, writes 0, timeouts 0, DMA errors 0, CC errors 0
Driver 4: ok, SG min 0, read errors 0, write errors 0, ifcnt 42, reads 6086, writes 0, timeouts 0, DMA errors 0, CC errors 0
Driver 5: not present
Driver 6: not present
Date/time: 2023-12-08 13:45:36
Cache data hit count 1628047615
Slowest loop: 40.69ms; fastest: 0.11ms
=== Storage ===
Free file entries: 16
SD card 0 detected, interface speed: 22.5MBytes/sec
SD card longest read time 11.2ms, write time 1.2ms, max retries 0
=== Move ===
DMs created 83, segments created 38, maxWait 247ms, bed compensation in use: mesh, height map offset 0.000, ebfmin 0.00, ebfmax 0.00
next step interrupt due in 15 ticks, enabled
Moves shaped first try 409, on retry 93, too short 65, wrong shape 1839, maybepossible 55
=== DDARing 0 ===
Scheduled moves 9177, completed 9137, hiccups 0, stepErrors 0, LaErrors 2, Underruns [0, 0, 0], CDDA state 3
=== DDARing 1 ===
Scheduled moves 0, completed 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1
=== Heat ===
Bed heaters 0 -1 -1 -1, chamber heaters -1 -1 -1 -1, ordering errs 0
Heater 0 is on, I-accum = 0.4
Heater 1 is on, I-accum = 0.0
=== GCodes ===
Movement locks held by null, null
HTTP is idle in state(s) 0
Telnet is idle in state(s) 0
File is doing "G2 X168.376 Y211.552 I-.644 J-.16 E.01687" 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 P10" in state(s) 0 0, running macro
Aux2 is idle in state(s) 0
Autopause is idle in state(s) 0
File2 is idle in state(s) 0, sync state 1
Queue2 is idle in state(s) 0
Q0 segments left 0, axes/extruders owned 0x0000807
Code queue 0 is empty
Q1 segments left 0, axes/extruders owned 0x0000000
Code queue 1 is empty
=== Filament sensors ===
in 0 notIn 0
Extruder 0 sensor: no filament
=== CAN ===
Messages queued 3948, received 2408, lost 0, errs 0, boc 0
Longest wait 7ms for reply type 6024, peak Tx sync delay 141, free buffers 26 (min 24), ts 578/578/0
Tx timeouts 0,0,0,0,0,0
=== Network ===
Slowest loop: 19.83ms; fastest: 0.07ms
Responder states: MQTT(0) HTTP(2) HTTP(2) HTTP(0) HTTP(0) FTP(0) Telnet(0)
HTTP sessions: 3 of 8
=== WiFi ===
Interface state: active
Module is connected to access point 
Failed messages: pending 0, notrdy 0, noresp 0
Firmware version 2.1beta4
MAC address c4:5b:be:ce:91:93
Module reset reason: Power up, Vcc 3.38, flash size 2097152, free heap 39540
WiFi IP address 192.168.10.x
Signal strength -51dBm, channel

 M122 B121
Diagnostics for board 121:
Duet TOOL1LC rev 1.1 or later firmware version 3.5.0-rc.1+ (2023-11-21 09:48:16)
Bootloader ID: SAMC21 bootloader version 2.4 (2021-12-10)
All averaging filters OK
Never used RAM 2748, free system stack 89 words
Tasks: Move(3,nWait,0.7%,71) HEAT(2,nWait,0.4%,95) CanAsync(5,nWait,0.0%,55) CanRecv(3,nWait,0.2%,77) CanClock(5,nWait,0.0%,67) ACCEL(3,nWait,0.0%,53) TMC(2,delaying,3.0%,57) MAIN(1,running,90.9%,316) IDLE(0,ready,0.0%,27) AIN(2,delaying,4.8%,114), total 100.0%
Last reset 00:16:49 ago, cause: software
Last software reset data not available
Driver 0: pos 0, 568.8 steps/mm, standstill, SG min 0, read errors 0, write errors 0, ifcnt 148, reads 59435, writes 0, timeouts 0, DMA errors 0, CC errors 0, steps req 0 done 41820
Moves scheduled 3953, completed 3953, in progress 0, hiccups 1, segs 35, step errors 0, maxPrep 888, maxOverdue 0, maxInc 0, mcErrs 0, gcmErrs 0, ebfmin 0.00 max inf
Peak sync jitter 0/10, peak Rx sync delay 213, resyncs 0/0, no timer interrupt scheduled
VIN voltage: min 23.9, current 24.1, max 24.4
MCU temperature: min 55.1C, current 66.5C, max 66.5C
Last sensors broadcast 0x00000012 found 2 123 ticks ago, 0 ordering errs, loop time 0
CAN messages queued 2484, send timeouts 0, received 4020, lost 0, errs 0, boc 0, free buffers 18, min 18, error reg 0
dup 0, oos 0/0/0/0, bm 0, wbm 0, rxMotionDelay 327, adv 36161/74646
Accelerometer: LIS3DH, status: 00
Inductive sensor: not found
I2C bus errors 0, naks 0, contentions 0, other errors 0
=== Filament sensors ===
Interrupt 5726621 to 0us, poll 9 to 1276us
Driver 0: ok

And here is the print file for good meassure.

Since the issue wasn't related to the last build I have installed the one you suplied yesterday again btw.

Here is a link to the print job that's reproduced the issue the 3 times I've tried running it (happens on different layers each time).

Exerqtor · 9 Dec 2023, 16:36

I've been trying several other prints now as well, and the bug is for sure back! The last print it happened in, I let the print "complete" and it ended up fully unloading the hotend/extruder.

Just like "last time" (3.5.0 pre beta 4) it happens seemingly at random.

Exerqtor · 10 Dec 2023, 12:20

I've now regressed back to this "release" who is the first 3.5.0-rc1+ as far as i know of, and the issue is still present.

Reports from a ongoing print with the issue going on:

 M122
=== Diagnostics ===
RepRapFirmware for Duet 3 Mini 5+ version 3.5.0-rc.1+ (2023-11-03 17:18:21) running on Duet 3 Mini5plus WiFi (standalone mode)
Board ID: XNHXF-HR6KL-K65J0-409N2-K9W1Z-RV2MZ
Used output buffers: 15 of 40 (31 max)
=== RTOS ===
Static ram: 102812
Dynamic ram: 126708 of which 12 recycled
Never used RAM 7244, free system stack 128 words
Tasks: NETWORK(2,nWait,12.2%,197) HEAT(3,nWait,0.0%,343) Move(4,nWait,0.7%,243) CanReceiv(6,nWait,0.1%,566) CanSender(5,nWait,0.0%,327) CanClock(7,delaying,0.0%,341) TMC(4,nWait,0.7%,74) MAIN(1,running,85.3%,601) IDLE(0,ready,0.1%,29) AIN(4,delaying,0.8%,264), total 100.0%
Owned mutexes:
=== Platform ===
Last reset 00:25:25 ago, cause: software
Last software reset at 2023-12-09 15:05, reason: HardFault bfarValid precise, Gcodes spinning, available RAM 6040, slot 2
Software reset code 0x4063 HFSR 0x40000000 CFSR 0x00008200 ICSR 0x00000803 BFAR 0x362e303d SP 0x20011f60 Task NETW Freestk 472 ok
Stack: 362e303d 20032cfd 00000047 362e303c 20032ebc 0002dd33 00004434 210f0000 0002dce5 2002bed4 2002be01 000001c0 2002c100 200314b0 2002c118 2001e888 a5a5a5a5 a5a5a5a5 0002ff41 00000000 00000000 00000000 362e303d 00000800 200359c8 2002c100 20018678
Error status: 0x00
Aux0 errors 0,0,0
MCU revision 3, ADC conversions started 1525075, completed 1525075, timed out 0, errs 0
MCU temperature: min 35.7, current 46.2, max 46.6
Supply voltage: min 4.5, current 24.1, max 24.5, under voltage events: 0, over voltage events: 0, power good: yes
Heap OK, handles allocated/used 198/23, heap memory allocated/used/recyclable 2048/1952/1612, gc cycles 8
Events: 2 queued, 2 completed
Driver 0: standstill, SG min 0, read errors 0, write errors 1, ifcnt 51, reads 14667, writes 34, timeouts 0, DMA errors 0, CC errors 0
Driver 1: ok, SG min 0, read errors 0, write errors 1, ifcnt 49, reads 14667, writes 34, timeouts 0, DMA errors 0, CC errors 0
Driver 2: ok, SG min 0, read errors 0, write errors 1, ifcnt 244, reads 14677, writes 24, timeouts 0, DMA errors 0, CC errors 0
Driver 3: standstill, SG min 0, read errors 0, write errors 1, ifcnt 246, reads 14678, writes 23, timeouts 0, DMA errors 0, CC errors 0
Driver 4: ok, SG min 0, read errors 0, write errors 1, ifcnt 242, reads 14678, writes 23, timeouts 0, DMA errors 0, CC errors 0
Driver 5: not present
Driver 6: not present
Date/time: 2023-12-10 13:16:52
Cache data hit count 2401483401
Slowest loop: 224.04ms; fastest: 0.09ms
=== Storage ===
Free file entries: 16
SD card 0 detected, interface speed: 22.5MBytes/sec
SD card longest read time 8.0ms, write time 27.9ms, max retries 0
=== Move ===
DMs created 83, segments created 41, maxWait 909187ms, bed compensation in use: mesh, height map offset 0.000, ebfmin 0.00, ebfmax 0.00
next step interrupt due in 44 ticks, enabled
Moves shaped first try 516, on retry 378, too short 179, wrong shape 4761, maybepossible 134
=== DDARing 0 ===
Scheduled moves 7935, completed 7895, hiccups 0, stepErrors 0, LaErrors 8, Underruns [0, 0, 0], CDDA state 3
=== DDARing 1 ===
Scheduled moves 0, completed 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1
=== Heat ===
Bed heaters 0 -1 -1 -1, chamber heaters -1 -1 -1 -1, ordering errs 0
Heater 0 is on, I-accum = 0.4
Heater 1 is on, I-accum = 0.0
=== GCodes ===
Movement locks held by File, null
HTTP is idle in state(s) 0
Telnet is idle in state(s) 0
File is doing "G11" 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 S10000" in state(s) 0 0, running macro
Aux2 is idle in state(s) 0
Autopause is idle in state(s) 0
File2 is idle in state(s) 0, sync state 1
Queue2 is idle in state(s) 0
Q0 segments left 1, axes/extruders owned 0x0000807
Code queue 0 is empty
Q1 segments left 0, axes/extruders owned 0x0000000
Code queue 1 is empty
=== Filament sensors ===
in 0 notIn 0
Extruder 0 sensor: no filament
=== CAN ===
Messages queued 23320, received 31266, lost 0, errs 12789, boc 0
Longest wait 2ms for reply type 6031, peak Tx sync delay 35722, free buffers 26 (min 25), ts 7626/7613/0
Tx timeouts 0,0,12,0,0,7 last cancelled message type 30 dest 127
=== Network ===
Slowest loop: 50.37ms; fastest: 0.00ms
Responder states: MQTT(0) HTTP(0) HTTP(0) HTTP(0) HTTP(0) FTP(0) Telnet(0)
HTTP sessions: 1 of 8
=== WiFi ===
Interface state: active
Module is connected to access point 
Failed messages: pending 0, notrdy 0, noresp 0
Firmware version 2.1beta4
MAC address c4:5b:be:ce:91:93
Module reset reason: Power up, Vcc 3.38, flash size 2097152, free heap 42964
WiFi IP address 192.168.10.x
Signal strength -49dBm, channel 6, mode 802.11n, reconnections 0
Clock register 00002001
Socket states: 0 0 0 0 0 0 0 0

 M122 B121
Diagnostics for board 121:
Duet TOOL1LC rev 1.1 or later firmware version 3.5.0-rc.1+ (2023-11-21 09:48:16)
Bootloader ID: SAMC21 bootloader version 2.4 (2021-12-10)
All averaging filters OK
Never used RAM 2628, free system stack 89 words
Tasks: Move(3,nWait,0.2%,71) HEAT(2,nWait,0.3%,91) CanAsync(5,nWait,0.0%,55) CanRecv(3,nWait,0.0%,77) CanClock(5,nWait,0.0%,67) ACCEL(3,nWait,0.0%,53) TMC(2,delaying,3.1%,57) MAIN(1,running,91.6%,316) IDLE(0,ready,0.0%,27) AIN(2,delaying,4.8%,114), total 100.0%
Last reset 00:19:55 ago, cause: software
Last software reset data not available
Driver 0: pos 0, 568.8 steps/mm, standstill, SG min 0, read errors 0, write errors 1, ifcnt 25, reads 7287, writes 13, timeouts 0, DMA errors 0, CC errors 0, steps req 0 done 438346
Moves scheduled 2995, completed 2995, in progress 0, hiccups 4, segs 40, step errors 0, maxPrep 900, maxOverdue 59, maxInc 59, mcErrs 0, gcmErrs 0, ebfmin -0.97 max inf
Peak sync jitter -2/11, peak Rx sync delay 219, resyncs 0/0, no timer interrupt scheduled
VIN voltage: min 23.3, current 24.1, max 24.4
MCU temperature: min 44.1C, current 62.3C, max 62.3C
Last sensors broadcast 0x00000012 found 2 130 ticks ago, 0 ordering errs, loop time 0
CAN messages queued 24647, send timeouts 0, received 18188, lost 0, errs 0, boc 0, free buffers 18, min 18, error reg 0
dup 0, oos 0/0/0/0, bm 0, wbm 0, rxMotionDelay 354, adv 35968/74648
Accelerometer: LIS3DH, status: 00
Inductive sensor: not found
I2C bus errors 0, naks 6, contentions 0, other errors 0
=== Filament sensors ===
Interrupt 5726621 to 0us, poll 4 to 1416us
Driver 0: ok

Moving back to 3.5.0-rc1 now to see if that issue follows there as well.

Exerqtor · 10 Dec 2023, 12:30

And so it does, same problem on 3.5.0-rc1:

Ongoing print displaying the issue:

 M122
=== Diagnostics ===
RepRapFirmware for Duet 3 Mini 5+ version 3.5.0-rc.1 (2023-08-31 16:16:56) running on Duet 3 Mini5plus WiFi (standalone mode)
Board ID: XNHXF-HR6KL-K65J0-409N2-K9W1Z-RV2MZ
Used output buffers: 26 of 40 (29 max)
=== RTOS ===
Static ram: 102836
Dynamic ram: 127244 of which 0 recycled
Never used RAM 6720, free system stack 134 words
Tasks: NETWORK(2,nWait,11.3%,197) HEAT(3,nWait,0.0%,352) Move(4,nWait,1.4%,244) CanReceiv(6,nWait,0.1%,796) CanSender(5,nWait,0.0%,337) CanClock(7,delaying,0.0%,351) TMC(4,nWait,0.7%,74) MAIN(1,running,85.5%,603) IDLE(0,ready,0.1%,29) AIN(4,delaying,0.9%,264), total 100.0%
Owned mutexes: WiFi(NETWORK)
=== Platform ===
Last reset 00:08:25 ago, cause: software
Last software reset at 2023-12-10 13:20, reason: User, Gcodes spinning, available RAM 13016, slot 0
Software reset code 0x0003 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00489000 BFAR 0xe000ed38 SP 0x00000000 Task MAIN Freestk 0 n/a
Error status: 0x00
Aux0 errors 0,0,0
MCU revision 3, ADC conversions started 505809, completed 505809, timed out 0, errs 0
MCU temperature: min 42.2, current 46.4, max 46.6
Supply voltage: min 8.8, current 24.2, max 24.6, under voltage events: 0, over voltage events: 0, power good: yes
Heap OK, handles allocated/used 198/23, heap memory allocated/used/recyclable 2048/1696/1352, gc cycles 8
Events: 1 queued, 1 completed
Driver 0: ok, SG min 0, read errors 0, write errors 1, ifcnt 99, reads 26545, writes 31, timeouts 0, DMA errors 0, CC errors 0
Driver 1: ok, SG min 0, read errors 0, write errors 1, ifcnt 97, reads 26545, writes 31, timeouts 0, DMA errors 0, CC errors 0
Driver 2: ok, SG min 0, read errors 0, write errors 1, ifcnt 25, reads 26555, writes 20, timeouts 0, DMA errors 0, CC errors 0
Driver 3: ok, SG min 0, read errors 0, write errors 1, ifcnt 27, reads 26555, writes 20, timeouts 0, DMA errors 0, CC errors 0
Driver 4: ok, SG min 0, read errors 0, write errors 1, ifcnt 24, reads 26555, writes 21, timeouts 0, DMA errors 0, CC errors 0
Driver 5: not present
Driver 6: not present
Date/time: 2023-12-10 13:28:49
Cache data hit count 741229810
Slowest loop: 224.32ms; fastest: 0.09ms
=== Storage ===
Free file entries: 16
SD card 0 detected, interface speed: 22.5MBytes/sec
SD card longest read time 6.0ms, write time 4.5ms, max retries 0
=== Move ===
DMs created 83, segments created 40, maxWait 70761ms, bed compensation in use: mesh, height map offset 0.000, ebfmin 0.00, ebfmax 0.00
next step interrupt due in 48 ticks, enabled
Moves shaped first try 284, on retry 120, too short 594, wrong shape 2189, maybepossible 201
=== DDARing 0 ===
Scheduled moves 4585, completed 4545, hiccups 0, stepErrors 0, LaErrors 5, Underruns [0, 0, 0], CDDA state 3
=== DDARing 1 ===
Scheduled moves 0, completed 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1
=== Heat ===
Bed heaters 0 -1 -1 -1, chamber heaters -1 -1 -1 -1, ordering errs 0
Heater 0 is on, I-accum = 0.4
Heater 1 is on, I-accum = 0.0
=== GCodes ===
Movement locks held by null, null
HTTP is idle in state(s) 0
Telnet is idle in state(s) 0
File is doing "G1 X187.663 Y162.47 E.19318" 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 S10000" in state(s) 0 0, running macro
Aux2 is idle in state(s) 0
Autopause is idle in state(s) 0
File2 is idle in state(s) 0, sync state 1
Queue2 is idle in state(s) 0
Q0 segments left 1, axes/extruders owned 0x0000807
Code queue 0 is empty
Q1 segments left 0, axes/extruders owned 0x0000000
Code queue 1 is empty
=== Filament sensors ===
Extruder 0 sensor: no filament
=== CAN ===
Messages queued 8689, received 10558, lost 0, boc 0
Longest wait 2ms for reply type 6034, peak Tx sync delay 252, free buffers 26 (min 25), ts 2528/2527/0
Tx timeouts 0,0,0,0,0,0
=== Network ===
Slowest loop: 108.08ms; fastest: 0.00ms
Responder states: MQTT(0) HTTP(0) HTTP(0) HTTP(0) HTTP(0) FTP(0) Telnet(0)
HTTP sessions: 1 of 8
=== WiFi ===
Interface state: active
Module is connected to access point 
Failed messages: pending 0, notrdy 0, noresp 0
Firmware version 2.1beta4
MAC address c4:5b:be:ce:91:93
Module reset reason: Power up, Vcc 3.38, flash size 2097152, free heap 43128
WiFi IP address 192.168.10.x
Signal strength -46dBm, channel 6, mode 802.11n, reconnections 0
Clock register 00002001
Socket states: 0 0 0 0 0 0 0 0

 M122 B121
Diagnostics for board 121:
Duet TOOL1LC rev 1.1 or later firmware version 3.5.0-rc.1 (2023-08-31 16:30:01)
Bootloader ID: SAMC21 bootloader version 2.4 (2021-12-10)
All averaging filters OK
Never used RAM 2760, free system stack 89 words
Tasks: Move(3,nWait,0.2%,71) HEAT(2,nWait,0.4%,91) CanAsync(5,nWait,0.0%,53) CanRecv(3,nWait,0.1%,77) CanClock(5,nWait,0.0%,66) ACCEL(3,nWait,0.0%,53) TMC(2,delaying,3.1%,57) MAIN(1,running,91.2%,324) IDLE(0,ready,0.0%,27) AIN(2,delaying,5.1%,112), total 100.0%
Last reset 00:08:29 ago, cause: software
Last software reset data not available
Driver 0: pos 0, 568.8 steps/mm, ok, SG min 0, read errors 0, write errors 1, ifcnt 81, reads 57570, writes 22, timeouts 0, DMA errors 0, CC errors 0, steps req 0 done 386243
Moves scheduled 2792, completed 2792, in progress 0, hiccups 4, segs 38, step errors 0, maxPrep 862, maxOverdue 174, maxInc 140, mcErrs 0, gcmErrs 0, ebfmin -1.00 max inf
Peak sync jitter -1/10, peak Rx sync delay 216, resyncs 0/0, no timer interrupt scheduled
VIN voltage: min 9.0, current 24.1, max 24.6
MCU temperature: min 58.6C, current 68.8C, max 68.8C
Last sensors broadcast 0x00000012 found 2 7 ticks ago, 0 ordering errs, loop time 0
CAN messages queued 10650, send timeouts 0, received 8816, lost 0, free buffers 18, min 18, error reg 110000
dup 0, oos 0/0/0/0, bm 0, wbm 0, rxMotionDelay 357, adv 35693/74648
Accelerometer: LIS3DH, status: 00
Inductive sensor: not found
I2C bus errors 0, naks 6, contentions 0, other errors 0
=== Filament sensors ===
Interrupt 5726621 to 0us, poll 4 to 1440us
Driver 0: ok

gloomyandy · 10 Dec 2023, 12:53

@Exerqtor Is there anything different about the prints or the setup you are now using? I seem to remember you have printed a lot of things using the various rc versions without hitting this problem.

Exerqtor · 12 Oct 2023, 13:18

@gloomyandy Nope, no difference anywhere other than the different FW versions (and changes to daemon.g I've been doing on request from @dc42, which shouldn't impact much).

Haven't done any config changes in either the firmware or slicer. So what made this bug suddenly pop up is beyond me.

I litlerlaly finished one printed job, sliced a new part (with the exact same settings), uploaded, started printing and 10minutes into the print i saw it wasn't extruding. So i thought it was either a clog or had ran out of filament.

Paused the print, saw there was plenty with filament left, so i tried extruding manually through PanelDue which worked after it had finally loaded/primed the hotend again.

So i canceled the print, and restarted it. This time it started acting up on layer 7-8 or something (way earlier than it had shit the bed last time I tried). Canceled and try again, now it didn't get to layer 3 even.

gloomyandy · 10 Dec 2023, 13:36

@Exerqtor So just to be clear, is this a print that you have not printed before,or have you printed it successfully in the past?

Exerqtor · 10 Dec 2023, 14:14

@gloomyandy The prints I've tried now are prints that i haven't tried before.

I did first think that the issue with the file i linked here was that it has quite alot of retractions in quick sucession. So i sliced another job (same slicer settings and no fw changes), and that job did complete without issues. Then i sliced up the exact same stl that i had just sucessfully printed, only change was that i mirrored it over x-axis in the slicer since it's a right/left side model. Sliced that, uploaded and started printing it, but that failed on me.

So it's leads me to think the issue ain't the job/sliced files.

And just for referance the WiFi module has been switched off before any of these print jobs have been started due to the crash issue i've been having. So it's nothing "external" doing nothing funny 😅

NeoDue · 10 Dec 2023, 17:55

@Exerqtor I don't know which slicer you use, but did you check if there might be a bug in that slicer? I just recently upgraded my Prusaslicer, hence the question. Did you confirm that the gcode files are okay in the relevant area?

Exerqtor · 10 Dec 2023, 18:21

@NeoDue said in 1LC stepper intermittently running backwards - 3.5.0-r1+:

@Exerqtor I don't know which slicer you use, but did you check if there might be a bug in that slicer? I just recently upgraded my Prusaslicer, hence the question. Did you confirm that the gcode files are okay in the relevant area?

I'm using Orca Slicer 1.8.1, and i was before this problem suddenly started manifesting as well.

And since it happens on different heights (on the same job file) every time i try iy out i can't fathom how it could be a slicer generated issue.

I've read through the parts of gcode where the problem seem to have happened, and it's nothing out of the ordinary.

If you look at the file i supplied a little bit farther up, it stopped extruding somewhere between layer 1 finishing up, and layer 2 being done one of the times (I at least haven't been able to find anything that stands out as wrong within that segment of code). And the first time that print failed the print came to about 12,6mm height before it stopped ‍️

NeoDue · 10 Dec 2023, 21:04

@Exerqtor that link you posted up there was too large, I could not see it

The file seems okay though.

Just to have tried it and maybe narrow down the issue - did you try to switch to absolute extrusion instead of using relative extrusion (RRF default is absolute - thus, if this works, your printer might "forget" its relative mode which you can doublecheck then)?

Apart from that, two probably unrelated issues in your code: you set global.layer_number twice for each layer, and you do a G92 E0 for each layer change - that one does not make sense if you use relative extruder coordinates. I remember commenting all these out when I switched to using relative extruder coordinates because something went strange then... but it has been a while, so I do not remember what that was.

Exerqtor · 12 Nov 2023, 05:34

@NeoDue said in 1LC stepper intermittently running backwards - 3.5.0-r1+:

@Exerqtor that link you posted up there was too large, I could not see it

The file seems okay though.

Haha, hidden in plain sight 🤣

Glad i'm not the only one not able to spot any clear mistakes

Just to have tried it and maybe narrow down the issue - did you try to switch to absolute extrusion instead of using relative extrusion (RRF default is absolute - thus, if this works, your printer might "forget" its relative mode which you can doublecheck then)?

Hmm, no I haven't tried that, I'll give it a try after work!

Apart from that, two probably unrelated issues in your code: you set global.layer_number twice for each layer, and you do a G92 E0 for each layer change - that one does not make sense if you use relative extruder coordinates. I remember commenting all these out when I switched to using relative extruder coordinates because something went strange then... but it has been a while, so I do not remember what that was.

Hmm, i'll do that later too!

Weird of it to suddenly happen though, since i haven't done any changes in that for litlerlaly years 🤔

gloomyandy · 11 Dec 2023, 08:04

@Exerqtor The Duet folks recommend the use of relative extrusion: https://docs.duet3d.com/User_manual/Reference/Slicing_recommendations#:~:text=All popular slicers support relative,you are using relative extrusion.

I suspect that is the mode that most folks are using.

It seems strange that there are no other reports of this issue from other folks. One thing that is perhaps a little unusual about your setup is that it looks like you have a filament sensor attached to the toolboard. Perhaps you could try disconnecting that (so that it no longer generates interrupts) and see if that makes any difference? Is there anything else about your toolboard setup that is unusual (so for instance do you have any neopixels running from it)? Are you using slicer or firmware retraction?

Exerqtor · 11 Dec 2023, 09:00

@gloomyandy said in 1LC stepper intermittently running backwards - 3.5.0-r1+:

@Exerqtor The Duet folks recommend the use of relative extrusion: https://docs.duet3d.com/User_manual/Reference/Slicing_recommendations#:~:text=All popular slicers support relative,you are using relative extrusion.

I suspect that is the mode that most folks are using.

Yeah that's exactly why i'm using it too 🤣

It seems strange that there are no other reports of this issue from other folks. One thing that is perhaps a little unusual about your setup is that it looks like you have a filament sensor attached to the toolboard. Perhaps you could try disconnecting that (so that it no longer generates interrupts) and see if that makes any difference? Is there anything else about your toolboard setup that is unusual (so for instance do you have any neopixels running from it)? Are you using slicer or firmware retraction?

Thought most people ran at least one sensor these days lol, I can disable it in firmware and unplug it as well just to try.

The neopixels have wires ran all the way from the mainboard, since toolboard driven neopixels wasn't supported when i hooked it up 😅

I'm running firmware retraction, input shaping and pressure advance.

dc42 · 11 Dec 2023, 09:35

@Exerqtor please try the firmware binary at https://www.dropbox.com/scl/fo/uf8gsgetc2mfbh34hm3up/h?rlkey=bx1aavry6xplebwxhv5rx7xee&dl=0 and test it both for the WiFi resetting issue and the extruder reversal issue.

Exerqtor · 11 Dec 2023, 14:17

@dc42 said in 1LC stepper intermittently running backwards - 3.5.0-r1+:

@Exerqtor please try the firmware binary at https://www.dropbox.com/scl/fo/uf8gsgetc2mfbh34hm3up/h?rlkey=bx1aavry6xplebwxhv5rx7xee&dl=0 and test it both for the WiFi resetting issue and the extruder reversal issue.

Sweet, but continue to run the "regular" 1LC 3.5.0-rc1+ firmware?

Exerqtor · 11 Dec 2023, 16:28

@dc42 Ok let's see, I've installed those last binaries and the "normal" 3.5.0rc1+ release on the 1LC.

After that I tried one of the jobs that failed earlier, and it completed without reversing the extruder (or crashing).

I'll try some of the other jobs that has failed too now and see of they also complete.

Should i still leave the "stuff" we put in daemon.g be there for a while btw?

(Copying this response to the other thread too, since it's refering to the same binaries)

Exerqtor · 11 Dec 2023, 16:54

@Exerqtor said in 1LC stepper intermittently running backwards - 3.5.0-r1+:

@dc42 ~~Ok let's see, I've installed those last binaries and the "normal" 3.5.0rc1+ release on the 1LC.~~

~~After that I tried one of the jobs that failed earlier, and it completed without reversing the extruder (or crashing).~~

I'll try some of the other jobs that has failed too now and see of they also complete.

~~Should i still leave the "stuff" we put in daemon.g be there for a while btw?~~

~~(Copying this response to the other thread too, since it's refering to the same binaries)~~

Well that didn't last long, the next print started reversing after the second layer completed, it's still going as i type this reply.

So here is a few reports from when it's currently reversing:

 M122
=== Diagnostics ===
RepRapFirmware for Duet 3 Mini 5+ version 3.5.0-rc.1++wdb (2023-12-11 09:30:48) running on Duet 3 Mini5plus WiFi (standalone mode)
Board ID: XNHXF-HR6KL-K65J0-409N2-K9W1Z-RV2MZ
Used output buffers: 12 of 40 (40 max)
=== RTOS ===
Static ram: 102844
Dynamic ram: 126732 of which 0 recycled
Never used RAM 7128, free system stack 128 words
Tasks: NETWORK(1,ready,143.3%,173) HEAT(3,nWait,0.2%,327) Move(4,nWait,6.2%,242) CanReceiv(6,nWait,0.4%,774) CanSender(5,nWait,0.2%,327) CanClock(7,delaying,0.1%,350) TMC(4,nWait,5.7%,74) MAIN(1,running,583.5%,584) IDLE(0,ready,0.9%,29) AIN(4,delaying,6.4%,264), total 746.8%
Owned mutexes: WiFi(NETWORK)
=== Platform ===
Last reset 01:50:12 ago, cause: software
Last software reset at 2023-12-11 16:03, reason: User, Gcodes spinning, available RAM 13548, slot 1
Software reset code 0x0003 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00446000 BFAR 0xe000ed38 SP 0x00000000 Task MAIN Freestk 0 n/a
Error status: 0x04
Aux0 errors 0,0,0
MCU revision 3, ADC conversions started 6612142, completed 6612142, timed out 0, errs 0
MCU temperature: min 34.7, current 46.4, max 46.8
Supply voltage: min 7.5, current 24.1, max 24.6, under voltage events: 0, over voltage events: 0, power good: yes
Heap OK, handles allocated/used 198/23, heap memory allocated/used/recyclable 2048/788/444, gc cycles 18
Events: 0 queued, 0 completed
Driver 0: ok, SG min 0, read errors 0, write errors 1, ifcnt 166, reads 20196, writes 50, timeouts 0, DMA errors 0, CC errors 0
Driver 1: standstill, SG min 0, read errors 0, write errors 1, ifcnt 164, reads 20196, writes 50, timeouts 0, DMA errors 0, CC errors 0
Driver 2: standstill, SG min 0, read errors 0, write errors 1, ifcnt 70, reads 20217, writes 28, timeouts 0, DMA errors 0, CC errors 0
Driver 3: standstill, SG min 0, read errors 0, write errors 1, ifcnt 72, reads 20217, writes 28, timeouts 0, DMA errors 0, CC errors 0
Driver 4: standstill, SG min 0, read errors 0, write errors 1, ifcnt 68, reads 20219, writes 27, timeouts 0, DMA errors 0, CC errors 0
Driver 5: not present
Driver 6: not present
Date/time: 2023-12-11 17:54:00
Cache data hit count 4294967295
Slowest loop: 306.84ms; fastest: 0.09ms
=== Storage ===
Free file entries: 16
SD card 0 detected, interface speed: 22.5MBytes/sec
SD card longest read time 9.2ms, write time 6.2ms, max retries 0
=== Move ===
DMs created 83, segments created 44, maxWait 2843003ms, bed compensation in use: mesh, height map offset 0.000, max steps late 1, ebfmin 0.00, ebfmax 0.00
next step interrupt due in 63 ticks, enabled
Moves shaped first try 2684, on retry 3142, too short 7967, wrong shape 32970, maybepossible 1754
=== DDARing 0 ===
Scheduled moves 7910, completed 7871, hiccups 0, stepErrors 0, LaErrors 31, Underruns [0, 0, 0], CDDA state 3
=== DDARing 1 ===
Scheduled moves 0, completed 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1
=== Heat ===
Bed heaters 0 -1 -1 -1, chamber heaters -1 -1 -1 -1, ordering errs 0
Heater 0 is on, I-accum = 0.4
Heater 1 is on, I-accum = 0.0
=== GCodes ===
Movement locks held by null, null
HTTP is idle in state(s) 0
Telnet is idle in state(s) 0
File is doing "G1 X170.601 Y152.656 E.00239" 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 S10000" in state(s) 0 0, running macro
Aux2 is idle in state(s) 0
Autopause is idle in state(s) 0
File2 is idle in state(s) 0, sync state 1
Queue2 is idle in state(s) 0
Q0 segments left 0, axes/extruders owned 0x0000807
Code queue 0 is empty
Q1 segments left 0, axes/extruders owned 0x0000000
Code queue 1 is empty
=== Filament sensors ===
in 0 notIn 0
Extruder 0 sensor: no filament
=== CAN ===
Messages queued 111977, received 136294, lost 0, errs 1, boc 0
Longest wait 6ms for reply type 6029, peak Tx sync delay 340, free buffers 26 (min 24), ts 33061/33060/0
Tx timeouts 0,0,0,0,0,0
=== Network ===
Slowest loop: 210.23ms; fastest: 0.00ms
Responder states: MQTT(0) HTTP(0) HTTP(0) HTTP(0) HTTP(0) FTP(0) Telnet(0)
HTTP sessions: 3 of 8
=== WiFi ===
Interface state: active
Module is connected to access point 
Failed messages: pending 0, notrdy 0, noresp 0
Firmware version 2.1beta4
MAC address c4:5b:be:ce:91:93
Module reset reason: Power up, Vcc 3.38, flash size 2097152, free heap 42948
WiFi IP address 192.168.10.x
Signal strength -49dBm, channel 6, mode 802.11n, reconnections 0
Clock register 00002001
Socket states: 0 0 0 0 0 0 0 0

 M122 B121
Diagnostics for board 121:
Duet TOOL1LC rev 1.1 or later firmware version 3.5.0-rc.1+ (2023-11-21 09:48:16)
Bootloader ID: SAMC21 bootloader version 2.4 (2021-12-10)
All averaging filters OK
Never used RAM 2556, free system stack 89 words
Tasks: Move(3,nWait,1.4%,71) HEAT(2,nWait,2.5%,91) CanAsync(5,nWait,0.0%,54) CanRecv(3,nWait,0.4%,77) CanClock(5,nWait,0.1%,67) ACCEL(3,nWait,0.0%,53) TMC(2,nWait,22.2%,57) MAIN(1,running,38.2%,316) IDLE(0,ready,0.0%,27) AIN(2,delaying,35.0%,114), total 100.0%
Last reset 01:50:46 ago, cause: software
Last software reset data not available
Driver 0: pos 0, 568.8 steps/mm, standstill, SG min 0, read errors 0, write errors 3, ifcnt 140, reads 40832, writes 24, timeouts 0, DMA errors 0, CC errors 0, steps req 0 done 4320865
Moves scheduled 47946, completed 47946, in progress 0, hiccups 77, segs 43, step errors 0, maxPrep 887, maxOverdue 7251, maxInc 2966, mcErrs 0, gcmErrs 0, ebfmin -1.00 max inf
Peak sync jitter -2/11, peak Rx sync delay 279, resyncs 0/0, no timer interrupt scheduled
VIN voltage: min 7.7, current 24.1, max 24.5
MCU temperature: min 38.8C, current 66.5C, max 74.8C
Last sensors broadcast 0x00000012 found 2 34 ticks ago, 0 ordering errs, loop time 0
CAN messages queued 137004, send timeouts 0, received 112920, lost 0, errs 1213, boc 0, free buffers 18, min 18, error reg 110000
dup 0, oos 0/0/0/0, bm 0, wbm 0, rxMotionDelay 369, adv 35625/74652
Accelerometer: LIS3DH, status: 00
Inductive sensor: not found
I2C bus errors 0, naks 6, contentions 0, other errors 0
=== Filament sensors ===
Interrupt 5726621 to 0us, poll 2 to 1966us
Driver 0: ok

dc42 · 12 Nov 2023, 17:59

@Exerqtor please use the 3.5.0-rc.1++ tool board/expansion board firmware from https://www.dropbox.com/scl/fo/gaxzegafmnmagaefo9mgc/h?rlkey=hk4wpttdje76oews8zkuh86q3&dl=0.

Exerqtor · 12 Nov 2023, 19:11

@dc42 said in 1LC stepper intermittently running backwards - 3.5.0-r1+:

@Exerqtor please use the 3.5.0-rc.1++ tool board/expansion board firmware from https://www.dropbox.com/scl/fo/gaxzegafmnmagaefo9mgc/h?rlkey=hk4wpttdje76oews8zkuh86q3&dl=0.

Aha, ok just moved over to it. I'll try the same job file again before hitting the bunk and report back✌️

Just tried the same print with 3.5.0-c.1++ on the 1LC and it's the exact same behaviour:

 M122
=== Diagnostics ===
RepRapFirmware for Duet 3 Mini 5+ version 3.5.0-rc.1++wdb (2023-12-11 09:30:48) running on Duet 3 Mini5plus WiFi (standalone mode)
Board ID: XNHXF-HR6KL-K65J0-409N2-K9W1Z-RV2MZ
Used output buffers: 4 of 40 (40 max)
=== RTOS ===
Static ram: 102844
Dynamic ram: 125540 of which 0 recycled
Never used RAM 9168, free system stack 138 words
Tasks: NETWORK(1,ready,16.8%,179) HEAT(3,nWait,0.0%,352) Move(4,nWait,0.5%,244) CanReceiv(6,nWait,0.1%,774) CanSender(5,nWait,0.0%,327) CanClock(7,delaying,0.0%,350) TMC(4,delaying,0.7%,74) MAIN(1,running,80.9%,584) IDLE(0,ready,0.2%,29) AIN(4,delaying,0.8%,264), total 100.0%
Owned mutexes: WiFi(NETWORK)
=== Platform ===
Last reset 00:25:33 ago, cause: software
Last software reset at 2023-12-11 19:17, reason: User, Gcodes spinning, available RAM 7056, slot 2
Software reset code 0x0003 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00446000 BFAR 0xe000ed38 SP 0x00000000 Task MAIN Freestk 0 n/a
Error status: 0x04
Aux0 errors 0,0,0
MCU revision 3, ADC conversions started 1533781, completed 1533780, timed out 0, errs 0
MCU temperature: min 37.0, current 46.4, max 46.6
Supply voltage: min 7.8, current 24.0, max 24.7, under voltage events: 0, over voltage events: 0, power good: yes
Heap OK, handles allocated/used 99/23, heap memory allocated/used/recyclable 2048/1912/1572, gc cycles 7
Events: 0 queued, 0 completed
Driver 0: ok, SG min 0, read errors 0, write errors 1, ifcnt 201, reads 15125, writes 32, timeouts 0, DMA errors 0, CC errors 0
Driver 1: standstill, SG min 0, read errors 0, write errors 1, ifcnt 199, reads 15124, writes 32, timeouts 0, DMA errors 0, CC errors 0
Driver 2: standstill, SG min 0, read errors 0, write errors 1, ifcnt 93, reads 15136, writes 20, timeouts 0, DMA errors 0, CC errors 0
Driver 3: ok, SG min 0, read errors 0, write errors 1, ifcnt 96, reads 15135, writes 21, timeouts 0, DMA errors 0, CC errors 0
Driver 4: standstill, SG min 0, read errors 0, write errors 1, ifcnt 91, reads 15137, writes 20, timeouts 0, DMA errors 0, CC errors 0
Driver 5: not present
Driver 6: not present
Date/time: 2023-12-11 19:43:28
Cache data hit count 2492399296
Slowest loop: 226.89ms; fastest: 0.09ms
=== Storage ===
Free file entries: 16
SD card 0 detected, interface speed: 22.5MBytes/sec
SD card longest read time 5.4ms, write time 5.1ms, max retries 0
=== Move ===
DMs created 83, segments created 42, maxWait 1083591ms, bed compensation in use: mesh, height map offset 0.000, max steps late 1, ebfmin 0.00, ebfmax 0.00
next step interrupt due in 30 ticks, enabled
Moves shaped first try 265, on retry 158, too short 102, wrong shape 2987, maybepossible 63
=== DDARing 0 ===
Scheduled moves 4562, completed 4522, hiccups 0, stepErrors 0, LaErrors 5, Underruns [0, 0, 0], CDDA state 3
=== DDARing 1 ===
Scheduled moves 0, completed 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1
=== Heat ===
Bed heaters 0 -1 -1 -1, chamber heaters -1 -1 -1 -1, ordering errs 0
Heater 0 is on, I-accum = 0.4
Heater 1 is on, I-accum = 0.0
=== GCodes ===
Movement locks held by null, null
HTTP is idle in state(s) 0
Telnet is idle in state(s) 0
File is doing "G1 X187.692 Y162.442 Z1.35" 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 S10000" in state(s) 0 0, running macro
Aux2 is idle in state(s) 0
Autopause is idle in state(s) 0
File2 is idle in state(s) 0, sync state 1
Queue2 is idle in state(s) 0
Q0 segments left 0, axes/extruders owned 0x0000807
Code queue 0 is empty
Q1 segments left 0, axes/extruders owned 0x0000000
Code queue 1 is empty
=== Filament sensors ===
in 0 notIn 0
Extruder 0 sensor: no filament
=== CAN ===
Messages queued 17932, received 31633, lost 0, errs 0, boc 0
Longest wait 3ms for reply type 6013, peak Tx sync delay 327, free buffers 26 (min 25), ts 7669/7668/0
Tx timeouts 0,0,0,0,0,0
=== Network ===
Slowest loop: 208.78ms; fastest: 0.00ms
Responder states: MQTT(0) HTTP(0) HTTP(0) HTTP(0) HTTP(0) FTP(0) Telnet(0)
HTTP sessions: 2 of 8
=== WiFi ===
Interface state: active
Module is connected to access point 
Failed messages: pending 0, notrdy 0, noresp 0
Firmware version 2.1beta4
MAC address c4:5b:be:ce:91:93
Module reset reason: Power up, Vcc 3.38, flash size 2097152, free heap 43112
WiFi IP address 192.168.10.x
Signal strength -48dBm, channel 6, mode 802.11n, reconnections 0
Clock register 00002001
Socket states: 0 0 0 0 0 0 0 0

 M122 B121
Diagnostics for board 121:
Duet TOOL1LC rev 1.1 or later firmware version 3.5.0-rc.1++ (2023-12-07 12:52:31)
Bootloader ID: SAMC21 bootloader version 2.4 (2021-12-10)
All averaging filters OK
Never used RAM 2628, free system stack 89 words
Tasks: Move(3,nWait,0.1%,71) HEAT(2,nWait,0.3%,91) CanAsync(5,nWait,0.0%,55) CanRecv(3,nWait,0.0%,77) CanClock(5,nWait,0.0%,67) ACCEL(3,nWait,0.0%,53) TMC(2,nWait,3.0%,57) MAIN(1,running,91.7%,316) IDLE(0,ready,0.0%,27) AIN(2,delaying,4.8%,114), total 100.0%
Last reset 00:26:29 ago, cause: software
Last software reset data not available
Driver 0: pos 0, 568.8 steps/mm, standstill, SG min 0, read errors 0, write errors 1, ifcnt 174, reads 7708, writes 22, timeouts 1, DMA errors 0, CC errors 0, failedOp 0x6c, steps req 0 done 401933
Moves scheduled 2847, completed 2847, in progress 0, hiccups 1, segs 40, step errors 0, maxLate 1 maxPrep 900, maxOverdue 40, maxInc 40, mcErrs 0, gcmErrs 0, ebfmin -1.00 max inf
Peak sync jitter -2/9, peak Rx sync delay 219, resyncs 0/0, no timer interrupt scheduled
VIN voltage: min 8.1, current 24.1, max 24.7
MCU temperature: min 45.6C, current 61.2C, max 61.2C
Last sensors broadcast 0x00000012 found 2 228 ticks ago, 0 ordering errs, loop time 0
CAN messages queued 32789, send timeouts 0, received 19593, lost 0, errs 1210, boc 0, free buffers 18, min 18, error reg 100000
dup 0, oos 0/0/0/0, bm 0, wbm 0, rxMotionDelay 354, adv 35712/74647
Accelerometer: LIS3DH, status: 00
Inductive sensor: not found
I2C bus errors 0, naks 6, contentions 0, other errors 0
=== Filament sensors ===
Interrupt 5726621 to 0us, poll 2 to 1314us
Driver 0: ok

	M122
	=== Diagnostics ===
	RepRapFirmware for Duet 3 Mini 5+ version 3.5.0-rc.1+ (2023-12-07 09:49:06) running on Duet 3 Mini5plus WiFi (standalone mode)
	Board ID: XNHXF-HR6KL-K65J0-409N2-K9W1Z-RV2MZ
	Used output buffers: 1 of 40 (40 max)
	=== RTOS ===
	Static ram: 102844
	Dynamic ram: 128036 of which 0 recycled
	Never used RAM 5752, free system stack 118 words
	Tasks: NETWORK(1,ready,77.5%,195) HEAT(3,nWait,0.2%,328) Move(4,nWait,11.5%,241) CanReceiv(6,nWait,0.4%,774) CanSender(5,nWait,0.3%,327) CanClock(7,delaying,0.1%,350) TMC(4,nWait,5.7%,74) MAIN(1,running,150.3%,580) IDLE(0,ready,0.7%,29) AIN(4,delaying,6.6%,264), total 253.2%
	Owned mutexes: WiFi(NETWORK)
	=== Platform ===
	Last reset 07:24:04 ago, cause: software
	Last software reset at 2023-12-07 06:59, reason: AssertionFailed, Gcodes spinning, available RAM 13540, slot 0
	Software reset code 0x4123 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00000000 BFAR 0xe000ed38 SP 0x20011fbc Task NETW Freestk 495 ok
	Stack: 00000913 000af408 0002de53 2002bed4 2002be01 000001a8 2002c100 20031d28 2002c118 2001e888 a5a5a5a5 a5a5a5a5 362e303d 00000000 00000000 00000000 20031d34 00000800 20035a28 2002c100 20018678 2002bf9d 20018678 2001e888 000300db 00000000 00000000
	Error status: 0x04
	Aux0 errors 0,1,0
	MCU revision 3, ADC conversions started 26644948, completed 26644948, timed out 0, errs 0
	MCU temperature: min 39.5, current 46.2, max 47.0
	Supply voltage: min 5.1, current 24.0, max 24.6, under voltage events: 0, over voltage events: 0, power good: yes
	Heap OK, handles allocated/used 198/34, heap memory allocated/used/recyclable 2048/1260/776, gc cycles 1354
	Events: 1 queued, 1 completed
	Driver 0: ok, SG min 0, read errors 0, write errors 1, ifcnt 76, reads 25633, writes 82, timeouts 0, DMA errors 0, CC errors 0
	Driver 1: ok, SG min 0, read errors 0, write errors 1, ifcnt 76, reads 25632, writes 83, timeouts 0, DMA errors 0, CC errors 0
	Driver 2: standstill, SG min 0, read errors 0, write errors 1, ifcnt 192, reads 25677, writes 38, timeouts 0, DMA errors 0, CC errors 0
	Driver 3: standstill, SG min 0, read errors 0, write errors 1, ifcnt 192, reads 25677, writes 37, timeouts 0, DMA errors 0, CC errors 0
	Driver 4: standstill, SG min 0, read errors 0, write errors 1, ifcnt 189, reads 25678, writes 37, timeouts 0, DMA errors 0, CC errors 0
	Driver 5: not present
	Driver 6: not present
	Date/time: 2023-12-07 18:33:40
	Cache data hit count 4294967295
	Slowest loop: 235.32ms; fastest: 0.09ms
	=== Storage ===
	Free file entries: 16
	SD card 0 detected, interface speed: 22.5MBytes/sec
	SD card longest read time 10.0ms, write time 30.2ms, max retries 0
	=== Move ===
	DMs created 83, segments created 47, maxWait 2831509ms, bed compensation in use: mesh, height map offset 0.000, ebfmin 0.00, ebfmax 0.00
	next step interrupt due in 17 ticks, enabled
	Moves shaped first try 37104, on retry 9435, too short 18092, wrong shape 217112, maybepossible 5892
	=== DDARing 0 ===
	Scheduled moves 72372, completed 72332, hiccups 0, stepErrors 0, LaErrors 1446, Underruns [0, 0, 2], CDDA state 3
	=== DDARing 1 ===
	Scheduled moves 0, completed 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1
	=== Heat ===
	Bed heaters 0 -1 -1 -1, chamber heaters -1 -1 -1 -1, ordering errs 0
	Heater 0 is on, I-accum = 0.4
	Heater 1 is on, I-accum = 0.0
	=== GCodes ===
	Movement locks held by null, null
	HTTP is idle in state(s) 0
	Telnet is idle in state(s) 0
	File is doing "G1 X175.056 Y124.432 E.01578" 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
	File2 is idle in state(s) 0, sync state 1
	Queue2 is idle in state(s) 0
	Q0 segments left 1, axes/extruders owned 0x0000807
	Queue 0 has 'M106 S255' for move 72370
	Q1 segments left 0, axes/extruders owned 0x0000000
	Code queue 1 is empty
	=== Filament sensors ===
	in 0 notIn 0
	Extruder 0 sensor: no filament
	=== CAN ===
	Messages queued 581746, received 549305, lost 0, errs 1, boc 0
	Longest wait 3ms for reply type 6029, peak Tx sync delay 533, free buffers 26 (min 24), ts 133223/133222/0
	Tx timeouts 0,0,0,0,0,0
	=== Network ===
	Slowest loop: 205.33ms; fastest: 0.00ms
	Responder states: MQTT(0) HTTP(0) HTTP(0) HTTP(0) HTTP(0) FTP(0) Telnet(0)
	HTTP sessions: 2 of 8
	=== WiFi ===
	Interface state: active
	Module is connected to access point
	Failed messages: pending 0, notrdy 0, noresp 0
	Firmware version 2.1beta4
	MAC address c4:5b:be:ce:91:93
	Module reset reason: Power up, Vcc 3.37, flash size 2097152, free heap 42960
	WiFi IP address 192.168.10.x
	Signal strength -58dBm, channel 6, mode 802.11n, reconnections 0
	Clock register 00002001
	Socket states: 0 0 0 0 0 0 0 0

	M122 B121
	Diagnostics for board 121:
	Duet TOOL1LC rev 1.1 or later firmware version 3.5.0-rc.1+ (2023-11-21 09:48:16)
	Bootloader ID: SAMC21 bootloader version 2.4 (2021-12-10)
	All averaging filters OK
	Never used RAM 2364, free system stack 89 words
	Tasks: Move(3,nWait,2.3%,71) HEAT(2,nWait,2.6%,91) CanAsync(5,nWait,0.0%,55) CanRecv(3,nWait,0.6%,77) CanClock(5,nWait,0.1%,67) ACCEL(3,nWait,0.0%,53) TMC(2,delaying,22.2%,57) MAIN(1,running,37.1%,316) IDLE(0,ready,0.0%,27) AIN(2,delaying,35.0%,114), total 100.0%
	Last reset 07:24:21 ago, cause: software
	Last software reset data not available
	Driver 0: pos 0, 568.8 steps/mm, standstill, SG min 0, read errors 4, write errors 1, ifcnt 94, reads 57047, writes 26, timeouts 10, DMA errors 0, CC errors 0, failedOp 0x6c, steps req 0 done 39783642
	Moves scheduled 283066, completed 283066, in progress 0, hiccups 839, segs 51, step errors 0, maxPrep 1124, maxOverdue 5537, maxInc 1554, mcErrs 0, gcmErrs 0, ebfmin -1.00 max inf
	Peak sync jitter -3/15, peak Rx sync delay 267, resyncs 0/0, no timer interrupt scheduled
	VIN voltage: min 6.3, current 24.0, max 34.7
	MCU temperature: min 53.8C, current 76.8C, max 78.8C
	Last sensors broadcast 0x00000012 found 2 57 ticks ago, 0 ordering errs, loop time 0
	CAN messages queued 549472, send timeouts 7, received 582102, lost 0, errs 40685, boc 0, free buffers 18, min 17, error reg 110000
	Last cancelled message type 4519 dest 0
	dup 0, oos 0/0/0/0, bm 0, wbm 0, rxMotionDelay 396, adv 31230/74659
	Accelerometer: LIS3DH, status: 00
	Inductive sensor: not found
	I2C bus errors 0, naks 6, contentions 0, other errors 0
	=== Filament sensors ===
	Interrupt 5726621 to 0us, poll 4 to 2846us
	Driver 0: ok