Reboots/resets randomly - RRF 3.5.0-b4
-
Tried running the flow calibration again, and it still stops. So something is still "broken" with RRF 3.5b3+.
Here is the M122's while the print is going but extruder standing still / going backwards:
M122 === Diagnostics === RepRapFirmware for Duet 3 Mini 5+ version 3.5.0-beta.3+ (2023-05-09 10:59:17) running on Duet 3 Mini5plus WiFi (standalone mode) Board ID: FAP55-Q967A-G65J0-401GL-0S02Z-RF9TL Used output buffers: 1 of 40 (40 max) === RTOS === Static ram: 101720 Dynamic ram: 130888 of which 24 recycled Never used RAM 5000, free system stack 134 words Tasks: NETWORK(ready,106.7%,193) HEAT(nWait,0.9%,329) Move(nWait,1.6%,270) CanReceiv(nWait,1.7%,772) CanSender(nWait,0.0%,327) CanClock(delaying,0.3%,341) TMC(nWait,42.1%,74) MAIN(running,480.3%,314) IDLE(ready,14.8%,29) AIN(delaying,29.1%,266), total 677.4% Owned mutexes: WiFi(NETWORK) === Platform === Last reset 09:49:11 ago, cause: software Last software reset at 2023-05-27 12:27, reason: HardFault imprec, Gcodes spinning, available RAM 5856, slot 1 Software reset code 0x4063 HFSR 0x40000000 CFSR 0x00000400 ICSR 0x00000803 BFAR 0xe000ed38 SP 0x20011b98 Task NETW Freestk 482 ok Stack: 2002be78 00000000 0000000a 0000019d 20032c8a 0002f6d1 00034064 810f0000 0002f6bd 00000000 00000000 00000000 20030a84 00000800 2002be60 2002be60 00000002 2002bd05 20018250 2001e438 0002f857 00000000 00000000 00000000 20011c48 00000014 00000000 Error status: 0x04 Aux0 errors 0,0,0 MCU revision 3, ADC conversions started 35351654, completed 35351653, timed out 0, errs 0 MCU temperature: min 35.5, current 45.6, max 46.0 Supply voltage: min 23.1, current 23.8, max 24.2, under voltage events: 0, over voltage events: 0, power good: yes Heap OK, handles allocated/used 198/41, heap memory allocated/used/recyclable 2048/1256/568, gc cycles 1401 Events: 0 queued, 0 completed Driver 0: ok, SG min 0, read errors 0, write errors 1, ifcnt 67, reads 2458, writes 33, timeouts 0, DMA errors 0, CC errors 0 Driver 1: ok, SG min 0, read errors 0, write errors 1, ifcnt 67, reads 2457, writes 33, timeouts 0, DMA errors 0, CC errors 0 Driver 2: ok, SG min 0, read errors 0, write errors 1, ifcnt 45, reads 2468, writes 22, timeouts 0, DMA errors 0, CC errors 0 Driver 3: ok, SG min 0, read errors 0, write errors 1, ifcnt 45, reads 2468, writes 22, timeouts 0, DMA errors 0, CC errors 0 Driver 4: ok, SG min 0, read errors 0, write errors 1, ifcnt 45, reads 2469, writes 22, timeouts 0, DMA errors 0, CC errors 0 Driver 5: standstill, SG min 0, read errors 0, write errors 1, ifcnt 21, reads 2480, writes 10, timeouts 1, DMA errors 0, CC errors 0, failedOp 0x41 Driver 6: standstill, SG min 0, read errors 0, write errors 1, ifcnt 21, reads 2480, writes 10, timeouts 0, DMA errors 0, CC errors 0 Date/time: 2023-05-27 22:16:47 Cache data hit count 4294967295 Slowest loop: 235.21ms; fastest: 0.08ms === Storage === Free file entries: 16 SD card 0 detected, interface speed: 22.5MBytes/sec SD card longest read time 8.9ms, write time 12.4ms, max retries 0 === Move === DMs created 83, segments created 32, maxWait 34476115ms, bed compensation in use: mesh, comp offset 0.000 next step interrupt due in 15 ticks, enabled === DDARing 0 === Scheduled moves 10011, completed 9988, hiccups 0, stepErrors 0, LaErrors 0, 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.3 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 X232.625 Y210.177 E1.87917" 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 0, axes/extruders owned 0x0000807 Code queue 0 is empty Q1 segments left 0, axes/extruders owned 0x0000000 Code queue 1 is empty === CAN === Messages queued 327074, received 707304, lost 0, boc 0 Longest wait 4ms for reply type 6024, peak Tx sync delay 276, free buffers 18 (min 8), ts 176758/176757/0 Tx timeouts 0,0,0,0,0,0 === Network === Slowest loop: 213.59ms; 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 = Network state is active Module is connected to access point Failed messages: pending 0, notready 0, noresp 0 Firmware version 2.1beta4 MAC address bc:ff:4d:e6:b1:62 Module reset reason: Power up, Vcc 3.40, flash size 2097152, free heap 43000 WiFi IP address 192.168.10.50 Signal strength -54dBm, channel 1, 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-beta.3+ (2023-05-09 13:40:30) Bootloader ID: SAMC21 bootloader version 2.4 (2021-12-10) All averaging filters OK Never used RAM 4208, free system stack 38 words Tasks: Move(nWait,1.9%,93) HEAT(nWait,18.4%,57) CanAsync(nWait,0.0%,48) CanRecv(nWait,0.8%,74) CanClock(nWait,0.7%,67) ACCEL(nWait,0.0%,53) TMC(delaying,115.8%,57) MAIN(running,38.4%,344) IDLE(ready,0.0%,27) AIN(delaying,185.2%,142), total 361.3% Last reset 22:52:44 ago, cause: power up Last software reset data not available Driver 0: pos 0, 568.8 steps/mm,standstill, SG min 0, read errors 1, write errors 0, ifcnt 18, reads 6905, writes 18, timeouts 7, DMA errors 0, CC errors 0, failedOp 0x6a, steps req 0 done 11548228 Moves scheduled 134370, completed 134370, in progress 0, hiccups 2783, step errors 0, maxPrep 1186, maxOverdue 37230, maxInc 4375, mcErrs 0, gcmErrs 0 Peak sync jitter -5/11, peak Rx sync delay 269, resyncs 0/1, no timer interrupt scheduled VIN voltage: min 23.3, current 24.4, max 24.7 MCU temperature: min 41.1C, current 70.4C, max 80.9C Last sensors broadcast 0x00000012 found 2 52 ticks ago, 0 ordering errs, loop time 1 CAN messages queued 1647766, send timeouts 0, received 878541, lost 0, free buffers 37, min 34, error reg 110000 dup 0, oos 0/0/0/1, bm 0, wbm 0, rxMotionDelay 1023, adv 27487/74646 Accelerometer: LIS3DH, status: 00 I2C bus errors 0, naks 3, other errors 0
The job file that breaks RRF.
-
@Exerqtor This sounds similar to an issue I'm having in 3.45. My extruder (on a 1LC board) will just stop extruding randomly, but I am only seeing it happen at the very beginning of a print. It is almost like the stepper amperage drops so significantly that it cannot push filament. If I power down and and restart the printer, it works again.
-
@br7408
I didn't have any issues on 3.4.5 actually!
I've continued to try zeroing down on possible reasons for this to happen, the "weirdness" at the end seems to come from not having
M0
in the custom end G-code pared up with using M73/remaining time in the slicer(s). After adding backM0
it seems to behave when a print finishes (if the extruder don't act up).Other than that, I just finished another single object print without any issues during the print. BUT after the print had finished the printer restarted/crashed all by itself. Here is the debug-log as proof, and some more M122's taken with a "freshly" booted printer after the crash:
2023-05-28 17:46:47 [warn] Started printing file 0:/gcodes/revo_nozzle_carrier-v2_0.2mm_ABS_0.4n_40m.gcode 2023-05-28 17:46:47 [debug] File 0:/gcodes/revo_nozzle_carrier-v2_0.2mm_ABS_0.4n_40m.gcode selected for printing 2023-05-28 17:46:52 [info] M291: - [no title] - Print started, preheating. 2023-05-28 17:46:53 [info] G10 P0 S150 R150 2023-05-28 17:46:53 [debug] T:57.6 /150.0 T0:57.6 /150.0 B:110.0 /110.0 2023-05-28 17:46:54 [debug] T:57.7 /150.0 T0:57.7 /150.0 B:110.0 /110.0 2023-05-28 17:46:55 [debug] T:59.9 /150.0 T0:59.9 /150.0 B:110.0 /110.0 2023-05-28 17:46:56 [debug] T:64.9 /150.0 T0:64.9 /150.0 B:110.0 /110.0 2023-05-28 17:46:57 [debug] T:71.4 /150.0 T0:71.4 /150.0 B:110.0 /110.0 2023-05-28 17:46:58 [debug] T:78.5 /150.0 T0:78.5 /150.0 B:110.0 /110.0 2023-05-28 17:46:59 [debug] T:85.5 /150.0 T0:85.5 /150.0 B:110.0 /110.0 2023-05-28 17:47:00 [debug] T:92.5 /150.0 T0:92.5 /150.0 B:110.0 /110.0 2023-05-28 17:47:01 [debug] T:99.4 /150.0 T0:99.4 /150.0 B:110.0 /110.0 2023-05-28 17:47:02 [debug] T:106.2 /150.0 T0:106.2 /150.0 B:110.0 /110.0 2023-05-28 17:47:03 [debug] T:112.7 /150.0 T0:112.7 /150.0 B:110.0 /110.0 2023-05-28 17:47:04 [debug] T:119.1 /150.0 T0:119.1 /150.0 B:110.0 /110.0 2023-05-28 17:47:05 [debug] T:125.2 /150.0 T0:125.2 /150.0 B:110.0 /110.0 2023-05-28 17:47:06 [debug] T:131.2 /150.0 T0:131.2 /150.0 B:110.0 /110.0 2023-05-28 17:47:07 [debug] T:136.6 /150.0 T0:136.6 /150.0 B:110.0 /110.0 2023-05-28 17:47:08 [debug] T:141.1 /150.0 T0:141.1 /150.0 B:110.0 /110.0 2023-05-28 17:47:09 [debug] T:144.5 /150.0 T0:144.5 /150.0 B:110.0 /110.0 2023-05-28 17:47:10 [debug] T:147.1 /150.0 T0:147.1 /150.0 B:110.0 /110.0 2023-05-28 17:47:25 [info] G10 P0 S150.0 2023-05-28 17:47:25 [info] G10 P0 S150.0 2023-05-28 17:47:26 [info] M291: - [no title] - Pre-print mesh probing enabled, probing new bed mesh! 2023-05-28 17:47:26 [debug] Default grid: X10.0:340.0, Y10.0:340.0, Number of points: X12 Y12, 144 points 2023-05-28 17:47:26 [debug] Adaptive grid: X124.564:233.264, Y156.5:196.668, Number of points: X4 Y3, 12 points 2023-05-28 17:47:28 [info] G10 P0 S150.0 2023-05-28 17:47:28 [debug] Z probe trigger height set to -1.409 mm 2023-05-28 17:47:28 [info] M291: - Mesh Probing - Probing now! Please wait... 2023-05-28 17:47:46 [info] G10 P0 S150.0 2023-05-28 17:47:46 [warn] 12 points probed, min error -0.022, max error 0.019, mean -0.001, deviation 0.014 Height map saved to file 0:/sys/heightmap.csv 2023-05-28 17:47:46 [debug] 12 points probed, min error -0.022, max error 0.019, mean -0.001, deviation 0.014 Height map saved to file 0:/sys/heightmap.csv 2023-05-28 17:47:46 [debug] Height map saved to file 0:/sys/adaptive_heightmap.csv 2023-05-28 17:47:50 [info] M291: - Mesh Probing - Done 2023-05-28 17:47:50 [info] G10 P0 S150.0 2023-05-28 17:47:51 [info] G10 P{global.initial_extruder} R{global.hotend_temp} S{global.hotend_temp} 2023-05-28 17:47:51 [debug] T:150.0 /255.0 T0:150.0 /255.0 B:110.0 /110.0 2023-05-28 17:47:52 [debug] T:150.0 /255.0 T0:150.0 /255.0 B:110.0 /110.0 2023-05-28 17:47:53 [debug] T:151.4 /255.0 T0:151.4 /255.0 B:110.0 /110.0 2023-05-28 17:47:54 [debug] T:155.0 /255.0 T0:155.0 /255.0 B:110.0 /110.0 2023-05-28 17:47:55 [debug] T:159.6 /255.0 T0:159.6 /255.0 B:110.0 /110.0 2023-05-28 17:47:56 [debug] T:165.0 /255.0 T0:165.0 /255.0 B:110.0 /110.0 2023-05-28 17:47:57 [debug] T:170.5 /255.0 T0:170.5 /255.0 B:110.0 /110.0 2023-05-28 17:47:58 [debug] T:176.1 /255.0 T0:176.1 /255.0 B:110.0 /110.0 2023-05-28 17:47:59 [debug] T:181.4 /255.0 T0:181.4 /255.0 B:110.0 /110.0 2023-05-28 17:48:00 [debug] T:186.9 /255.0 T0:186.9 /255.0 B:110.0 /110.0 2023-05-28 17:48:01 [debug] T:192.3 /255.0 T0:192.3 /255.0 B:110.0 /110.0 2023-05-28 17:48:02 [debug] T:197.3 /255.0 T0:197.3 /255.0 B:110.0 /110.0 2023-05-28 17:48:03 [debug] T:202.5 /255.0 T0:202.5 /255.0 B:110.0 /110.0 2023-05-28 17:48:04 [debug] T:207.6 /255.0 T0:207.6 /255.0 B:110.0 /110.0 2023-05-28 17:48:05 [debug] T:212.3 /255.0 T0:212.3 /255.0 B:110.0 /110.0 2023-05-28 17:48:06 [debug] T:217.3 /255.0 T0:217.3 /255.0 B:110.0 /110.0 2023-05-28 17:48:07 [debug] T:222.2 /255.0 T0:222.2 /255.0 B:110.0 /110.0 2023-05-28 17:48:08 [debug] T:227.0 /255.0 T0:227.0 /255.0 B:110.0 /110.0 2023-05-28 17:48:09 [debug] T:231.9 /255.0 T0:231.9 /255.0 B:110.0 /110.0 2023-05-28 17:48:10 [debug] T:236.5 /255.0 T0:236.5 /255.0 B:110.0 /110.0 2023-05-28 17:48:11 [debug] T:240.7 /255.0 T0:240.7 /255.0 B:110.0 /110.0 2023-05-28 17:48:12 [debug] T:244.9 /255.0 T0:244.9 /255.0 B:110.0 /110.0 2023-05-28 17:48:13 [debug] T:248.6 /255.0 T0:248.6 /255.0 B:110.0 /110.0 2023-05-28 17:48:14 [debug] T:251.8 /255.0 T0:251.8 /255.0 B:110.0 /110.0 2023-05-28 17:48:15 [info] M291: - [no title] - Purge location, X min: 99.564; Y min: 146.5; Purge move speed: 4.802495; Prepurge speed: 4.158004 2023-05-28 17:48:26 [debug] ABS filament loaded & config applied 2023-05-28 17:48:26 [debug] ABS filament loaded & config applied 2023-05-28 18:17:42 [debug] {"err":-1} 2023-05-28 18:27:22 [debug] Done printing file 2023-05-28 18:27:22 [debug] Done printing file 2023-05-28 18:27:22 [warn] Finished printing file 0:/gcodes/revo_nozzle_carrier-v2_0.2mm_ABS_0.4n_40m.gcode, print time was 0h 40m 2023-05-28 18:27:26 [info] G10 P0 R0 S0 2023-05-28 18:27:26 [debug] ABS filament unloaded & pressure advance disabled 2023-05-28 18:27:26 [debug] ABS filament unloaded & pressure advance disabled power up + 00:00:03 [info] Event logging started at level debug power up + 00:00:03 [info] Running: Duet 3 Mini5plus WiFi: 3.5.0-beta.3+ (2023-05-09 10:59:17) power up + 00:00:03 [debug] Done! power up + 00:00:03 [debug] RepRapFirmware for Duet 3 Mini 5+ is up and running. power up + 00:00:04 [warn] WiFi module started power up + 00:00:07 [warn] WiFi module is connected to access point RV32-IOT2G, IP address 192.168.10.50 power up + 00:00:08 [warn] HTTP client 192.168.10.100 login succeeded (session key 0) 2023-05-28 19:14:17 [warn] Date and time set at power up + 00:00:08
M122 === Diagnostics === RepRapFirmware for Duet 3 Mini 5+ version 3.5.0-beta.3+ (2023-05-09 10:59:17) running on Duet 3 Mini5plus WiFi (standalone mode) Board ID: FAP55-Q967A-G65J0-401GL-0S02Z-RF9TL Used output buffers: 8 of 40 (40 max) === RTOS === Static ram: 101720 Dynamic ram: 125120 of which 0 recycled Never used RAM 12360, free system stack 186 words Tasks: NETWORK(ready,19.0%,219) HEAT(nWait,0.0%,327) Move(nWait,0.0%,358) CanReceiv(nWait,0.0%,772) CanSender(nWait,0.0%,336) CanClock(delaying,0.0%,341) TMC(delaying,1.2%,108) MAIN(running,78.5%,444) IDLE(ready,0.5%,29) AIN(delaying,0.8%,266), total 100.0% Owned mutexes: HTTP(MAIN) === Platform === Last reset 02:33:16 ago, cause: software Last software reset at 2023-05-28 19:14, reason: HardFault imprec, Gcodes spinning, available RAM 5556, slot 1 Software reset code 0x4063 HFSR 0x40000000 CFSR 0x00000400 ICSR 0x00000803 BFAR 0xe000ed38 SP 0x20011b98 Task NETW Freestk 482 ok Stack: 2002be78 00000000 200014e8 0000019d 20032c8a 0002f6d1 00034064 810f0000 0002f6bd 00000000 00000000 00000000 2003129c 00000800 2002be60 2002be60 00000001 2002bd05 20018250 2001e438 0002f857 00000000 00000000 00000000 20011c48 00000014 00000000 Error status: 0x04 Aux0 errors 0,0,0 MCU revision 3, ADC conversions started 9196481, completed 9196480, timed out 0, errs 0 MCU temperature: min 35.7, current 36.3, max 37.1 Supply voltage: min 23.7, current 23.8, max 23.9, under voltage events: 0, over voltage events: 0, power good: yes Heap OK, handles allocated/used 99/32, heap memory allocated/used/recyclable 2048/1052/628, gc cycles 358 Events: 0 queued, 0 completed Driver 0: standstill, SG min 2, read errors 0, write errors 0, ifcnt 215, reads 28756, writes 0, timeouts 0, DMA errors 0, CC errors 0 Driver 1: standstill, SG min 0, read errors 0, write errors 0, ifcnt 215, reads 28756, writes 0, timeouts 0, DMA errors 0, CC errors 0 Driver 2: standstill, SG min 2, read errors 0, write errors 0, ifcnt 109, reads 28756, writes 0, timeouts 0, DMA errors 0, CC errors 0 Driver 3: standstill, SG min 2, read errors 0, write errors 0, ifcnt 110, reads 28756, writes 0, timeouts 0, DMA errors 0, CC errors 0 Driver 4: standstill, SG min 2, read errors 0, write errors 0, ifcnt 109, reads 28757, writes 0, timeouts 0, DMA errors 0, CC errors 0 Driver 5: standstill, SG min 0, read errors 0, write errors 0, ifcnt 32, reads 28756, writes 0, timeouts 0, DMA errors 0, CC errors 0 Driver 6: standstill, SG min 0, read errors 0, write errors 0, ifcnt 32, reads 28757, writes 0, timeouts 0, DMA errors 0, CC errors 0 Date/time: 2023-05-28 21:47:24 Cache data hit count 4294967295 Slowest loop: 79.96ms; fastest: 0.12ms === Storage === Free file entries: 18 SD card 0 detected, interface speed: 22.5MBytes/sec SD card longest read time 4.1ms, write time 39.0ms, max retries 0 === Move === DMs created 83, segments created 0, maxWait 0ms, bed compensation in use: none, comp offset 0.000 no step interrupt scheduled === DDARing 0 === Scheduled moves 0, completed 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1 === 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 1 is on, I-accum = 0.0 === GCodes === Movement locks held by null, null HTTP is ready with "M122 " in state(s) 0 Telnet is idle in state(s) 0 File is idle 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 Queue2 is idle in state(s) 0 Q0 segments left 0, axes/extruders owned 0x0000803 Code queue 0 is empty Q1 segments left 0, axes/extruders owned 0x0000000 Code queue 1 is empty === CAN === Messages queued 2846, received 6320, lost 0, boc 0 Longest wait 0ms for reply type 0, peak Tx sync delay 6, free buffers 18 (min 18), ts 1581/1581/0 Tx timeouts 0,0,0,0,0,0 === Network === Slowest loop: 19.94ms; fastest: 0.06ms Responder states: MQTT(0) HTTP(0) HTTP(0) HTTP(0) HTTP(0) FTP(0) Telnet(0) HTTP sessions: 1 of 8 = WiFi = Network state is active Module is connected to access point Failed messages: pending 0, notready 0, noresp 0 Firmware version 2.1beta4 MAC address bc:ff:4d:e6:b1:62 Module reset reason: Power up, Vcc 3.40, flash size 2097152, free heap 42996 WiFi IP address 192.168.10.50 Signal strength -53dBm, channel 1, 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-beta.3+ (2023-05-09 13:40:30) Bootloader ID: SAMC21 bootloader version 2.4 (2021-12-10) All averaging filters OK Never used RAM 4112, free system stack 38 words Tasks: Move(nWait,1.5%,93) HEAT(nWait,5.0%,57) CanAsync(nWait,0.0%,48) CanRecv(nWait,0.4%,74) CanClock(nWait,0.2%,67) ACCEL(nWait,0.0%,53) TMC(delaying,31.6%,57) MAIN(running,10.9%,346) IDLE(ready,0.0%,27) AIN(delaying,50.6%,142), total 100.0% Last reset 05:17:24 ago, cause: software Last software reset data not available Driver 0: pos 0, 568.8 steps/mm,standstill, SG min 0, read errors 1, write errors 1, ifcnt 46, reads 4821, writes 27, timeouts 1, DMA errors 0, CC errors 0, failedOp 0x01, steps req 0 done 4396932 Moves scheduled 68488, completed 68488, in progress 0, hiccups 2427, step errors 0, maxPrep 1404, maxOverdue 17166, maxInc 3246, mcErrs 0, gcmErrs 0 Peak sync jitter -6/10, peak Rx sync delay 333, resyncs 0/1, no timer interrupt scheduled VIN voltage: min 23.3, current 24.3, max 24.7 MCU temperature: min 43.3C, current 43.3C, max 80.6C Last sensors broadcast 0x00000012 found 2 181 ticks ago, 0 ordering errs, loop time 1 CAN messages queued 384593, send timeouts 0, received 245172, lost 0, free buffers 37, min 36, error reg 220000 dup 0, oos 0/0/0/0, bm 0, wbm 0, rxMotionDelay 535, adv 35598/74648 Accelerometer: LIS3DH, status: 00 I2C bus errors 0, naks 3, other errors 0
-
I've let the printer sit alone (not homed or anything since it shit the bed and rebooted last time).
Thought i would check the debug log again now to see if it rebooted more since last time i looked at it, and sure it has. One more time yesterday evening without being touched:
2023-05-28 21:47:29 [debug] Accelerometer: LIS3DH, status: 00 I2C bus errors 0, naks 3, other errors 0 power up + 00:00:03 [info] Event logging started at level debug power up + 00:00:03 [info] Running: Duet 3 Mini5plus WiFi: 3.5.0-beta.3+ (2023-05-09 10:59:17) power up + 00:00:03 [debug] Done! power up + 00:00:03 [debug] RepRapFirmware for Duet 3 Mini 5+ is up and running. power up + 00:00:04 [warn] WiFi module started power up + 00:00:07 [warn] WiFi module is connected to access point RV32-IOT2G, IP address 192.168.10.50 power up + 00:00:09 [warn] HTTP client 192.168.10.100 login succeeded (session key 0) 2023-05-28 22:17:44 [warn] Date and time set at power up + 00:00:09
And some more M122's i just took:
M122 === Diagnostics === RepRapFirmware for Duet 3 Mini 5+ version 3.5.0-beta.3+ (2023-05-09 10:59:17) running on Duet 3 Mini5plus WiFi (standalone mode) Board ID: FAP55-Q967A-G65J0-401GL-0S02Z-RF9TL Used output buffers: 14 of 40 (28 max) === RTOS === Static ram: 101720 Dynamic ram: 123656 of which 12 recycled Never used RAM 13812, free system stack 180 words Tasks: NETWORK(nWait,68.7%,219) HEAT(nWait,0.2%,327) Move(nWait,0.0%,358) CanReceiv(nWait,0.5%,772) CanSender(nWait,0.0%,336) CanClock(delaying,0.1%,341) TMC(nWait,11.7%,108) MAIN(running,6.8%,444) IDLE(ready,3.9%,29) AIN(delaying,8.0%,266), total 100.0% Owned mutexes: WiFi(NETWORK) === Platform === Last reset 14:08:27 ago, cause: software Last software reset at 2023-05-28 22:17, reason: HardFault imprec, Gcodes spinning, available RAM 12360, slot 2 Software reset code 0x4063 HFSR 0x40000000 CFSR 0x00000400 ICSR 0x00000803 BFAR 0xe000ed38 SP 0x20011bb0 Task NETW Freestk 488 ok Stack: 2002be78 20031a60 200014e8 00000000 20032c37 0002f6d1 0002f5e8 610f6000 20035760 2002be60 20018250 2002bd05 20018250 2001e438 0002f857 00000000 00000000 00000000 20011c48 00000014 b5dd9f97 00000002 da360050 640aa8c0 0800019b 00000001 00033f31 Error status: 0x00 Aux0 errors 0,0,0 MCU revision 3, ADC conversions started 50907946, completed 50907946, timed out 0, errs 0 MCU temperature: min 34.5, current 36.7, max 39.2 Supply voltage: min 23.7, current 23.8, max 23.9, under voltage events: 0, over voltage events: 0, power good: yes Heap OK, handles allocated/used 99/28, heap memory allocated/used/recyclable 2048/916/532, gc cycles 1906 Events: 0 queued, 0 completed Driver 0: standstill, SG min 2, read errors 0, write errors 1, ifcnt 229, reads 40442, writes 13, timeouts 0, DMA errors 0, CC errors 0 Driver 1: standstill, SG min 0, read errors 0, write errors 1, ifcnt 229, reads 40442, writes 13, timeouts 0, DMA errors 0, CC errors 0 Driver 2: standstill, SG min 2, read errors 0, write errors 1, ifcnt 123, reads 40442, writes 13, timeouts 0, DMA errors 0, CC errors 0 Driver 3: standstill, SG min 2, read errors 0, write errors 1, ifcnt 124, reads 40442, writes 13, timeouts 0, DMA errors 0, CC errors 0 Driver 4: standstill, SG min 2, read errors 0, write errors 1, ifcnt 123, reads 40443, writes 13, timeouts 0, DMA errors 0, CC errors 0 Driver 5: standstill, SG min 0, read errors 0, write errors 1, ifcnt 43, reads 40445, writes 10, timeouts 0, DMA errors 0, CC errors 0 Driver 6: standstill, SG min 0, read errors 0, write errors 1, ifcnt 43, reads 40445, writes 10, timeouts 0, DMA errors 0, CC errors 0 Date/time: 2023-05-29 12:26:02 Cache data hit count 4294967295 Slowest loop: 27.00ms; fastest: 0.12ms === Storage === Free file entries: 18 SD card 0 detected, interface speed: 22.5MBytes/sec SD card longest read time 4.2ms, write time 2.1ms, max retries 0 === Move === DMs created 83, segments created 0, maxWait 0ms, bed compensation in use: none, comp offset 0.000 no step interrupt scheduled === DDARing 0 === Scheduled moves 0, completed 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1 === 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 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 idle 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 Queue2 is idle in state(s) 0 Q0 segments left 0, axes/extruders owned 0x0000803 Code queue 0 is empty Q1 segments left 0, axes/extruders owned 0x0000000 Code queue 1 is empty === CAN === Messages queued 458179, received 1018211, lost 0, boc 0 Longest wait 3ms for reply type 6053, peak Tx sync delay 276, free buffers 18 (min 17), ts 254540/254539/0 Tx timeouts 0,0,0,0,0,0 === Network === Slowest loop: 20.34ms; fastest: 0.00ms Responder states: MQTT(0) HTTP(2) HTTP(0) HTTP(0) HTTP(0) FTP(0) Telnet(0) HTTP sessions: 1 of 8 = WiFi = Network state is active Module is connected to access point Failed messages: pending 0, notready 0, noresp 0 Firmware version 2.1beta4 MAC address bc:ff:4d:e6:b1:62 Module reset reason: Power up, Vcc 3.38, flash size 2097152, free heap 36464 WiFi IP address 192.168.10.50 Signal strength -51dBm, channel 1, 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-beta.3+ (2023-05-09 13:40:30) Bootloader ID: SAMC21 bootloader version 2.4 (2021-12-10) All averaging filters OK Never used RAM 4112, free system stack 38 words Tasks: Move(nWait,0.1%,93) HEAT(nWait,22.6%,57) CanAsync(nWait,0.0%,48) CanRecv(nWait,0.5%,74) CanClock(nWait,0.8%,67) ACCEL(nWait,0.0%,53) TMC(nWait,137.2%,57) MAIN(running,205.0%,336) IDLE(ready,0.0%,27) AIN(delaying,219.4%,142), total 585.6% Last reset 19:56:02 ago, cause: software Last software reset data not available Driver 0: pos 0, 568.8 steps/mm,standstill, SG min 2, read errors 0, write errors 0, ifcnt 48, reads 13903, writes 2, timeouts 0, DMA errors 0, CC errors 0, steps req 0 done 0 Moves scheduled 68488, completed 68488, in progress 0, hiccups 0, step errors 0, maxPrep 0, maxOverdue 0, maxInc 0, mcErrs 0, gcmErrs 0 Peak sync jitter -5/9, peak Rx sync delay 219, resyncs 0/1, no timer interrupt scheduled VIN voltage: min 24.3, current 24.3, max 24.3 MCU temperature: min 41.8C, current 43.5C, max 80.6C Last sensors broadcast 0x00000012 found 2 235 ticks ago, 0 ordering errs, loop time 1 CAN messages queued 1054423, send timeouts 0, received 474470, lost 0, free buffers 37, min 37, error reg 110000 dup 0, oos 0/0/0/0, bm 0, wbm 0, rxMotionDelay 0 Accelerometer: LIS3DH, status: 00 I2C bus errors 0, naks 0, other errors 0
EDIT 18:08 29/5:
And the reboots keep happening, the 12:26:06 entry in the log is from the
M122 B121
request i posted just above here:2023-05-29 12:26:06 [debug] Accelerometer: LIS3DH, status: 00 I2C bus errors 0, naks 0, other errors 0 power up + 00:00:03 [info] Event logging started at level debug power up + 00:00:03 [info] Running: Duet 3 Mini5plus WiFi: 3.5.0-beta.3+ (2023-05-09 10:59:17) power up + 00:00:03 [debug] Done! power up + 00:00:03 [debug] RepRapFirmware for Duet 3 Mini 5+ is up and running. power up + 00:00:04 [warn] WiFi module started power up + 00:00:07 [warn] WiFi module is connected to access point RV32-IOT2G, IP address 192.168.10.50 power up + 00:00:08 [warn] HTTP client 192.168.10.100 login succeeded (session key 0) 2023-05-29 14:56:21 [warn] Date and time set at power up + 00:00:08
-
-
I hate to reply to my own thread, but is it any helpfull info contained in the diagnostics posts regarding this issue? Because it sure keeps happening, and lets just say these two issues sure renders any machines useless lol. Hope it's (still) on the radar for an fix or acknowledged as a persisting bug.
-
@Exerqtor please post a few more M122 reports for the main board after this issue happens. There does appear to be some commonality but I haven't identified the exact issue yet.
The crash happens in the WiFi module interface code. Do you have just a single PC running DWC as wifi client, or are there multiple clients?
Are you able to run RRF 3.4.5 to see whether the resets happen with that version?
-
@Exerqtor PS - please run M122 P500 S1 after reset (you can put this in config.g temporarily). This will reduce performance somewhat, but will provide more accurate reset data in the M122 report.
-
@dc42 said in Extruder stops extruding (again) & reboots randomly - RRF 3.5b3+:
@Exerqtor please post a few more M122 reports for the main board after this issue happens. There does appear to be some commonality but I haven't identified the exact issue yet.
The crash happens in the WiFi module interface code. Do you have just a single PC running DWC as wifi client, or are there multiple clients?
Ok, good to see it's something happening that's traceable!
Uhm DWC is mainly running on one pc/unit at a time. Either i'm at the office while printing, then I use the PC to check in on the printer. If i'm not in the office i use my phone (the pc might or might not be on/in hibernation). So for sake of argument lets say two units at a time?
Are you able to run RRF 3.4.5 to see whether the resets happen with that version?
I've deployed to many 3.5 dependant scripts at this point to make that swap tbh
😮💨
@dc42 said in Extruder stops extruding (again) & reboots randomly - RRF 3.5b3+:
@Exerqtor PS - please run M122 P500 S1 after reset (you can put this in config.g temporarily). This will reduce performance somewhat, but will provide more accurate reset data in the M122 report.
Ok, i added it as the last line in
config.g
and rebooted the machine before going to bed yesterday, so i'll check after work and report back. -
The printer haven't restartet (yet), but i just tried another print (one object) and it stopped extruding again!
Now it stopped on more or less the first print line on the first layer, and started agian in the second layer (then i canceled the print).M122's from when it's not extruding:
M122 === Diagnostics === RepRapFirmware for Duet 3 Mini 5+ version 3.5.0-beta.3+ (2023-05-09 10:59:17) running on Duet 3 Mini5plus WiFi (standalone mode) Board ID: FAP55-Q967A-G65J0-401GL-0S02Z-RF9TL Used output buffers: 4 of 40 (40 max) === RTOS === Static ram: 101720 Dynamic ram: 130896 of which 228 recycled Never used RAM 4860, free system stack 134 words Tasks: NETWORK(ready,224.7%,179) HEAT(nWait,0.7%,327) Move(nWait,0.4%,270) CanReceiv(nWait,1.2%,772) CanSender(nWait,0.0%,327) CanClock(delaying,0.2%,341) TMC(nWait,30.8%,74) MAIN(running,62.8%,335) IDLE(ready,10.7%,29) AIN(delaying,21.2%,266), total 352.6% Owned mutexes: WiFi(NETWORK) === Platform === Last reset 16:32:12 ago, cause: software Last software reset at 2023-06-01 00:47, reason: User, Gcodes spinning, available RAM 13792, slot 1 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 59533190, completed 59533190, timed out 0, errs 0 MCU temperature: min 33.9, current 45.6, max 46.0 Supply voltage: min 23.1, current 23.5, max 24.2, under voltage events: 0, over voltage events: 0, power good: yes Heap OK, handles allocated/used 198/33, heap memory allocated/used/recyclable 2048/1260/772, gc cycles 2264 Events: 0 queued, 0 completed Driver 0: ok, SG min 0, read errors 0, write errors 1, ifcnt 39, reads 38057, writes 51, timeouts 0, DMA errors 0, CC errors 0 Driver 1: ok, SG min 0, read errors 0, write errors 1, ifcnt 39, reads 38056, writes 51, timeouts 0, DMA errors 0, CC errors 0 Driver 2: standstill, SG min 0, read errors 0, write errors 1, ifcnt 167, reads 38078, writes 29, timeouts 0, DMA errors 0, CC errors 0 Driver 3: standstill, SG min 0, read errors 0, write errors 1, ifcnt 168, reads 38078, writes 29, timeouts 0, DMA errors 0, CC errors 0 Driver 4: ok, SG min 0, read errors 0, write errors 1, ifcnt 167, reads 38079, writes 29, timeouts 0, DMA errors 0, CC errors 0 Driver 5: standstill, SG min 0, read errors 0, write errors 1, ifcnt 65, reads 38098, writes 10, timeouts 0, DMA errors 0, CC errors 0 Driver 6: standstill, SG min 0, read errors 0, write errors 1, ifcnt 65, reads 38097, writes 10, timeouts 0, DMA errors 0, CC errors 0 Date/time: 2023-06-01 17:19:31 Cache data hit count 4294967295 Slowest loop: 239.37ms; fastest: 0.08ms === Storage === Free file entries: 16 SD card 0 detected, interface speed: 22.5MBytes/sec SD card longest read time 9.0ms, write time 62.2ms, max retries 0 === Move === DMs created 83, segments created 29, maxWait 58897889ms, bed compensation in use: mesh, comp offset 0.000 next step interrupt due in 45 ticks, enabled === DDARing 0 === Scheduled moves 364, completed 358, hiccups 0, stepErrors 0, LaErrors 0, 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 X181.195 Y162.316 E1.347" 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 doing "M0" 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 === CAN === Messages queued 538684, received 1190889, lost 0, boc 0 Longest wait 3ms for reply type 6053, peak Tx sync delay 275, free buffers 18 (min 14), ts 297665/297664/0 Tx timeouts 0,0,0,0,0,0 === Network === Slowest loop: 216.97ms; 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 = Network state is active Module is connected to access point Failed messages: pending 0, notready 0, noresp 0 Firmware version 2.1beta4 MAC address bc:ff:4d:e6:b1:62 Module reset reason: Power up, Vcc 3.38, flash size 2097152, free heap 43000 WiFi IP address 192.168.10.50 Signal strength -50dBm, channel 1, 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-beta.3+ (2023-05-09 13:40:30) Bootloader ID: SAMC21 bootloader version 2.4 (2021-12-10) All averaging filters OK Never used RAM 4232, free system stack 38 words Tasks: Move(nWait,0.1%,93) HEAT(nWait,13.2%,57) CanAsync(nWait,0.0%,53) CanRecv(nWait,0.3%,74) CanClock(nWait,0.5%,67) ACCEL(nWait,0.0%,53) TMC(nWait,80.4%,57) MAIN(running,128.9%,346) IDLE(ready,0.0%,27) AIN(delaying,128.5%,142), total 351.9% Last reset 16:32:19 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 67, reads 15903, writes 15, timeouts 0, DMA errors 0, CC errors 0, steps req 0 done 229311 Moves scheduled 2515, completed 2515, in progress 0, hiccups 133, step errors 0, maxPrep 1012, maxOverdue 4036, maxInc 2308, mcErrs 0, gcmErrs 0 Peak sync jitter -4/9, peak Rx sync delay 245, resyncs 0/0, no timer interrupt scheduled VIN voltage: min 23.3, current 24.4, max 24.7 MCU temperature: min 40.7C, current 68.1C, max 69.8C Last sensors broadcast 0x00000012 found 2 202 ticks ago, 0 ordering errs, loop time 1 CAN messages queued 1191020, send timeouts 0, received 538754, lost 0, free buffers 37, min 36, error reg 110000 dup 0, oos 0/0/0/0, bm 0, wbm 0, rxMotionDelay 513, adv 35873/74646 Accelerometer: LIS3DH, status: 00 I2C bus errors 0, naks 3, other errors 0
Debug log (with the M122 info scrubbed:
2023-06-01 17:17:13 [warn] Started printing file 0:/gcodes/print_job_0.16mm_ABS_0.4n_1h23m.gcode 2023-06-01 17:17:13 [debug] File 0:/gcodes/print_job_0.16mm_ABS_0.4n_1h23m.gcode selected for printing 2023-06-01 17:17:16 [info] M291: - [no title] - Print started, preheating. 2023-06-01 17:17:17 [info] G10 P0 S150 R150 2023-06-01 17:17:17 [debug] T:140.5 /150.0 T0:140.5 /150.0 B:110.2 /110.0 2023-06-01 17:17:18 [debug] T:139.9 /150.0 T0:139.9 /150.0 B:110.2 /110.0 2023-06-01 17:17:19 [debug] T:140.8 /150.0 T0:140.8 /150.0 B:110.2 /110.0 2023-06-01 17:17:20 [debug] T:143.6 /150.0 T0:143.6 /150.0 B:110.1 /110.0 2023-06-01 17:17:21 [debug] T:147.3 /150.0 T0:147.3 /150.0 B:110.1 /110.0 2023-06-01 17:17:23 [warn] HTTP client 192.168.10.100 login succeeded (session key 0) 2023-06-01 17:17:27 [warn] HTTP client 192.168.10.226 login succeeded (session key 0) 2023-06-01 17:17:36 [info] G10 P0 S150.0 2023-06-01 17:17:36 [info] G10 P0 S150.0 2023-06-01 17:17:36 [info] M291: - [no title] - Pre-print mesh probing enabled, probing new bed mesh! 2023-06-01 17:17:36 [debug] Default grid: X10.0:340.0, Y10.0:340.0, Number of points: X12 Y12, 144 points 2023-06-01 17:17:36 [debug] Adaptive grid: X160.918:189.082, Y147.261:202.739, Number of points: X3 Y3, 9 points 2023-06-01 17:17:38 [info] G10 P0 S150.0 2023-06-01 17:17:38 [debug] Z probe trigger height set to -1.361 mm 2023-06-01 17:17:39 [info] M291: - Mesh Probing - Probing now! Please wait... 2023-06-01 17:17:51 [info] G10 P0 S150.0 2023-06-01 17:17:52 [warn] 9 points probed, min error -0.017, max error 0.005, mean -0.007, deviation 0.006 Height map saved to file 0:/sys/heightmap.csv 2023-06-01 17:17:52 [debug] 9 points probed, min error -0.017, max error 0.005, mean -0.007, deviation 0.006 Height map saved to file 0:/sys/heightmap.csv 2023-06-01 17:17:52 [debug] Height map saved to file 0:/sys/adaptive_heightmap.csv 2023-06-01 17:17:54 [info] M291: - Mesh Probing - Done 2023-06-01 17:17:54 [info] G10 P0 S150.0 2023-06-01 17:17:55 [info] G10 P{global.initial_extruder} R{global.hotend_temp} S{global.hotend_temp} 2023-06-01 17:17:55 [debug] T:150.4 /255.0 T0:150.4 /255.0 B:110.0 /110.0 2023-06-01 17:17:56 [debug] T:150.5 /255.0 T0:150.5 /255.0 B:110.0 /110.0 2023-06-01 17:17:57 [debug] T:152.6 /255.0 T0:152.6 /255.0 B:110.0 /110.0 2023-06-01 17:17:58 [debug] T:156.5 /255.0 T0:156.5 /255.0 B:110.0 /110.0 2023-06-01 17:17:59 [debug] T:161.4 /255.0 T0:161.4 /255.0 B:110.0 /110.0 2023-06-01 17:18:00 [debug] T:167.0 /255.0 T0:167.0 /255.0 B:110.0 /110.0 2023-06-01 17:18:01 [debug] T:172.5 /255.0 T0:172.5 /255.0 B:110.0 /110.0 2023-06-01 17:18:02 [debug] T:178.2 /255.0 T0:178.2 /255.0 B:110.0 /110.0 2023-06-01 17:18:03 [debug] T:183.6 /255.0 T0:183.6 /255.0 B:110.0 /110.0 2023-06-01 17:18:04 [debug] T:189.0 /255.0 T0:189.0 /255.0 B:110.0 /110.0 2023-06-01 17:18:05 [debug] T:194.0 /255.0 T0:194.0 /255.0 B:110.0 /110.0 2023-06-01 17:18:06 [debug] T:199.3 /255.0 T0:199.3 /255.0 B:110.0 /110.0 2023-06-01 17:18:07 [debug] T:204.5 /255.0 T0:204.5 /255.0 B:110.0 /110.0 2023-06-01 17:18:08 [debug] T:209.7 /255.0 T0:209.7 /255.0 B:110.0 /110.0 2023-06-01 17:18:09 [debug] T:214.3 /255.0 T0:214.3 /255.0 B:110.0 /110.0 2023-06-01 17:18:10 [debug] T:219.3 /255.0 T0:219.3 /255.0 B:110.0 /110.0 2023-06-01 17:18:11 [debug] T:224.1 /255.0 T0:224.1 /255.0 B:110.0 /110.0 2023-06-01 17:18:12 [debug] T:228.9 /255.0 T0:228.9 /255.0 B:110.0 /110.0 2023-06-01 17:18:13 [debug] T:233.7 /255.0 T0:233.7 /255.0 B:110.0 /110.0 2023-06-01 17:18:14 [debug] T:238.0 /255.0 T0:238.0 /255.0 B:110.0 /110.0 2023-06-01 17:18:15 [debug] T:242.3 /255.0 T0:242.3 /255.0 B:110.0 /110.0 2023-06-01 17:18:16 [debug] T:246.4 /255.0 T0:246.4 /255.0 B:110.0 /110.0 2023-06-01 17:18:17 [debug] T:249.8 /255.0 T0:249.8 /255.0 B:110.0 /110.0 2023-06-01 17:18:18 [debug] T:252.4 /255.0 T0:252.4 /255.0 B:110.0 /110.0 2023-06-01 17:18:19 [info] M291: - [no title] - Purge location, X min: 135.918; Y min: 137.261; Purge move speed: 4.802495; Prepurge speed: 4.158004 2023-06-01 17:18:30 [debug] ABS filament loaded & config applied 2023-06-01 17:18:30 [debug] ABS filament loaded & config applied 2023-06-01 17:18:30 [debug] Maximum printing acceleration 5000.0, maximum travel acceleration 7000.0 mm/sec^2 2023-06-01 17:22:42 [warn] Resume state saved 2023-06-01 17:22:46 [warn] Printing paused at X179.6 Y161.4 Z1.4 2023-06-01 17:22:46 [debug] Printing paused at X179.6 Y161.4 Z1.4 2023-06-01 17:22:57 [debug] Done printing file 2023-06-01 17:22:57 [debug] Done printing file 2023-06-01 17:22:57 [warn] Cancelled printing file 0:/gcodes/print_job_0.16mm_ABS_0.4n_1h23m.gcode, print time was 0h 5m 2023-06-01 17:23:03 [info] G10 P0 R0 S0 2023-06-01 17:23:03 [debug] ABS filament unloaded & pressure advance disabled 2023-06-01 17:23:03 [debug] ABS filament unloaded & pressure advance disabled
-
@Exerqtor the issue with extrusion on tool boards stopping (actually reversing) is a known issue in 3.5beta3.
-
@dc42 said in Extruder stops extruding (again) & reboots randomly - RRF 3.5b3+:
@Exerqtor the issue with extrusion on tool boards stopping (actually reversing) is a known issue in 3.5beta3.
Yeah i knew it was in 3.5b3, but i thought the patch in b3+ sorted it out
😬
-
@Exerqtor OK, I didn't spot that you were running the patched version. There are still some extrusion issues on tool boards in that version.
-
@dc42 said in Extruder stops extruding (again) & reboots randomly - RRF 3.5b3+:
@Exerqtor OK, I didn't spot that you were running the patched version. There are still some extrusion issues on tool boards in that version.
Ok, if you have any newer binaries thats supposed to fix said issues i would be more than happy to try them if we put it like that
😆
-
@dc42 said in Extruder stops extruding (again) & reboots randomly - RRF 3.5b3+:
@Exerqtor PS - please run M122 P500 S1 after reset (you can put this in config.g temporarily). This will reduce performance somewhat, but will provide more accurate reset data in the M122 report.
Ok so i checked in on the debuglog now and the printer apparently restarted a couple times last evening (just been standing there collecting dust).
2023-06-02 20:55:23 [warn] HTTP client 192.168.10.100 disconnected power up + 00:00:03 [info] Event logging started at level debug power up + 00:00:03 [info] Running: Duet 3 Mini5plus WiFi: 3.5.0-beta.3+ (2023-05-09 10:59:17) power up + 00:00:03 [debug] Done! power up + 00:00:03 [debug] RepRapFirmware for Duet 3 Mini 5+ is up and running. power up + 00:00:04 [warn] WiFi module started power up + 00:00:07 [warn] WiFi module is connected to access point RV32-IOT2G, IP address 192.168.10.50 power up + 00:00:08 [warn] HTTP client 192.168.10.100 login succeeded (session key 0) 2023-06-02 21:19:35 [warn] Date and time set at power up + 00:00:08 power up + 00:00:03 [info] Event logging started at level debug power up + 00:00:03 [info] Running: Duet 3 Mini5plus WiFi: 3.5.0-beta.3+ (2023-05-09 10:59:17) power up + 00:00:03 [debug] Done! power up + 00:00:03 [debug] RepRapFirmware for Duet 3 Mini 5+ is up and running. power up + 00:00:04 [warn] WiFi module started power up + 00:00:07 [warn] WiFi module is connected to access point RV32-IOT2G, IP address 192.168.10.50 power up + 00:00:08 [warn] HTTP client 192.168.10.100 login succeeded (session key 0) 2023-06-02 21:24:36 [warn] Date and time set at power up + 00:00:08 power up + 00:00:03 [info] Event logging started at level debug power up + 00:00:03 [info] Running: Duet 3 Mini5plus WiFi: 3.5.0-beta.3+ (2023-05-09 10:59:17) power up + 00:00:03 [debug] Done! power up + 00:00:03 [debug] RepRapFirmware for Duet 3 Mini 5+ is up and running. power up + 00:00:04 [warn] WiFi module started power up + 00:00:07 [warn] WiFi module is connected to access point RV32-IOT2G, IP address 192.168.10.50 power up + 00:00:08 [warn] HTTP client 192.168.10.100 login succeeded (session key 0) 2023-06-03 05:24:05 [warn] Date and time set at power up + 00:00:08
Here is the M122:
M122 === Diagnostics === RepRapFirmware for Duet 3 Mini 5+ version 3.5.0-beta.3+ (2023-05-09 10:59:17) running on Duet 3 Mini5plus WiFi (standalone mode) Board ID: FAP55-Q967A-G65J0-401GL-0S02Z-RF9TL Used output buffers: 15 of 40 (30 max) === RTOS === Static ram: 101720 Dynamic ram: 123664 of which 0 recycled Never used RAM 13816, free system stack 184 words Tasks: NETWORK(nWait,155.6%,219) HEAT(nWait,0.2%,329) Move(nWait,0.0%,358) CanReceiv(nWait,0.4%,772) CanSender(nWait,0.0%,336) CanClock(delaying,0.1%,341) TMC(nWait,9.8%,108) MAIN(running,107.8%,444) IDLE(ready,3.3%,29) AIN(delaying,6.8%,266), total 284.1% Owned mutexes: WiFi(NETWORK) === Platform === Last reset 07:13:36 ago, cause: software Last software reset at 2023-06-03 05:23, reason: HardFault imprec, Gcodes spinning, available RAM 13792, slot 1 Software reset code 0x4063 HFSR 0x40000000 CFSR 0x00000400 ICSR 0x00000803 BFAR 0xe000ed38 SP 0x20011b98 Task NETW Freestk 482 ok Stack: 2002be78 00000000 200014e8 0000019f ffffffff 0002f6d1 00034064 810f0000 0002f6bd 00000000 00000000 00000000 20031a6c 00000800 20035760 2002be60 20018250 2002bd05 20018250 2001e438 0002f857 00000000 00000000 00000000 20011c48 00000014 b5dd9f97 Error status: 0x00 Aux0 errors 0,0,0 MCU revision 3, ADC conversions started 26016866, completed 26016866, timed out 0, errs 0 MCU temperature: min 33.5, current 36.3, max 37.6 Supply voltage: min 23.7, current 23.8, max 23.9, under voltage events: 0, over voltage events: 0, power good: yes Heap OK, handles allocated/used 99/28, heap memory allocated/used/recyclable 2048/468/84, gc cycles 974 Events: 0 queued, 0 completed Driver 0: standstill, SG min 2, read errors 0, write errors 1, ifcnt 83, reads 5830, writes 13, timeouts 0, DMA errors 0, CC errors 0 Driver 1: standstill, SG min 2, read errors 0, write errors 1, ifcnt 83, reads 5830, writes 13, timeouts 0, DMA errors 0, CC errors 0 Driver 2: standstill, SG min 0, read errors 0, write errors 1, ifcnt 211, reads 5830, writes 13, timeouts 0, DMA errors 0, CC errors 0 Driver 3: standstill, SG min 2, read errors 0, write errors 1, ifcnt 212, reads 5830, writes 13, timeouts 0, DMA errors 0, CC errors 0 Driver 4: standstill, SG min 0, read errors 0, write errors 1, ifcnt 211, reads 5831, writes 13, timeouts 0, DMA errors 0, CC errors 0 Driver 5: standstill, SG min 0, read errors 0, write errors 1, ifcnt 98, reads 5832, writes 10, timeouts 1, DMA errors 0, CC errors 0, failedOp 0x6f Driver 6: standstill, SG min 0, read errors 0, write errors 1, ifcnt 98, reads 5833, writes 10, timeouts 0, DMA errors 0, CC errors 0 Date/time: 2023-06-03 12:37:44 Cache data hit count 4294967295 Slowest loop: 22.63ms; fastest: 0.12ms === Storage === Free file entries: 18 SD card 0 detected, interface speed: 22.5MBytes/sec SD card longest read time 4.2ms, write time 2.1ms, max retries 0 === Move === DMs created 83, segments created 0, maxWait 0ms, bed compensation in use: none, comp offset 0.000 no step interrupt scheduled === DDARing 0 === Scheduled moves 0, completed 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1 === 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 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 idle 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 Queue2 is idle in state(s) 0 Q0 segments left 0, axes/extruders owned 0x0000803 Code queue 0 is empty Q1 segments left 0, axes/extruders owned 0x0000000 Code queue 1 is empty === CAN === Messages queued 234159, received 520381, lost 0, boc 0 Longest wait 3ms for reply type 6053, peak Tx sync delay 275, free buffers 18 (min 17), ts 130084/130083/0 Tx timeouts 0,0,0,0,0,0 === Network === Slowest loop: 19.72ms; 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 = Network state is active Module is connected to access point Failed messages: pending 0, notready 0, noresp 0 Firmware version 2.1beta4 MAC address bc:ff:4d:e6:b1:62 Module reset reason: Power up, Vcc 3.38, flash size 2097152, free heap 43000 WiFi IP address 192.168.10.50 Signal strength -54dBm, channel 1, mode 802.11n, reconnections 0 Clock register 00002001 Socket states: 0 0 0 0 0 0 0 0
-
@Exerqtor thanks. I made a mistake: the command needed in config.g is M122 P500 S0 not S1. Please make that change and send me the next M122 main board report after that. You can check that the setting is correct by sending M122 P500 without the S parameter - it should report "Write buffer is disabled".
-
@dc42
Aha, cool changed it to S0 now and checked, now it's disabled✌
-
@dc42
NOW i think "we" got it!2023-06-03 13:59:24 [debug] Write buffer is disabled power up + 00:00:03 [info] Event logging started at level debug power up + 00:00:03 [info] Running: Duet 3 Mini5plus WiFi: 3.5.0-beta.3+ (2023-05-09 10:59:17) power up + 00:00:03 [debug] Done! power up + 00:00:03 [debug] RepRapFirmware for Duet 3 Mini 5+ is up and running. power up + 00:00:04 [warn] WiFi module started power up + 00:00:07 [warn] WiFi module is connected to access point RV32-IOT2G, IP address 192.168.10.50 power up + 00:00:07 [warn] HTTP client 192.168.10.100 login succeeded (session key 0) 2023-06-03 15:52:38 [warn] Date and time set at power up + 00:00:07
M122 === Diagnostics === RepRapFirmware for Duet 3 Mini 5+ version 3.5.0-beta.3+ (2023-05-09 10:59:17) running on Duet 3 Mini5plus WiFi (standalone mode) Board ID: FAP55-Q967A-G65J0-401GL-0S02Z-RF9TL Used output buffers: 13 of 40 (28 max) === RTOS === Static ram: 101720 Dynamic ram: 123664 of which 0 recycled Never used RAM 13816, free system stack 184 words Tasks: NETWORK(nWait,68.6%,217) HEAT(nWait,0.1%,327) Move(nWait,0.0%,358) CanReceiv(nWait,0.2%,772) CanSender(nWait,0.0%,336) CanClock(delaying,0.0%,341) TMC(delaying,4.4%,108) MAIN(running,22.0%,444) IDLE(ready,1.5%,29) AIN(delaying,3.1%,266), total 100.0% Owned mutexes: WiFi(NETWORK) === Platform === Last reset 02:09:59 ago, cause: software Last software reset at 2023-06-03 15:52, reason: HardFault bfarValid precise, Platform spinning, available RAM 13816, slot 2 Software reset code 0x4060 HFSR 0x40000000 CFSR 0x00008200 ICSR 0x00000803 BFAR 0x0000001c SP 0x20011b98 Task NETW Freestk 482 ok Stack: 2002be78 20030218 200014e8 00000000 20032c37 0002f6d1 0002f5e4 610f0000 0002f6bd 00000000 00000000 00000000 20030224 00000800 20035760 2002be60 20018250 2002bd05 20018250 2001e438 0002f857 00000000 00000000 00000000 20011c48 00000014 b5dd9f97 Error status: 0x00 Aux0 errors 0,0,0 MCU revision 3, ADC conversions started 7800185, completed 7800184, timed out 0, errs 0 MCU temperature: min 35.7, current 36.9, max 40.4 Supply voltage: min 23.7, current 23.8, max 23.9, under voltage events: 0, over voltage events: 0, power good: yes Heap OK, handles allocated/used 99/28, heap memory allocated/used/recyclable 2048/1876/1492, gc cycles 291 Events: 0 queued, 0 completed Driver 0: standstill, SG min 2, read errors 0, write errors 1, ifcnt 97, reads 53695, writes 13, timeouts 0, DMA errors 0, CC errors 0 Driver 1: standstill, SG min 2, read errors 0, write errors 1, ifcnt 97, reads 53695, writes 13, timeouts 0, DMA errors 0, CC errors 0 Driver 2: standstill, SG min 0, read errors 0, write errors 1, ifcnt 225, reads 53695, writes 13, timeouts 0, DMA errors 0, CC errors 0 Driver 3: standstill, SG min 2, read errors 0, write errors 1, ifcnt 226, reads 53695, writes 13, timeouts 0, DMA errors 0, CC errors 0 Driver 4: standstill, SG min 0, read errors 0, write errors 1, ifcnt 225, reads 53695, writes 13, timeouts 0, DMA errors 0, CC errors 0 Driver 5: standstill, SG min 0, read errors 0, write errors 1, ifcnt 109, reads 53698, writes 10, timeouts 0, DMA errors 0, CC errors 0 Driver 6: standstill, SG min 0, read errors 0, write errors 1, ifcnt 109, reads 53698, writes 10, timeouts 0, DMA errors 0, CC errors 0 Date/time: 2023-06-03 18:02:30 Cache data hit count 4294967295 Slowest loop: 21.27ms; fastest: 0.12ms === Storage === Free file entries: 18 SD card 0 detected, interface speed: 22.5MBytes/sec SD card longest read time 4.2ms, write time 2.1ms, max retries 0 === Move === DMs created 83, segments created 0, maxWait 0ms, bed compensation in use: none, comp offset 0.000 no step interrupt scheduled === DDARing 0 === Scheduled moves 0, completed 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1 === 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 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 idle 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 idle 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 Queue2 is idle in state(s) 0 Q0 segments left 0, axes/extruders owned 0x0000803 Code queue 0 is empty Q1 segments left 0, axes/extruders owned 0x0000000 Code queue 1 is empty === CAN === Messages queued 70207, received 156041, lost 0, boc 0 Longest wait 3ms for reply type 6053, peak Tx sync delay 275, free buffers 18 (min 17), ts 39000/38999/0 Tx timeouts 0,0,0,0,0,0 === Network === Slowest loop: 20.23ms; 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 = Network state is active Module is connected to access point Failed messages: pending 0, notready 0, noresp 0 Firmware version 2.1beta4 MAC address bc:ff:4d:e6:b1:62 Module reset reason: Power up, Vcc 3.38, flash size 2097152, free heap 42288 WiFi IP address 192.168.10.50 Signal strength -50dBm, channel 1, mode 802.11n, reconnections 0 Clock register 00002001 Socket states: 0 0 0 0 0 0 0 0
-
@Exerqtor thanks again. Please try the Mini5+ RRF file at https://www.dropbox.com/sh/in0t2j68ic66oa8/AADv_6WzRy07H6MhBOrkDt23a?dl=0. Leave the M122 command in config.g, and post the main board M122 main board if it resets again.
-
@dc42
Will do, just installed the new binaries. This is just meant to remedy the restart issue right? Not the reversing extruder? -
@Exerqtor this may not remedy the resetting issue, but should remedy any extrusion issues.