2021-05-29 14:20:08 [warn] Started printing file 0:/gcodes/ScrewMount 4v7Dx.gcode 2021-05-29 14:20:08 [debug] File 0:/gcodes/ScrewMount 4v7Dx.gcode selected for printing 2021-05-29 14:20:08 [info] G10 P0 R205 2021-05-29 14:20:08 [info] G10 P0 R0 S0 2021-05-29 14:20:08 [info] G10 P1 R0 S0 2021-05-29 14:20:08 [info] G10 P2 R0 S0 2021-05-29 14:20:08 [debug] T0:60.4 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.8 /50.0 2021-05-29 14:20:09 [debug] T0:60.2 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.8 /50.0 2021-05-29 14:20:10 [debug] T0:60.0 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.8 /50.0 2021-05-29 14:20:11 [debug] T0:59.9 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.7 /50.0 2021-05-29 14:20:12 [debug] T0:59.7 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.7 /50.0 2021-05-29 14:20:13 [debug] T0:59.5 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.7 /50.0 2021-05-29 14:20:14 [debug] T0:59.3 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.7 /50.0 2021-05-29 14:20:15 [debug] T0:59.1 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.7 /50.0 2021-05-29 14:20:16 [debug] T0:59.0 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.7 /50.0 2021-05-29 14:20:17 [debug] T0:58.8 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.7 /50.0 2021-05-29 14:20:18 [debug] T0:58.6 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.7 /50.0 2021-05-29 14:20:19 [debug] T0:58.4 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.7 /50.0 2021-05-29 14:20:20 [debug] T0:58.3 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.7 /50.0 2021-05-29 14:20:21 [debug] T0:58.1 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.6 /50.0 2021-05-29 14:20:22 [debug] T0:58.0 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.6 /50.0 2021-05-29 14:20:23 [debug] T0:57.8 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.6 /50.0 2021-05-29 14:20:24 [debug] T0:57.6 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.6 /50.0 2021-05-29 14:20:25 [debug] T0:57.4 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.6 /50.0 2021-05-29 14:20:26 [debug] T0:57.3 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.6 /50.0 2021-05-29 14:20:27 [debug] T0:57.1 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.6 /50.0 2021-05-29 14:20:28 [debug] T0:57.0 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.5 /50.0 2021-05-29 14:20:29 [debug] T0:56.8 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.5 /50.0 2021-05-29 14:20:30 [debug] T0:56.6 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.5 /50.0 2021-05-29 14:20:31 [debug] T0:56.5 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.5 /50.0 2021-05-29 14:20:32 [debug] T0:56.3 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.6 /50.0 2021-05-29 14:20:33 [debug] T0:56.1 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.6 /50.0 2021-05-29 14:20:34 [debug] T0:56.0 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.6 /50.0 2021-05-29 14:20:35 [debug] T0:55.8 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.6 /50.0 2021-05-29 14:20:36 [debug] T0:55.6 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.6 /50.0 2021-05-29 14:20:37 [debug] T0:55.5 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.6 /50.0 2021-05-29 14:20:38 [debug] T0:55.4 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.6 /50.0 2021-05-29 14:20:39 [debug] T0:55.2 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.7 /50.0 2021-05-29 14:20:40 [debug] T0:55.1 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.7 /50.0 2021-05-29 14:20:41 [debug] T0:54.9 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.7 /50.0 2021-05-29 14:20:42 [debug] T0:54.8 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.8 /50.0 2021-05-29 14:20:43 [debug] T0:54.6 /0.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:47.8 /50.0 2021-05-29 14:20:44 [debug] T0:54.5 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.8 /50.0 2021-05-29 14:20:45 [debug] T0:54.3 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.8 /50.0 2021-05-29 14:20:46 [debug] T0:54.2 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.9 /50.0 2021-05-29 14:20:47 [debug] T0:54.0 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.9 /50.0 2021-05-29 14:20:48 [debug] T0:53.8 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.9 /50.0 2021-05-29 14:20:49 [debug] T0:53.7 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.9 /50.0 2021-05-29 14:20:50 [debug] T0:53.6 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:47.9 /50.0 2021-05-29 14:20:51 [debug] T0:53.4 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:48.0 /50.0 2021-05-29 14:20:52 [debug] T0:53.3 /0.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:48.0 /50.0 2021-05-29 14:20:53 [info] G10 P0 R175 S205 2021-05-29 14:21:20 [debug] 1 2021-05-29 14:21:20 [debug] Carriage coupling failed! 2021-05-29 14:21:38 [debug] 1 2021-05-29 14:21:38 [debug] Carriage coupling failed! 2021-05-29 14:22:04 [warn] Leadscrew adjustments made: -0.026 -0.036 -0.031, points used 3, (mean, deviation) before (-0.031, 0.003) after (-0.000, 0.000) 2021-05-29 14:22:04 [debug] Leadscrew adjustments made: -0.026 -0.036 -0.031, points used 3, (mean, deviation) before (-0.031, 0.003) after (-0.000, 0.000) 2021-05-29 14:22:04 [debug] Gantry deviation of 0.003mm obtained. 2021-05-29 14:22:08 [debug] === Diagnostics === 2021-05-29 14:22:08 [debug] RepRapFirmware for Duet 3 MB6HC version 3.3RC1 (2021-05-01 09:12:50) running on Duet 3 MB6HC v0.6 or 1.0 (standalone mode) 2021-05-29 14:22:08 [debug] Board ID: 08DJM-956L2-G43S4-6JKDD-3SJ6L-TB62G 2021-05-29 14:22:08 [debug] Used output buffers: 2 of 40 (40 max) 2021-05-29 14:22:08 [debug] === RTOS === 2021-05-29 14:22:08 [debug] Static ram: 150680 2021-05-29 14:22:08 [debug] Dynamic ram: 94968 of which 40 recycled 2021-05-29 14:22:08 [debug] Never used RAM 105648, free system stack 119 words 2021-05-29 14:22:08 [debug] Tasks: 2021-05-29 14:22:08 [debug] NETWORK(ready,25.6%,194) 2021-05-29 14:22:08 [debug] ETHERNET(notifyWait,0.3%,120) 2021-05-29 14:22:08 [debug] HEAT(delaying,0.0%,295) 2021-05-29 14:22:08 [debug] Move(notifyWait,0.1%,176) 2021-05-29 14:22:08 [debug] CanReceiv(notifyWait,0.0%,773) 2021-05-29 14:22:08 [debug] CanSender(notifyWait,0.0%,359) 2021-05-29 14:22:08 [debug] CanClock(delaying,0.0%,341) 2021-05-29 14:22:08 [debug] TMC(notifyWait,8.2%,59) 2021-05-29 14:22:08 [debug] MAIN(running,65.8%,516) 2021-05-29 14:22:08 [debug] IDLE(ready,0.0%,29) 2021-05-29 14:22:08 [debug] , total 100.0% Owned mutexes: 2021-05-29 14:22:08 [debug] File(MAIN) 2021-05-29 14:22:08 [debug] === Platform === 2021-05-29 14:22:08 [debug] Last reset 00:28:09 ago, cause: software 2021-05-29 14:22:08 [debug] Last software reset at 2021-05-29 13:53, reason: User, GCodes spinning, available RAM 105688, slot 0 2021-05-29 14:22:08 [debug] Software reset code 0x0003 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00400000 BFAR 0x00000000 SP 0x00000000 Task MAIN Freestk 0 n/a 2021-05-29 14:22:08 [debug] Error status: 0x04 2021-05-29 14:22:08 [debug] Aux0 errors 0,0,0 2021-05-29 14:22:08 [debug] Aux1 errors 0,0,0 2021-05-29 14:22:08 [debug] Step timer max interval 135 2021-05-29 14:22:08 [debug] MCU temperature: min 41.9, current 42.1, max 42.5 2021-05-29 14:22:08 [debug] Supply voltage: min 31.8, current 31.9, max 31.9, under voltage events: 0, over voltage events: 0, power good: yes 2021-05-29 14:22:08 [debug] 12V rail voltage: min 12.0, current 12.1, max 12.1, under voltage events: 0 2021-05-29 14:22:08 [debug] Heap OK, handles allocated/used 99/0, heap memory allocated/used/recyclable 2048/600/600, gc cycles 0 2021-05-29 14:22:08 [debug] Driver 0: position 320000, standstill, reads 3318, writes 4 timeouts 0, SG min/max 0/638 2021-05-29 14:22:08 [debug] Driver 1: position 0, standstill, reads 3318, writes 4 timeouts 0, SG min/max 0/1023 2021-05-29 14:22:08 [debug] Driver 2: position 28800, standstill, reads 3311, writes 16 timeouts 0, SG min/max 0/159 2021-05-29 14:22:08 [debug] Driver 3: position 0, ok, reads 3317, writes 4 timeouts 0, SG min/max 0/396 2021-05-29 14:22:08 [debug] Driver 4: position 0, ok, reads 3318, writes 4 timeouts 0, SG min/max 0/704 2021-05-29 14:22:08 [debug] Driver 5: position 0, ok, reads 3317, writes 4 timeouts 0, SG min/max 0/1023 2021-05-29 14:22:08 [debug] Date/time: 2021-05-29 14:22:08 [debug] 2021-05-29 14:22:08 2021-05-29 14:22:08 [debug] Slowest loop: 68.89ms; fastest: 0.03ms 2021-05-29 14:22:08 [debug] === Storage === Free file entries: 7 2021-05-29 14:22:08 [debug] SD card 0 detected, interface speed: 25.0MBytes/sec 2021-05-29 14:22:08 [debug] SD card longest read time 3.3ms, write time 3.6ms, max retries 0 2021-05-29 14:22:08 [debug] === Move === DMs created 125, maxWait 294458ms, bed compensation in use: none, comp offset 0.000 2021-05-29 14:22:08 [debug] === MainDDARing === Scheduled moves 77, completed moves 76, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1 2021-05-29 14:22:08 [debug] === AuxDDARing === Scheduled moves 0, completed moves 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1 2021-05-29 14:22:08 [debug] === Heat === Bed heaters = 2021-05-29 14:22:08 [debug] 0 2021-05-29 14:22:08 [debug] -1 2021-05-29 14:22:08 [debug] -1 2021-05-29 14:22:08 [debug] -1 2021-05-29 14:22:08 [debug] -1 2021-05-29 14:22:08 [debug] -1 2021-05-29 14:22:08 [debug] -1 2021-05-29 14:22:08 [debug] -1 2021-05-29 14:22:08 [debug] -1 2021-05-29 14:22:08 [debug] -1 2021-05-29 14:22:08 [debug] -1 2021-05-29 14:22:08 [debug] -1 2021-05-29 14:22:08 [debug] , chamberHeaters = 2021-05-29 14:22:08 [debug] -1 2021-05-29 14:22:08 [debug] -1 2021-05-29 14:22:08 [debug] -1 2021-05-29 14:22:08 [debug] -1 2021-05-29 14:22:08 [debug] Heater 0 is on, I-accum = 0.3 2021-05-29 14:22:08 [debug] === GCodes === 2021-05-29 14:22:08 [debug] Segments left: 0 2021-05-29 14:22:08 [debug] Movement lock held by File 2021-05-29 14:22:08 [debug] HTTP is idle in state(s) 0 2021-05-29 14:22:08 [debug] Telnet is idle in state(s) 0 2021-05-29 14:22:08 [debug] File is ready with "M122 B0 " in state(s) 0 15, running macro 2021-05-29 14:22:08 [debug] USB is idle in state(s) 0 2021-05-29 14:22:08 [debug] Aux is idle in state(s) 0 2021-05-29 14:22:08 [debug] Trigger is idle in state(s) 0 2021-05-29 14:22:08 [debug] Queue is idle in state(s) 0 2021-05-29 14:22:08 [debug] LCD is idle in state(s) 0 2021-05-29 14:22:08 [debug] SBC is idle in state(s) 0 2021-05-29 14:22:08 [debug] Daemon is idle in state(s) 0 2021-05-29 14:22:08 [debug] Aux2 is idle in state(s) 0 2021-05-29 14:22:08 [debug] Autopause is idle in state(s) 0 2021-05-29 14:22:08 [debug] Code queue is empty. 2021-05-29 14:22:08 [debug] === CAN === Messages queued 9801, send timeouts 0, received 9373, lost 0, longest wait 21ms for reply type 6024, peak Tx sync delay 351, free buffers 49 (min 33) 2021-05-29 14:22:08 [debug] === Network === 2021-05-29 14:22:08 [debug] Slowest loop: 16.44ms; fastest: 0.02ms 2021-05-29 14:22:08 [debug] Responder states: 2021-05-29 14:22:08 [debug] HTTP(0) 2021-05-29 14:22:08 [debug] HTTP(0) 2021-05-29 14:22:08 [debug] HTTP(0) 2021-05-29 14:22:08 [debug] HTTP(0) 2021-05-29 14:22:08 [debug] HTTP(0) 2021-05-29 14:22:08 [debug] HTTP(0) 2021-05-29 14:22:08 [debug] FTP(0) 2021-05-29 14:22:08 [debug] Telnet(0), 0 sessions 2021-05-29 14:22:08 [debug] Telnet(0), 0 sessions 2021-05-29 14:22:08 [debug] HTTP sessions: 3 of 8 2021-05-29 14:22:08 [debug] - Ethernet - State: active 2021-05-29 14:22:08 [debug] Error counts: 0 0 1 0 0 Socket states: 2021-05-29 14:22:08 [debug] 2 2021-05-29 14:22:08 [debug] 2 2021-05-29 14:22:08 [debug] 2 2021-05-29 14:22:08 [debug] 2 2021-05-29 14:22:08 [debug] 2 2021-05-29 14:22:08 [debug] 0 2021-05-29 14:22:08 [debug] 0 2021-05-29 14:22:08 [debug] 0 2021-05-29 14:22:08 [debug] Diagnostics for board 1: 2021-05-29 14:22:08 [debug] Duet EXP3HC firmware version 3.3RC1 (2021-04-29 10:20:51) Bootloader ID: SAME5x bootloader version 2.2 (2021-01-16b1) 2021-05-29 14:22:08 [debug] Never used RAM 159136, free system stack 0 words Tasks: Move(notifyWait,0.0%,100) HEAT(delaying,0.0%,88) CanAsync(notifyWait,0.0%,72) CanRecv(notifyWait,0.0%,81) CanClock(notifyWait,0.0%,74) TMC(notifyWait,25.0%,29) MAIN(running,73.5%,339) IDLE(ready,0.0%,40) AIN(delaying,1.4%,263), total 100.0% Last reset 00:28:10 ago, cause: software 2021-05-29 14:22:08 [debug] Last software reset time unknown, reason: AssertionFailed, available RAM 159320, slot 1 Software reset code 0x0120 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00000000 BFAR 0xe000ed38 SP 0x20004754 Task HEAT Freestk 142 bad marker 2021-05-29 14:22:08 [debug] Stack: 00000544 0002eb94 000261af 42000400 000223e3 2002f020 00000000 2002f038 2000151c 00000000 0001d681 0002dd80 0002de38 0002d43c 000b0000 2000159c 00000000 2002f020 00015609 00000000 000009c4 000009c4 a5a5a5a5 a5a5a5a5 a5a5a5a5 a5a5a5a5 00024ff5 2021-05-29 14:22:08 [debug] Driver 0: position -860480, 320.0 steps/mm, standstill, reads 40559, writes 4 timeouts 0, SG min/max 0/485, steps req 4706542 done 4451830 Driver 1: position 471360, 320.0 steps/mm, standstill, reads 40559, writes 4 timeouts 0, SG min/max 0/1023, steps req 2751110 done 2496398 Driver 2: position 0, 80.0 steps/mm, standstill, reads 40563, writes 0 timeouts 0, SG min/max not available, steps req 0 done 0 2021-05-29 14:22:08 [debug] Moves scheduled 13348, completed 13348, in progress 0, hiccups 0, step errors 0, maxPrep 74, maxOverdue 2, maxInc 1, mcErrs 0, gcmErrs 0 Peak sync jitter 10, peak Rx sync delay 235, resyncs 0, no step interrupt scheduled VIN: 32.1V, V12: 12.1V MCU temperature: min 37.3C, current 38.8C, max 39.4C Ticks since heat task active 118, ADC conversions started 1690336, completed 1690336, timed out 0, errs 0 2021-05-29 14:22:08 [debug] Last sensors broadcast 0x00000000 found 0 126 ticks ago, loop time 0 CAN messages queued 2395, send timeouts 0, received 9827, lost 0, free buffers 36, min 36, error reg 0 dup 0, oos 0, bm 0, wbm 0 2021-05-29 14:22:08 [debug] Diagnostics for board 2: 2021-05-29 14:22:08 [debug] Duet EXP3HC firmware version 3.3RC1 (2021-04-29 10:20:51) Bootloader ID: not available 2021-05-29 14:22:08 [debug] Never used RAM 158184, free system stack 0 words Tasks: Move(notifyWait,0.0%,92) HEAT(delaying,0.0%,63) CanAsync(notifyWait,0.0%,72) CanRecv(notifyWait,0.0%,81) CanClock(notifyWait,0.0%,74) TMC(notifyWait,24.1%,29) MAIN(running,74.4%,301) IDLE(ready,0.0%,40) AIN(delaying,1.4%,263), total 100.0% Last reset 00:28:10 ago, cause: software 2021-05-29 14:22:08 [debug] Last software reset at 2021-05-25 23:19, reason: AssertionFailed, available RAM 158184, slot 2 Software reset code 0x0120 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00000000 BFAR 0xe000ed38 SP 0x20004764 Task HEAT Freestk 146 ok 2021-05-29 14:22:08 [debug] Stack: 00000544 0002eb10 000260ff 42000400 0002232f 00000000 00000020 2002f020 2000159c 00000003 0001d25b 00000000 2002f020 00000020 000157b1 00000000 000d205a 000d205a 41c13260 a5a5a5a5 a5a5a5a5 a5a5a5a5 00024f45 a5a5a5a5 00000058 00000000 2002ee70 2021-05-29 14:22:08 [debug] Driver 0: position 721794, 830.0 steps/mm, standstill, reads 15105, writes 4 timeouts 0, SG min/max 0/226, steps req 196389 done 196389 Driver 1: position 0, 830.0 steps/mm, standstill, reads 15111, writes 0 timeouts 0, SG min/max not available, steps req 0 done 0 Driver 2: position 0, 830.0 steps/mm, standstill, reads 15110, writes 0 timeouts 0, SG min/max not available, steps req 0 done 0 2021-05-29 14:22:08 [debug] Moves scheduled 12677, completed 12677, in progress 0, hiccups 0, step errors 0, maxPrep 49, maxOverdue 0, maxInc 0, mcErrs 0, gcmErrs 0 Peak sync jitter 12, peak Rx sync delay 180, resyncs 1, no step interrupt scheduled VIN: 24.1V, V12: 12.2V MCU temperature: min 38.7C, current 39.3C, max 39.6C Ticks since heat task active 240, ADC conversions started 1690424, completed 1690423, timed out 0, errs 0 2021-05-29 14:22:08 [debug] Last sensors broadcast 0x0000000e found 3 248 ticks ago, loop time 0 CAN messages queued 6810, send timeouts 0, received 7318, lost 0, free buffers 36, min 36, error reg 0 dup 0, oos 0, bm 0, wbm 0 2021-05-29 14:22:10 [debug] T:175.1 /205.0 T0:175.1 /205.0 T1:-273.1 /0.0 T2:27.1 /0.0 B:49.5 /50.0 2021-05-29 14:22:11 [debug] T:175.4 /205.0 T0:175.4 /205.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:49.6 /50.0 2021-05-29 14:22:12 [debug] T:176.5 /205.0 T0:176.5 /205.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:49.6 /50.0 2021-05-29 14:22:13 [debug] T:178.1 /205.0 T0:178.1 /205.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:49.6 /50.0 2021-05-29 14:22:14 [debug] T:180.2 /205.0 T0:180.2 /205.0 T1:-273.1 /0.0 T2:27.0 /0.0 B:49.6 /50.0 2021-05-29 14:22:15 [debug] T:182.5 /205.0 T0:182.5 /205.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:49.6 /50.0 2021-05-29 14:22:16 [debug] T:185.2 /205.0 T0:185.2 /205.0 T1:-273.1 /0.0 T2:27.2 /0.0 B:49.7 /50.0 2021-05-29 14:22:17 [debug] T:187.8 /205.0 T0:187.8 /205.0 T1:-273.1 /0.0 T2:27.1 /0.0 B:49.7 /50.0 2021-05-29 14:22:18 [debug] T:190.6 /205.0 T0:190.6 /205.0 T1:-273.1 /0.0 T2:27.1 /0.0 B:49.7 /50.0 2021-05-29 14:22:19 [debug] T:193.4 /205.0 T0:193.4 /205.0 T1:-273.1 /0.0 T2:27.1 /0.0 B:49.7 /50.0 2021-05-29 14:22:20 [debug] T:196.2 /205.0 T0:196.2 /205.0 T1:-273.1 /0.0 T2:27.1 /0.0 B:49.7 /50.0 2021-05-29 14:22:21 [debug] T:198.8 /205.0 T0:198.8 /205.0 T1:-273.1 /0.0 T2:26.9 /0.0 B:49.7 /50.0 2021-05-29 14:22:21 [debug] X-Max Deactivated 2021-05-29 14:33:23 [warn] Warning: Discarded std reply src=2 RID=434 exp 435 "ps 0" 2021-05-29 14:39:07 [debug] Diagnostics for board 2: 2021-05-29 14:39:07 [debug] Duet EXP3HC firmware version 3.3RC1 (2021-04-29 10:20:51) Bootloader ID: not available 2021-05-29 14:39:07 [debug] Never used RAM 158184, free system stack 0 words Tasks: Move(notifyWait,0.2%,92) HEAT(delaying,0.0%,63) CanAsync(notifyWait,0.0%,72) CanRecv(notifyWait,0.1%,81) CanClock(notifyWait,0.0%,74) TMC(notifyWait,24.6%,29) MAIN(running,73.7%,301) IDLE(ready,0.0%,40) AIN(delaying,1.5%,263), total 100.0% Last reset 00:45:09 ago, cause: software 2021-05-29 14:39:07 [debug] Last software reset at 2021-05-25 23:19, reason: AssertionFailed, available RAM 158184, slot 2 Software reset code 0x0120 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00000000 BFAR 0xe000ed38 SP 0x20004764 Task HEAT Freestk 146 ok 2021-05-29 14:39:07 [debug] Stack: 00000544 0002eb10 000260ff 42000400 0002232f 00000000 00000020 2002f020 2000159c 00000003 0001d25b 00000000 2002f020 00000020 000157b1 00000000 000d205a 000d205a 41c13260 a5a5a5a5 a5a5a5a5 a5a5a5a5 00024f45 a5a5a5a5 00000058 00000000 2002ee70 2021-05-29 14:39:07 [debug] Driver 0: position 1676920, 830.0 steps/mm, ok, reads 301, writes 2 timeouts 0, SG min/max 0/832, steps req 1016234 done 1016216 Driver 1: position 0, 830.0 steps/mm, standstill, reads 303, writes 0 timeouts 0, SG min/max not available, steps req 0 done 0 Driver 2: position 0, 830.0 steps/mm, standstill, reads 302, writes 0 timeouts 0, SG min/max not available, steps req 0 done 0 2021-05-29 14:39:07 [debug] Moves scheduled 52023, completed 52017, in progress 1, hiccups 0, step errors 0, maxPrep 55, maxOverdue 0, maxInc 0, mcErrs 0, gcmErrs 0 Peak sync jitter 12, peak Rx sync delay 181, resyncs 0, next step interrupt due in 11721 ticks, enabled VIN: 24.1V, V12: 12.2V MCU temperature: min 38.7C, current 39.9C, max 40.2C Ticks since heat task active 175, ADC conversions started 2709358, completed 2709358, timed out 0, errs 0 2021-05-29 14:39:07 [debug] Last sensors broadcast 0x0000000e found 3 184 ticks ago, loop time 0 CAN messages queued 12276, send timeouts 0, received 48538, lost 0, free buffers 36, min 36, error reg 0 dup 0, oos 0, bm 0, wbm 0 2021-05-29 14:42:25 [debug] Diagnostics for board 2: 2021-05-29 14:42:25 [debug] Duet EXP3HC firmware version 3.3RC1 (2021-04-29 10:20:51) Bootloader ID: not available 2021-05-29 14:42:25 [debug] Never used RAM 158184, free system stack 0 words Tasks: Move(notifyWait,0.2%,92) HEAT(delaying,0.0%,63) CanAsync(notifyWait,0.0%,72) CanRecv(notifyWait,0.1%,81) CanClock(notifyWait,0.0%,74) TMC(notifyWait,24.5%,29) MAIN(running,73.6%,301) IDLE(ready,0.0%,40) AIN(delaying,1.5%,263), total 100.0% Last reset 00:48:27 ago, cause: software 2021-05-29 14:42:25 [debug] Last software reset at 2021-05-25 23:19, reason: AssertionFailed, available RAM 158184, slot 2 Software reset code 0x0120 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00000000 BFAR 0xe000ed38 SP 0x20004764 Task HEAT Freestk 146 ok 2021-05-29 14:42:25 [debug] Stack: 00000544 0002eb10 000260ff 42000400 0002232f 00000000 00000020 2002f020 2000159c 00000003 0001d25b 00000000 2002f020 00000020 000157b1 00000000 000d205a 000d205a 41c13260 a5a5a5a5 a5a5a5a5 a5a5a5a5 00024f45 a5a5a5a5 00000058 00000000 2002ee70 2021-05-29 14:42:25 [debug] Driver 0: position 1861345, 830.0 steps/mm, ok, reads 49880, writes 0 timeouts 0, SG min/max 0/659, steps req 197231 done 196702 Driver 1: position 0, 830.0 steps/mm, standstill, reads 49879, writes 0 timeouts 0, SG min/max not available, steps req 0 done 0 Driver 2: position 0, 830.0 steps/mm, standstill, reads 49879, writes 0 timeouts 0, SG min/max not available, steps req 0 done 0 2021-05-29 14:42:25 [debug] Moves scheduled 63200, completed 63199, in progress 1, hiccups 0, step errors 0, maxPrep 52, maxOverdue 0, maxInc 0, mcErrs 0, gcmErrs 0 Peak sync jitter 12, peak Rx sync delay 183, resyncs 0, next step interrupt due in 74 ticks, enabled VIN: 24.1V, V12: 12.2V MCU temperature: min 38.7C, current 39.9C, max 40.2C Ticks since heat task active 174, ADC conversions started 2907858, completed 2907858, timed out 0, errs 0 2021-05-29 14:42:25 [debug] Last sensors broadcast 0x0000000e found 3 180 ticks ago, loop time 0 CAN messages queued 2427, send timeouts 0, received 12976, lost 0, free buffers 36, min 36, error reg 0 dup 0, oos 0, bm 0, wbm 0 2021-05-29 14:49:05 [debug] Diagnostics for board 2: 2021-05-29 14:49:05 [debug] Duet EXP3HC firmware version 3.3RC1 (2021-04-29 10:20:51) Bootloader ID: not available 2021-05-29 14:49:05 [debug] Never used RAM 158184, free system stack 0 words Tasks: Move(notifyWait,0.2%,92) HEAT(delaying,0.0%,63) CanAsync(notifyWait,0.0%,72) CanRecv(notifyWait,0.1%,81) CanClock(notifyWait,0.0%,74) TMC(notifyWait,24.6%,29) MAIN(running,73.7%,301) IDLE(ready,0.0%,40) AIN(delaying,1.5%,263), total 100.0% Last reset 00:55:07 ago, cause: software 2021-05-29 14:49:05 [debug] Last software reset at 2021-05-25 23:19, reason: AssertionFailed, available RAM 158184, slot 2 Software reset code 0x0120 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00000000 BFAR 0xe000ed38 SP 0x20004764 Task HEAT Freestk 146 ok 2021-05-29 14:49:05 [debug] Stack: 00000544 0002eb10 000260ff 42000400 0002232f 00000000 00000020 2002f020 2000159c 00000003 0001d25b 00000000 2002f020 00000020 000157b1 00000000 000d205a 000d205a 41c13260 a5a5a5a5 a5a5a5a5 a5a5a5a5 00024f45 a5a5a5a5 00000058 00000000 2002ee70 2021-05-29 14:49:05 [debug] Driver 0: position 2204223, 830.0 steps/mm, ok, reads 8659, writes 0 timeouts 0, SG min/max 0/865, steps req 387680 done 388188 Driver 1: position 0, 830.0 steps/mm, standstill, reads 8659, writes 0 timeouts 0, SG min/max not available, steps req 0 done 0 Driver 2: position 0, 830.0 steps/mm, standstill, reads 8658, writes 0 timeouts 0, SG min/max not available, steps req 0 done 0 2021-05-29 14:49:05 [debug] Moves scheduled 78776, completed 78773, in progress 1, hiccups 0, step errors 0, maxPrep 53, maxOverdue 11483, maxInc 7925, mcErrs 0, gcmErrs 0 Peak sync jitter 13, peak Rx sync delay 182, resyncs 0, next step interrupt due in 547 ticks, enabled VIN: 24.1V, V12: 12.2V MCU temperature: min 38.7C, current 40.2C, max 40.4C Ticks since heat task active 109, ADC conversions started 3307792, completed 3307792, timed out 0, errs 0 2021-05-29 14:49:05 [debug] Last sensors broadcast 0x0000000e found 3 118 ticks ago, loop time 0 CAN messages queued 4858, send timeouts 0, received 19204, lost 0, free buffers 36, min 36, error reg 0 dup 0, oos 0, bm 0, wbm 0 2021-05-29 14:49:31 [debug] Diagnostics for board 1: 2021-05-29 14:49:31 [debug] Duet EXP3HC firmware version 3.3RC1 (2021-04-29 10:20:51) Bootloader ID: SAME5x bootloader version 2.2 (2021-01-16b1) 2021-05-29 14:49:31 [debug] Never used RAM 159136, free system stack 0 words Tasks: Move(notifyWait,0.3%,100) HEAT(delaying,0.0%,88) CanAsync(notifyWait,0.0%,72) CanRecv(notifyWait,0.1%,81) CanClock(notifyWait,0.0%,74) TMC(notifyWait,26.3%,29) MAIN(running,71.7%,339) IDLE(ready,0.0%,40) AIN(delaying,1.5%,263), total 100.0% Last reset 00:55:33 ago, cause: software 2021-05-29 14:49:31 [debug] Last software reset time unknown, reason: AssertionFailed, available RAM 159320, slot 1 Software reset code 0x0120 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00000000 BFAR 0xe000ed38 SP 0x20004754 Task HEAT Freestk 142 bad marker 2021-05-29 14:49:31 [debug] Stack: 00000544 0002eb94 000261af 42000400 000223e3 2002f020 00000000 2002f038 2000151c 00000000 0001d681 0002dd80 0002de38 0002d43c 000b0000 2000159c 00000000 2002f020 00015609 00000000 000009c4 000009c4 a5a5a5a5 a5a5a5a5 a5a5a5a5 a5a5a5a5 00024ff5 2021-05-29 14:49:31 [debug] Driver 0: position -1014804, 320.0 steps/mm, ok, reads 12348, writes 0 timeouts 0, SG min/max 0/1023, steps req 18769194 done 18769053 Driver 1: position 477050, 320.0 steps/mm, ok, reads 12347, writes 0 timeouts 0, SG min/max 0/1023, steps req 17016100 done 17015546 Driver 2: position 0, 80.0 steps/mm, standstill, reads 12347, writes 0 timeouts 0, SG min/max not available, steps req 0 done 0 2021-05-29 14:49:31 [debug] Moves scheduled 83101, completed 83098, in progress 1, hiccups 0, step errors 0, maxPrep 131, maxOverdue 11879, maxInc 8115, mcErrs 0, gcmErrs 0 Peak sync jitter 10, peak Rx sync delay 208, resyncs 1, next step interrupt due in 46 ticks, enabled VIN: 32.1V, V12: 12.1V MCU temperature: min 37.3C, current 39.4C, max 39.6C Ticks since heat task active 202, ADC conversions started 3333670, completed 3333670, timed out 0, errs 0 2021-05-29 14:49:31 [debug] Last sensors broadcast 0x00000000 found 0 213 ticks ago, loop time 0 CAN messages queued 6613, send timeouts 0, received 91129, lost 0, free buffers 36, min 36, error reg 0 dup 0, oos 0, bm 0, wbm 0 2021-05-29 14:49:33 [debug] === Diagnostics === 2021-05-29 14:49:33 [debug] RepRapFirmware for Duet 3 MB6HC version 3.3RC1 (2021-05-01 09:12:50) running on Duet 3 MB6HC v0.6 or 1.0 (standalone mode) 2021-05-29 14:49:33 [debug] Board ID: 08DJM-956L2-G43S4-6JKDD-3SJ6L-TB62G 2021-05-29 14:49:33 [debug] Used output buffers: 1 of 40 (40 max) 2021-05-29 14:49:33 [debug] === RTOS === 2021-05-29 14:49:33 [debug] Static ram: 150680 2021-05-29 14:49:33 [debug] Dynamic ram: 94968 of which 40 recycled 2021-05-29 14:49:33 [debug] Never used RAM 105648, free system stack 117 words 2021-05-29 14:49:33 [debug] Tasks: 2021-05-29 14:49:33 [debug] NETWORK(ready,23.8%,194) 2021-05-29 14:49:33 [debug] ETHERNET(notifyWait,0.2%,120) 2021-05-29 14:49:33 [debug] HEAT(delaying,0.0%,295) 2021-05-29 14:49:33 [debug] Move(notifyWait,0.6%,176) 2021-05-29 14:49:33 [debug] CanReceiv(notifyWait,0.0%,773) 2021-05-29 14:49:33 [debug] CanSender(notifyWait,0.0%,359) 2021-05-29 14:49:33 [debug] CanClock(delaying,0.0%,341) 2021-05-29 14:49:33 [debug] TMC(notifyWait,8.6%,59) 2021-05-29 14:49:33 [debug] MAIN(running,66.7%,516) 2021-05-29 14:49:33 [debug] IDLE(ready,0.0%,29) 2021-05-29 14:49:33 [debug] , total 100.0% Owned mutexes: 2021-05-29 14:49:33 [debug] HTTP(MAIN) 2021-05-29 14:49:33 [debug] === Platform === 2021-05-29 14:49:33 [debug] Last reset 00:55:33 ago, cause: software 2021-05-29 14:49:33 [debug] Last software reset at 2021-05-29 13:53, reason: User, GCodes spinning, available RAM 105688, slot 0 2021-05-29 14:49:33 [debug] Software reset code 0x0003 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00400000 BFAR 0x00000000 SP 0x00000000 Task MAIN Freestk 0 n/a 2021-05-29 14:49:33 [debug] Error status: 0x04 2021-05-29 14:49:33 [debug] Aux0 errors 0,0,0 2021-05-29 14:49:33 [debug] Aux1 errors 0,0,0 2021-05-29 14:49:33 [debug] Step timer max interval 308 2021-05-29 14:49:33 [debug] MCU temperature: min 41.9, current 42.4, max 42.6 2021-05-29 14:49:33 [debug] Supply voltage: min 31.8, current 31.8, max 31.9, under voltage events: 0, over voltage events: 0, power good: yes 2021-05-29 14:49:33 [debug] 12V rail voltage: min 12.0, current 12.0, max 12.1, under voltage events: 0 2021-05-29 14:49:33 [debug] Heap OK, handles allocated/used 99/1, heap memory allocated/used/recyclable 2048/656/620, gc cycles 0 2021-05-29 14:49:33 [debug] Driver 0: position 166563, ok, reads 6288, writes 0 timeouts 0, SG min/max 0/1023 2021-05-29 14:49:33 [debug] Driver 1: position 680, ok, reads 6288, writes 0 timeouts 0, SG min/max 0/1023 2021-05-29 14:49:33 [debug] Driver 2: position 16544, standstill, reads 6279, writes 4 timeouts 0, SG min/max 0/142 2021-05-29 14:49:33 [debug] Driver 3: position 291, standstill, reads 6283, writes 0 timeouts 0, SG min/max 0/266 2021-05-29 14:49:33 [debug] Driver 4: position 0, standstill, reads 6283, writes 0 timeouts 0, SG min/max 0/160 2021-05-29 14:49:33 [debug] Driver 5: position 0, standstill, reads 6288, writes 0 timeouts 0, SG min/max 0/104 2021-05-29 14:49:33 [debug] Date/time: 2021-05-29 14:49:33 [debug] 2021-05-29 14:49:33 2021-05-29 14:49:33 [debug] Slowest loop: 67.97ms; fastest: 0.05ms 2021-05-29 14:49:33 [debug] === Storage === Free file entries: 8 2021-05-29 14:49:33 [debug] SD card 0 detected, interface speed: 25.0MBytes/sec 2021-05-29 14:49:33 [debug] SD card longest read time 3.4ms, write time 3.7ms, max retries 0 2021-05-29 14:49:33 [debug] === Move === DMs created 125, maxWait 11629ms, bed compensation in use: none, comp offset 0.000 2021-05-29 14:49:33 [debug] === MainDDARing === Scheduled moves 70328, completed moves 70288, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state 3 2021-05-29 14:49:33 [debug] === AuxDDARing === Scheduled moves 0, completed moves 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1 2021-05-29 14:49:33 [debug] === Heat === Bed heaters = 2021-05-29 14:49:33 [debug] 0 2021-05-29 14:49:33 [debug] -1 2021-05-29 14:49:33 [debug] -1 2021-05-29 14:49:33 [debug] -1 2021-05-29 14:49:33 [debug] -1 2021-05-29 14:49:33 [debug] -1 2021-05-29 14:49:33 [debug] -1 2021-05-29 14:49:33 [debug] -1 2021-05-29 14:49:33 [debug] -1 2021-05-29 14:49:33 [debug] -1 2021-05-29 14:49:33 [debug] -1 2021-05-29 14:49:33 [debug] -1 2021-05-29 14:49:33 [debug] , chamberHeaters = 2021-05-29 14:49:33 [debug] -1 2021-05-29 14:49:33 [debug] -1 2021-05-29 14:49:33 [debug] -1 2021-05-29 14:49:33 [debug] -1 2021-05-29 14:49:33 [debug] Heater 0 is on, I-accum = 0.1 2021-05-29 14:49:33 [debug] Heater 1 is on, I-accum = 0.0 2021-05-29 14:49:33 [debug] === GCodes === 2021-05-29 14:49:33 [debug] Segments left: 0 2021-05-29 14:49:33 [debug] Movement lock held by null 2021-05-29 14:49:33 [debug] HTTP is ready with "m122 b0" in state(s) 0 2021-05-29 14:49:33 [debug] Telnet is idle in state(s) 0 2021-05-29 14:49:33 [debug] File is doing "G1 X249.849 Y244.132 E0.02034" in state(s) 0 2021-05-29 14:49:33 [debug] USB is idle in state(s) 0 2021-05-29 14:49:33 [debug] Aux is idle in state(s) 0 2021-05-29 14:49:33 [debug] Trigger is idle in state(s) 0 2021-05-29 14:49:33 [debug] Queue is idle in state(s) 0 2021-05-29 14:49:33 [debug] LCD is idle in state(s) 0 2021-05-29 14:49:33 [debug] SBC is idle in state(s) 0 2021-05-29 14:49:33 [debug] Daemon is idle in state(s) 0 2021-05-29 14:49:33 [debug] Aux2 is idle in state(s) 0 2021-05-29 14:49:33 [debug] Autopause is idle in state(s) 0 2021-05-29 14:49:33 [debug] Code queue is empty. 2021-05-29 14:49:33 [debug] === CAN === Messages queued 152317, send timeouts 69, received 26581, lost 0, longest wait 24ms for reply type 6024, peak Tx sync delay 383, free buffers 49 (min 18) 2021-05-29 14:49:33 [debug] Last cancelled message type 51 dest 1 2021-05-29 14:49:33 [debug] === Network === 2021-05-29 14:49:33 [debug] Slowest loop: 13.29ms; fastest: 0.02ms 2021-05-29 14:49:33 [debug] Responder states: 2021-05-29 14:49:33 [debug] HTTP(0) 2021-05-29 14:49:33 [debug] HTTP(0) 2021-05-29 14:49:33 [debug] HTTP(0) 2021-05-29 14:49:33 [debug] HTTP(0) 2021-05-29 14:49:33 [debug] HTTP(0) 2021-05-29 14:49:33 [debug] HTTP(0) 2021-05-29 14:49:33 [debug] FTP(0) 2021-05-29 14:49:33 [debug] Telnet(0), 0 sessions 2021-05-29 14:49:33 [debug] Telnet(0), 0 sessions 2021-05-29 14:49:33 [debug] HTTP sessions: 2 of 8 2021-05-29 14:49:33 [debug] - Ethernet - State: active 2021-05-29 14:49:33 [debug] Error counts: 0 0 1 0 0 Socket states: 2021-05-29 14:49:33 [debug] 2 2021-05-29 14:49:33 [debug] 5 2021-05-29 14:49:33 [debug] 2 2021-05-29 14:49:33 [debug] 2 2021-05-29 14:49:33 [debug] 2 2021-05-29 14:49:33 [debug] 0 2021-05-29 14:49:33 [debug] 0 2021-05-29 14:49:33 [debug] 0 2021-05-29 14:50:44 [debug] === Diagnostics === 2021-05-29 14:50:44 [debug] RepRapFirmware for Duet 3 MB6HC version 3.3RC1 (2021-05-01 09:12:50) running on Duet 3 MB6HC v0.6 or 1.0 (standalone mode) 2021-05-29 14:50:44 [debug] Board ID: 08DJM-956L2-G43S4-6JKDD-3SJ6L-TB62G 2021-05-29 14:50:44 [debug] Used output buffers: 1 of 40 (40 max) 2021-05-29 14:50:44 [debug] === RTOS === 2021-05-29 14:50:44 [debug] Static ram: 150680 2021-05-29 14:50:44 [debug] Dynamic ram: 94968 of which 40 recycled 2021-05-29 14:50:44 [debug] Never used RAM 105648, free system stack 117 words 2021-05-29 14:50:44 [debug] Tasks: 2021-05-29 14:50:44 [debug] NETWORK(ready,24.8%,194) 2021-05-29 14:50:44 [debug] ETHERNET(notifyWait,0.4%,120) 2021-05-29 14:50:44 [debug] HEAT(delaying,0.0%,295) 2021-05-29 14:50:44 [debug] Move(notifyWait,0.7%,176) 2021-05-29 14:50:44 [debug] CanReceiv(notifyWait,0.0%,773) 2021-05-29 14:50:44 [debug] CanSender(notifyWait,0.1%,359) 2021-05-29 14:50:44 [debug] CanClock(delaying,0.0%,341) 2021-05-29 14:50:44 [debug] TMC(notifyWait,8.7%,59) 2021-05-29 14:50:44 [debug] MAIN(running,65.3%,516) 2021-05-29 14:50:44 [debug] IDLE(ready,0.0%,29) 2021-05-29 14:50:44 [debug] , total 100.0% Owned mutexes: 2021-05-29 14:50:44 [debug] HTTP(MAIN) 2021-05-29 14:50:44 [debug] === Platform === 2021-05-29 14:50:44 [debug] Last reset 00:56:45 ago, cause: software 2021-05-29 14:50:44 [debug] Last software reset at 2021-05-29 13:53, reason: User, GCodes spinning, available RAM 105688, slot 0 2021-05-29 14:50:44 [debug] Software reset code 0x0003 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00400000 BFAR 0x00000000 SP 0x00000000 Task MAIN Freestk 0 n/a 2021-05-29 14:50:44 [debug] Error status: 0x04 2021-05-29 14:50:44 [debug] Aux0 errors 0,0,0 2021-05-29 14:50:44 [debug] Aux1 errors 0,0,0 2021-05-29 14:50:44 [debug] Step timer max interval 129 2021-05-29 14:50:44 [debug] MCU temperature: min 42.2, current 42.3, max 42.6 2021-05-29 14:50:44 [debug] Supply voltage: min 31.8, current 31.8, max 31.9, under voltage events: 0, over voltage events: 0, power good: yes 2021-05-29 14:50:44 [debug] 12V rail voltage: min 12.0, current 12.0, max 12.1, under voltage events: 0 2021-05-29 14:50:44 [debug] Heap OK, handles allocated/used 99/1, heap memory allocated/used/recyclable 2048/656/620, gc cycles 0 2021-05-29 14:50:44 [debug] Driver 0: position 167792, ok, reads 62027, writes 0 timeouts 0, SG min/max 0/1023 2021-05-29 14:50:44 [debug] Driver 1: position 3711, ok, reads 62026, writes 0 timeouts 0, SG min/max 0/1023 2021-05-29 14:50:44 [debug] Driver 2: position 17504, standstill, reads 62027, writes 0 timeouts 0, SG min/max not available 2021-05-29 14:50:44 [debug] Driver 3: position 291, standstill, reads 62027, writes 0 timeouts 0, SG min/max 33/144 2021-05-29 14:50:44 [debug] Driver 4: position 0, standstill, reads 62026, writes 0 timeouts 0, SG min/max 22/156 2021-05-29 14:50:44 [debug] Driver 5: position 0, standstill, reads 62037, writes 0 timeouts 0, SG min/max 32/97 2021-05-29 14:50:44 [debug] Date/time: 2021-05-29 14:50:44 [debug] 2021-05-29 14:50:44 2021-05-29 14:50:44 [debug] Slowest loop: 4.33ms; fastest: 0.06ms 2021-05-29 14:50:44 [debug] === Storage === Free file entries: 8 2021-05-29 14:50:44 [debug] SD card 0 detected, interface speed: 25.0MBytes/sec 2021-05-29 14:50:44 [debug] SD card longest read time 3.2ms, write time 0.9ms, max retries 0 2021-05-29 14:50:44 [debug] === Move === DMs created 125, maxWait 0ms, bed compensation in use: none, comp offset 0.000 2021-05-29 14:50:44 [debug] === MainDDARing === Scheduled moves 74260, completed moves 74202, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state 3 2021-05-29 14:50:44 [debug] === AuxDDARing === Scheduled moves 0, completed moves 0, hiccups 0, stepErrors 0, LaErrors 0, Underruns [0, 0, 0], CDDA state -1 2021-05-29 14:50:44 [debug] === Heat === Bed heaters = 2021-05-29 14:50:44 [debug] 0 2021-05-29 14:50:44 [debug] -1 2021-05-29 14:50:44 [debug] -1 2021-05-29 14:50:44 [debug] -1 2021-05-29 14:50:44 [debug] -1 2021-05-29 14:50:44 [debug] -1 2021-05-29 14:50:44 [debug] -1 2021-05-29 14:50:44 [debug] -1 2021-05-29 14:50:44 [debug] -1 2021-05-29 14:50:44 [debug] -1 2021-05-29 14:50:44 [debug] -1 2021-05-29 14:50:44 [debug] -1 2021-05-29 14:50:44 [debug] , chamberHeaters = 2021-05-29 14:50:44 [debug] -1 2021-05-29 14:50:44 [debug] -1 2021-05-29 14:50:44 [debug] -1 2021-05-29 14:50:44 [debug] -1 2021-05-29 14:50:44 [debug] Heater 0 is on, I-accum = 0.1 2021-05-29 14:50:44 [debug] Heater 1 is on, I-accum = 0.0 2021-05-29 14:50:44 [debug] === GCodes === 2021-05-29 14:50:44 [debug] Segments left: 0 2021-05-29 14:50:44 [debug] Movement lock held by null 2021-05-29 14:50:44 [debug] HTTP is ready with "M122 b0" in state(s) 0 2021-05-29 14:50:44 [debug] Telnet is idle in state(s) 0 2021-05-29 14:50:44 [debug] File is doing "G1 X260.120 Y240.212 E0.01132" in state(s) 0 2021-05-29 14:50:44 [debug] USB is idle in state(s) 0 2021-05-29 14:50:44 [debug] Aux is idle in state(s) 0 2021-05-29 14:50:44 [debug] Trigger is idle in state(s) 0 2021-05-29 14:50:44 [debug] Queue is idle in state(s) 0 2021-05-29 14:50:44 [debug] LCD is idle in state(s) 0 2021-05-29 14:50:44 [debug] SBC is idle in state(s) 0 2021-05-29 14:50:44 [debug] Daemon is idle in state(s) 0 2021-05-29 14:50:44 [debug] Aux2 is idle in state(s) 0 2021-05-29 14:50:44 [debug] Autopause is idle in state(s) 0 2021-05-29 14:50:44 [debug] Code queue is empty. 2021-05-29 14:50:44 [debug] === CAN === Messages queued 8208, send timeouts 7, received 1144, lost 0, longest wait 0ms for reply type 0, peak Tx sync delay 383, free buffers 49 (min 18) 2021-05-29 14:50:44 [debug] Last cancelled message type 51 dest 1 2021-05-29 14:50:44 [debug] === Network === 2021-05-29 14:50:44 [debug] Slowest loop: 8.16ms; fastest: 0.02ms 2021-05-29 14:50:44 [debug] Responder states: 2021-05-29 14:50:44 [debug] HTTP(0) 2021-05-29 14:50:44 [debug] HTTP(0) 2021-05-29 14:50:44 [debug] HTTP(0) 2021-05-29 14:50:44 [debug] HTTP(0) 2021-05-29 14:50:44 [debug] HTTP(0) 2021-05-29 14:50:44 [debug] HTTP(0) 2021-05-29 14:50:44 [debug] FTP(0) 2021-05-29 14:50:44 [debug] Telnet(0), 0 sessions 2021-05-29 14:50:44 [debug] Telnet(0), 0 sessions 2021-05-29 14:50:44 [debug] HTTP sessions: 3 of 8 2021-05-29 14:50:44 [debug] - Ethernet - State: active 2021-05-29 14:50:44 [debug] Error counts: 0 0 1 0 0 Socket states: 2021-05-29 14:50:44 [debug] 5 2021-05-29 14:50:44 [debug] 2 2021-05-29 14:50:44 [debug] 2 2021-05-29 14:50:44 [debug] 2 2021-05-29 14:50:44 [debug] 2 2021-05-29 14:50:44 [debug] 0 2021-05-29 14:50:44 [debug] 0 2021-05-29 14:50:44 [debug] 0 2021-05-29 14:56:03 [debug] DDAs 60, DMs 125, GracePeriod 10 2021-05-29 14:59:14 [debug] DDAs 60, DMs 125, GracePeriod 10 2021-05-29 15:21:00 [debug] Diagnostics for board 2: 2021-05-29 15:21:00 [debug] Duet EXP3HC firmware version 3.3RC1 (2021-04-29 10:20:51) Bootloader ID: not available 2021-05-29 15:21:00 [debug] Never used RAM 158184, free system stack 0 words Tasks: Move(notifyWait,0.2%,92) HEAT(delaying,0.0%,63) CanAsync(notifyWait,0.0%,72) CanRecv(notifyWait,0.1%,81) CanClock(notifyWait,0.0%,74) TMC(notifyWait,24.5%,29) MAIN(running,73.6%,301) IDLE(ready,0.0%,40) AIN(delaying,1.5%,263), total 100.0% Last reset 01:27:02 ago, cause: software 2021-05-29 15:21:00 [debug] Last software reset at 2021-05-25 23:19, reason: AssertionFailed, available RAM 158184, slot 2 Software reset code 0x0120 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00000000 BFAR 0xe000ed38 SP 0x20004764 Task HEAT Freestk 146 ok 2021-05-29 15:21:00 [debug] Stack: 00000544 0002eb10 000260ff 42000400 0002232f 00000000 00000020 2002f020 2000159c 00000003 0001d25b 00000000 2002f020 00000020 000157b1 00000000 000d205a 000d205a 41c13260 a5a5a5a5 a5a5a5a5 a5a5a5a5 00024f45 a5a5a5a5 00000058 00000000 2002ee70 2021-05-29 15:21:00 [debug] Driver 0: position 3817175, 830.0 steps/mm, ok, reads 26609, writes 0 timeouts 0, SG min/max 0/1023, steps req 1757110 done 1757068 Driver 1: position 0, 830.0 steps/mm, standstill, reads 26609, writes 0 timeouts 0, SG min/max not available, steps req 0 done 0 Driver 2: position 0, 830.0 steps/mm, standstill, reads 26610, writes 0 timeouts 0, SG min/max not available, steps req 0 done 0 2021-05-29 15:21:00 [debug] Moves scheduled 176071, completed 176069, in progress 1, hiccups 0, step errors 0, maxPrep 55, maxOverdue 0, maxInc 0, mcErrs 0, gcmErrs 0 Peak sync jitter 12, peak Rx sync delay 181, resyncs 0, next step interrupt due in 39 ticks, enabled VIN: 24.1V, V12: 12.2V MCU temperature: min 38.7C, current 40.4C, max 40.6C Ticks since heat task active 60, ADC conversions started 5222744, completed 5222743, timed out 0, errs 0 2021-05-29 15:21:00 [debug] Last sensors broadcast 0x0000000e found 3 66 ticks ago, loop time 0 CAN messages queued 23161, send timeouts 0, received 114679, lost 0, free buffers 36, min 36, error reg 0 dup 0, oos 0, bm 0, wbm 0 2021-05-29 15:50:50 [info] G10 P0 S0 R0 2021-05-29 15:50:50 [info] G10 P1 S0 R0 2021-05-29 15:50:50 [info] G10 P2 S0 R0 2021-05-29 15:50:57 [debug] Done printing file 2021-05-29 15:50:57 [debug] Done printing file 2021-05-29 15:50:57 [warn] Finished printing file 0:/gcodes/ScrewMount 4v7Dx.gcode, print time was 1h 30m 2021-05-29 16:49:11 [debug] Diagnostics for board 2: 2021-05-29 16:49:11 [debug] Duet EXP3HC firmware version 3.3RC1 (2021-04-29 10:20:51) Bootloader ID: not available 2021-05-29 16:49:11 [debug] Never used RAM 158184, free system stack 0 words Tasks: Move(notifyWait,0.0%,92) HEAT(delaying,0.0%,63) CanAsync(notifyWait,0.0%,72) CanRecv(notifyWait,0.0%,81) CanClock(notifyWait,0.0%,74) TMC(notifyWait,24.0%,29) MAIN(running,74.6%,301) IDLE(ready,0.0%,40) AIN(delaying,1.4%,263), total 100.0% Last reset 02:55:13 ago, cause: software 2021-05-29 16:49:11 [debug] Last software reset at 2021-05-25 23:19, reason: AssertionFailed, available RAM 158184, slot 2 Software reset code 0x0120 HFSR 0x00000000 CFSR 0x00000000 ICSR 0x00000000 BFAR 0xe000ed38 SP 0x20004764 Task HEAT Freestk 146 ok 2021-05-29 16:49:11 [debug] Stack: 00000544 0002eb10 000260ff 42000400 0002232f 00000000 00000020 2002f020 2000159c 00000003 0001d25b 00000000 2002f020 00000020 000157b1 00000000 000d205a 000d205a 41c13260 a5a5a5a5 a5a5a5a5 a5a5a5a5 00024f45 a5a5a5a5 00000058 00000000 2002ee70 2021-05-29 16:49:11 [debug] Driver 0: position 5332921, 830.0 steps/mm, standstill, reads 33298, writes 2 timeouts 0, SG min/max 0/1023, steps req 1720350 done 1720405 Driver 1: position 0, 830.0 steps/mm, standstill, reads 33299, writes 0 timeouts 0, SG min/max not available, steps req 0 done 0 Driver 2: position 0, 830.0 steps/mm, standstill, reads 33300, writes 0 timeouts 0, SG min/max not available, steps req 0 done 0 2021-05-29 16:49:11 [debug] Moves scheduled 216702, completed 216702, in progress 0, hiccups 0, step errors 2, maxPrep 54, maxOverdue 0, maxInc 0, mcErrs 0, gcmErrs 0 Peak sync jitter 13, peak Rx sync delay 181, resyncs 4, no step interrupt scheduled VIN: 24.1V, V12: 12.2V MCU temperature: min 38.7C, current 39.8C, max 41.0C Ticks since heat task active 148, ADC conversions started 10513332, completed 10513332, timed out 0, errs 0 2021-05-29 16:49:11 [debug] Last sensors broadcast 0x0000000e found 3 154 ticks ago, loop time 0 CAN messages queued 63688, send timeouts 0, received 88418, lost 0, free buffers 36, min 36, error reg 0 dup 0, oos 0, bm 0, wbm 0