RRF3.4 RC2 Filament/sensor error
-
Happened again at 44.5% of the print the same error code:
3/10/2022, 2:47:01 PM Error: Filament error on extruder 0: sensorErrorThis time I did the diagnostic codes before I resumed the print.
M1223/10/2022, 4:32:40 PM M122 === Diagnostics === RepRapFirmware for Duet 3 MB6HC version 3.4.0rc2 (2022-02-22 17:04:17) running on Duet 3 MB6HC v1.01 or later (SBC mode) Board ID: 08DJM-956BA-NA3TN-6JTD0-3SJ6S-1V82V Used output buffers: 8 of 40 (40 max) === RTOS === Static ram: 150984 Dynamic ram: 66520 of which 28 recycled Never used RAM 129828, free system stack 128 words Tasks: SBC(ready,120.2%,504) HEAT(notifyWait,2.6%,321) Move(notifyWait,231.3%,248) CanReceiv(notifyWait,4.1%,772) CanSender(notifyWait,3.2%,346) CanClock(delaying,0.9%,339) TMC(notifyWait,1474.5%,58) MAIN(running,2710.9%,923) IDLE(ready,0.1%,30), total 4547.8% Owned mutexes: HTTP(MAIN) === Platform === Last reset 19:42:02 ago, cause: power up Last software reset at 2022-03-10 01:24, reason: AssertionFailed, GCodes spinning, available RAM 129804, slot 2 Software reset code 0x4123 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00400000 BFAR 0x00000000 SP 0x2041b53c Task MAIN Freestk 1689 ok Stack: 00000599 004a3b00 00484adb 20429860 ffffffff 9b6a2e4b 2042c2dc 20419a7c 2042e1c4 ffffffff 00000000 9b6a2e7a 00484b0d 2041b58c 20429f28 20421e98 0048229f 2042e1c0 0045c7f3 00000000 2042e1c4 00000000 2041b59c 00000101 00000000 00000000 00000000 Error status: 0x04 Aux0 errors 0,0,0 Step timer max interval 149 MCU temperature: min 45.4, current 47.2, max 48.7 Supply voltage: min 23.9, current 24.0, max 24.1, under voltage events: 0, over voltage events: 0, power good: yes 12V rail voltage: min 12.0, current 12.1, max 12.1, under voltage events: 0 Heap OK, handles allocated/used 99/1, heap memory allocated/used/recyclable 2048/160/120, gc cycles 0 Events: 2 queued, 2 completed Driver 0: pos 36230, standstill, SG min 0, mspos 104, reads 17097, writes 0 timeouts 0 Driver 1: pos -35430, standstill, SG min 0, mspos 904, reads 17097, writes 0 timeouts 0 Driver 2: pos 40272, standstill, SG min 0, mspos 312, reads 17097, writes 0 timeouts 0 Driver 3: pos 0, standstill, SG min 0, mspos 840, reads 17097, writes 0 timeouts 0 Driver 4: pos 0, standstill, SG min 0, mspos 392, reads 17098, writes 0 timeouts 0 Driver 5: pos 0, standstill, SG min 0, mspos 24, reads 17098, writes 0 timeouts 0 Date/time: 2022-03-10 21:02:19 Slowest loop: 50.08ms; fastest: 0.04ms === Storage === Free file entries: 10 SD card 0 not detected, interface speed: 37.5MBytes/sec SD card longest read time 0.0ms, write time 0.0ms, max retries 0 === Move === DMs created 125, segments created 19, maxWait 1260ms, bed compensation in use: mesh, comp offset -0.455 === MainDDARing === Scheduled moves 602559, completed 602559, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1 === AuxDDARing === Scheduled moves 0, completed 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1 === Heat === Bed heaters 0 -1 -1 -1 -1 -1 -1 -1 -1 -1 -1 -1, chamber heaters -1 -1 -1 -1, ordering errs 0 Heater 0 is on, I-accum = 0.2 Heater 1 is on, I-accum = 0.0 === GCodes === Segments left: 0 Movement lock held by null HTTP* is doing "M122" in state(s) 0 Telnet is idle in state(s) 0 File* is 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 Aux2 is idle in state(s) 0 Autopause* is idle in state(s) 0 Code queue is empty === Filament sensors === Extruder 0: no data received === CAN === Messages queued 494841, received 472277, lost 0, boc 0 Longest wait 5ms for reply type 6024, peak Tx sync delay 301, free buffers 50 (min 45), ts 115176/115176/0 Tx timeouts 0,0,0,0,0,0 === SBC interface === Transfer state: 4, failed transfers: 0, checksum errors: 0 RX/TX seq numbers: 22180/22180 SPI underruns 0, overruns 0 State: 5, disconnects: 0, timeouts: 0, IAP RAM available 0x2b8b0 Buffer RX/TX: 0/0-0, open files: 0 === Duet Control Server === Duet Control Server v3.4-rc2 File /opt/dsf/sd/gcodes/Pandero 14in escalas_0.6n_0.3mm_PLA_18h27m.gcode is selected, paused Code buffer space: 4096 Configured SPI speed: 8000000Hz, TfrRdy pin glitches: 0 Full transfers per second: 39.26, max time between full transfers: 77.9ms, max pin wait times: 60.7ms/10.7ms Codes per second: 14.20 Maximum length of RX/TX data transfers: 3768/1716M122 B121
3/10/2022, 4:33:34 PM M122 B121 Diagnostics for board 121: Duet TOOL1LC rev 1.1 or later firmware version 3.4.0rc2 (2022-02-22 10:15:02) Bootloader ID: SAMC21 bootloader version 2.3 (2021-01-26b1) All averaging filters OK Never used RAM 2204, free system stack 17 words Tasks: Move(notifyWait,2.4%,99) HEAT(notifyWait,1.2%,95) CanAsync(notifyWait,0.0%,55) CanRecv(notifyWait,0.4%,74) CanClock(notifyWait,0.1%,65) ACCEL(notifyWait,0.0%,61) TMC(notifyWait,13.3%,57) MAIN(running,60.9%,351) IDLE(ready,0.0%,26) AIN(delaying,21.7%,142), total 100.0% Last reset 19:42:58 ago, cause: VDD brownout Last software reset data not available Driver 0: pos 35910153, 405.0 steps/mm,standstill, SG min 0, read errors 10, write errors 0, ifcnt 13, reads 15749, writes 0, timeouts 3, DMA errors 0, CC errors 0, failedOp 0x06, steps req 16566495 done 16566495 Moves scheduled 560607, completed 560607, in progress 0, hiccups 0, step errors 0, maxPrep 681, maxOverdue 0, maxInc 0, mcErrs 0, gcmErrs 0 Peak sync jitter 1/8, peak Rx sync delay 235, resyncs 0/0, no step interrupt scheduled VIN voltage: min 24.1, current 24.3, max 24.3 MCU temperature: min 37.8C, current 48.2C, max 53.2C Last sensors broadcast 0x00000002 found 1 70 ticks ago, 0 ordering errs, loop time 0 CAN messages queued 457092, send timeouts 0, received 473045, lost 0, free buffers 37, min 36, error reg 0 dup 0, oos 0/0/0/0, bm 0, wbm 0, rxMotionDelay 601, adv 35676/74660 Accelerometer: LIS3DH, status: 00 I2C bus errors 0, naks 0, other errors 0 === Filament sensors === Interrupt 4 to 34us, poll 8 to 2477us Driver 0: pos 139.92, errs: frame 206 parity 0 ovrun 0 pol 0 ovdue 0M591 D0
3/10/2022, 4:37:28 PM M591 D0 Duet3D rotating magnet filament monitor v3 on pin 121.io1.in, enabled, sensitivity 28.80mm/rev, allow 35% to 130%, check printing moves every 20.0mm, version 3, mag 129 agc 85, measured sensitivity 24.74mm/rev, min 98% max 103% over 33743.9mm -
@charliedrums You've kind of taken over someone else's thread. To keep things clear can you please create a new thread with your issue?
-
@phaedrux Sure thing will do Sorry about that.
-
@charliedrums said in RRF3.4 RC2 Filament/sensor error:
@phaedrux Sure thing will do Sorry about that.
No problem. I'd be curious to know if your issue also goes away when going back to fw 3.3
-
I made a thread on the issue.
Once this 17 hour print finishes I have a 20 hour print I have to do after this one. I can downgrade to 3.3 and see if it finishes without any problem but If you could point me in the right direction on how to downgrade I'd appreciate it. Also would I have to downgrade the tool board (1lc) as well?
-
Catched again. This time I executed M122 and M591 D0 before resuming the print.
11.03.2022, 19:21:28 M24 Printing resumed 11.03.2022, 19:21:21 M122 === Diagnostics === RepRapFirmware for Duet 3 MB6HC version 3.4.0rc2 (2022-02-22 17:04:17) running on Duet 3 MB6HC v1.01 or later (standalone mode) Board ID: 08DJM-956L2-G43S8-6J1D6-3SJ6R-KA0YG Used output buffers: 1 of 40 (40 max) === RTOS === Static ram: 150984 Dynamic ram: 98404 of which 0 recycled Never used RAM 81364, free system stack 116 words Tasks: NETWORK(ready,26.6%,199) ETHERNET(notifyWait,1.6%,166) HEAT(notifyWait,2.0%,321) Move(notifyWait,50.4%,243) CanReceiv(notifyWait,0.0%,944) CanSender(notifyWait,0.0%,355) CanClock(delaying,0.4%,333) TMC(notifyWait,89.7%,58) MAIN(running,47.4%,967) IDLE(ready,0.1%,30), total 218.2% Owned mutexes: === Platform === Last reset 49:04:02 ago, cause: software Last software reset time unknown, reason: User, GCodes spinning, available RAM 85132, slot 1 Software reset code 0x0003 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00400000 BFAR 0x00000000 SP 0x00000000 Task MAIN Freestk 0 n/a Error status: 0x04 Aux0 errors 0,1,0 Step timer max interval 184 MCU temperature: min 36.9, current 47.2, max 48.9 Supply voltage: min 12.2, current 27.2, max 27.5, under voltage events: 0, over voltage events: 0, power good: yes 12V rail voltage: min 11.4, current 12.2, max 12.5, under voltage events: 0 Heap OK, handles allocated/used 99/6, heap memory allocated/used/recyclable 2048/1440/1260, gc cycles 0 Events: 2 queued, 2 completed Driver 0: pos 0, standstill, SG min 0, mspos 296, reads 27362, writes 179 timeouts 0 Driver 1: pos 40000, standstill, SG min 0, mspos 408, reads 27360, writes 181 timeouts 0 Driver 2: pos 5685, standstill, SG min 0, mspos 600, reads 27471, writes 70 timeouts 0 Driver 3: pos 0, standstill, SG min 0, mspos 8, reads 27525, writes 16 timeouts 0 Driver 4: pos 0, standstill, SG min 0, mspos 72, reads 27407, writes 134 timeouts 0 Driver 5: pos 0, standstill, SG min 0, mspos 904, reads 27408, writes 134 timeouts 0 Date/time: 2022-03-11 19:21:12 Slowest loop: 79.06ms; fastest: 0.05ms === Storage === Free file entries: 9 SD card 0 detected, interface speed: 25.0MBytes/sec SD card longest read time 5.0ms, write time 131.1ms, max retries 0 === Move === DMs created 125, segments created 31, maxWait 8354511ms, bed compensation in use: mesh, comp offset 0.000 === MainDDARing === Scheduled moves 254484, completed 254484, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 3], CDDA state -1 === AuxDDARing === Scheduled moves 0, completed 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1 === Heat === Bed heaters 0 -1 -1 -1 -1 -1 -1 -1 -1 -1 -1 -1, chamber heaters 3 -1 -1 -1, ordering errs 0 Heater 0 is on, I-accum = 0.2 Heater 1 is on, I-accum = 0.6 Heater 3 is on, I-accum = 0.0 === GCodes === Segments left: 0 Movement lock held by 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 Aux2 is idle in state(s) 0 Autopause is idle in state(s) 0 Code queue is empty === Filament sensors === Extruder 0: pos 161.72, errs: frame 12 parity 0 ovrun 0 pol 0 ovdue 0 Extruder 1: pos 0.00, errs: frame 0 parity 0 ovrun 0 pol 0 ovdue 0 === CAN === Messages queued 1589784, received 0, lost 0, boc 0 Longest wait 0ms for reply type 0, peak Tx sync delay 0, free buffers 50 (min 50), ts 883214/0/0 Tx timeouts 0,0,883213,0,0,706569 last cancelled message type 4514 dest 127 === Network === Slowest loop: 131.55ms; fastest: 0.02ms Responder states: HTTP(0) HTTP(0) HTTP(0) HTTP(0) HTTP(0) HTTP(0) FTP(0) Telnet(0), 0 sessions Telnet(0), 0 sessions HTTP sessions: 1 of 8 - Ethernet - State: active Error counts: 0 0 1 0 0 Socket states: 5 2 2 2 2 2 0 0 11.03.2022, 19:21:14 M591 D0 Duet3D rotating magnet filament monitor v3 on pin io5.in, enabled, sensitivity 25.40mm/rev, allow 50% to 150%, check printing moves every 12.7mm, version 3, mag 131 agc 64, measured sensitivity 25.91mm/rev, min 94% max 107% over 26367.4mm 11.03.2022, 19:11:29 Resume state saved 11.03.2022, 19:11:27 Error: Filament error on extruder 0: sensorError -
@boa How do you have your cabling run?
Our best guess is that interference is corrupting the signal from the MFM and that RRF 3.3 wasn't very good at reporting that type of error.
-
@phaedrux
Blue path is filament sensor wiring - about 50cm long
Red are motors and heaters -
Well that path seems pretty clear from other cabling.
Is sensor error the only error that you get?
-
@phaedrux Yes. That is the only error. If there is a way to enable some debug logging I can do that to get more info.
And... probably not related completly, but I noticed that my stop.g causes chamber heater to go into active state, which was not the case with 3.3
stop.g:
T-1 M104 S0 T0 M104 S0 T1 M140 S0 R0 M141 S0 R0 ; disable chamber heater M144 S0 ; put heatbed on standby M106 P0 S0 M220 S100 M221 S100 D0 M221 S100 D1 M84 M300 P300 -
@boa said in RRF3.4 RC2 Filament/sensor error:
T-1 M104 S0 T0 M104 S0 T1 M140 S0 R0 M141 S0 R0 ; disable chamber heater M144 S0 ; put heatbed on standbyIf you send those commands manually does it behave the same with with the chamber heater? And is it active state with 0 temperature?
-
@phaedrux Yes. Sending manually
M141 S0 R0manually causes chamber heater switch to active with temps 0*C -
What if you just use M141 R0?
-
@phaedrux said in RRF3.4 RC2 Filament/sensor error:
What if you just use M141 R0?
This way it stays off. Thanks. However... what it is active, sending M141 R0 does not switch to off state. I wonder how DWC makes chamber heater off.
-
I just opened Object Model and...
I was expecting values from M591 command
M591 D0 P3 C"io5.in" S1 L25.4 R50:150 E12.7 A0which seems not to be the case.
-
@boa said in RRF3.4 RC2 Filament/sensor error:
I wonder how DWC makes chamber heater off.
What happens if you set the temp to -274?
-
@phaedrux said in RRF3.4 RC2 Filament/sensor error:
@boa said in RRF3.4 RC2 Filament/sensor error:
I wonder how DWC makes chamber heater off.
What happens if you set the temp to -274?
M141 R-274 Error: M141: Temperature too low for heater 3state is unchanged
-
How about -273?
-
@phaedrux
-273 is set and state does not change
If executed on active, it stays active, of on off it stays off -
I updated to official 3.4 release, and the issue is still reproducible.
20.03.2022, 19:17:00 Resume state saved 20.03.2022, 19:16:57 Error: Filament error on extruder 0: sensorError 20.03.2022, 12:27:04 80 points probed, min error -0.085, max error 0.175, mean 0.098, deviation 0.050 Height map saved to file 0:/sys/heightmap.csv 20.03.2022, 12:24:44 Leadscrew adjustments made: 0.322 -1.414, points used 2, (mean, deviation) before (-0.494, 0.579) after (0.000, 0.000) 20.03.2022, 12:23:29 Connected to 192.168.0.204Sensor reported after about 6h 50m of printing.
After resuming, works just fine.M122 shows nothing disturbing
M122 === Diagnostics === RepRapFirmware for Duet 3 MB6HC version 3.4.0 (2022-03-15 18:57:24) running on Duet 3 MB6HC v1.01 or later (standalone mode) Board ID: 08DJM-956L2-G43S8-6J1D6-3SJ6R-KA0YG Used output buffers: 1 of 40 (40 max) === RTOS === Static ram: 151000 Dynamic ram: 98868 of which 0 recycled Never used RAM 80884, free system stack 118 words Tasks: NETWORK(ready,13.6%,193) ETHERNET(notifyWait,0.6%,166) HEAT(notifyWait,0.6%,321) Move(notifyWait,18.1%,248) CanReceiv(notifyWait,0.0%,944) CanSender(notifyWait,0.0%,356) CanClock(delaying,0.1%,333) TMC(notifyWait,102.1%,58) MAIN(running,210.0%,1016) IDLE(ready,0.0%,30), total 345.1% Owned mutexes: === Platform === Last reset 07:00:42 ago, cause: power up Last software reset at 2022-03-14 16:09, reason: User, GCodes spinning, available RAM 85252, slot 2 Software reset code 0x0003 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00400000 BFAR 0x00000000 SP 0x00000000 Task MAIN Freestk 0 n/a Error status: 0x04 Aux0 errors 0,1,0 Step timer max interval 195 MCU temperature: min 23.6, current 45.3, max 45.7 Supply voltage: min 9.2, current 27.3, max 27.5, under voltage events: 0, over voltage events: 0, power good: yes 12V rail voltage: min 8.4, current 12.2, max 12.5, under voltage events: 1 Heap OK, handles allocated/used 99/8, heap memory allocated/used/recyclable 2048/240/0, gc cycles 0 Events: 1 queued, 1 completed Driver 0: ok, SG min 0, mspos 166, reads 30928, writes 47 timeouts 0 Driver 1: ok, SG min 0, mspos 120, reads 30928, writes 47 timeouts 0 Driver 2: stalled, SG min 0, mspos 498, reads 30943, writes 33 timeouts 0 Driver 3: standstill, SG min 0, mspos 8, reads 30950, writes 26 timeouts 0 Driver 4: ok, SG min 0, mspos 248, reads 30938, writes 38 timeouts 0 Driver 5: ok, SG min 0, mspos 103, reads 30938, writes 38 timeouts 0 Date/time: 2022-03-20 19:20:04 Slowest loop: 78.87ms; fastest: 0.05ms === Storage === Free file entries: 9 SD card 0 detected, interface speed: 25.0MBytes/sec SD card longest read time 4.5ms, write time 1.4ms, max retries 0 === Move === DMs created 125, segments created 31, maxWait 203567ms, bed compensation in use: mesh, comp offset 0.000 === MainDDARing === Scheduled moves 358986, completed 358977, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 4], CDDA state 3 === AuxDDARing === Scheduled moves 0, completed 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1 === Heat === Bed heaters 0 -1 -1 -1 -1 -1 -1 -1 -1 -1 -1 -1, chamber heaters 3 -1 -1 -1, ordering errs 0 Heater 0 is on, I-accum = 0.3 Heater 1 is on, I-accum = 0.7 === GCodes === Segments left: 1 Movement lock held by null HTTP is idle in state(s) 0 Telnet is idle in state(s) 0 File is doing "G1 X171.425003 Y45.29912 E.186246311" 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 Aux2 is idle in state(s) 0 Autopause is idle in state(s) 0 Code queue is empty === Filament sensors === Extruder 0: pos 142.03, errs: frame 0 parity 0 ovrun 0 pol 0 ovdue 0 Extruder 1: pos 0.00, errs: frame 0 parity 0 ovrun 0 pol 0 ovdue 0 === CAN === Messages queued 227184, received 0, lost 0, boc 0 Longest wait 0ms for reply type 0, peak Tx sync delay 0, free buffers 50 (min 50), ts 126215/0/0 Tx timeouts 0,0,126214,0,0,100968 last cancelled message type 30 dest 127 === Network === Slowest loop: 18.39ms; fastest: 0.02ms Responder states: HTTP(0) HTTP(0) HTTP(0) HTTP(0) HTTP(0) HTTP(0) FTP(0) Telnet(0), 0 sessions Telnet(0), 0 sessions HTTP sessions: 1 of 8 - Ethernet - State: active Error counts: 0 0 0 0 0 Socket states: 5 2 2 2 2 2 0 0Same thing with M591 D0
M591 D0 Duet3D rotating magnet filament monitor v3 on pin io5.in, enabled, sensitivity 25.40mm/rev, allow 50% to 150%, check printing moves every 12.7mm, version 3, mag 131 agc 64, measured sensitivity 26.03mm/rev, min 95% max 104% over 625.4mm
