Duet3 Mini 5+ - strange messages, Do I run my first print?

[PaulHew]

@chrishamm Current journal, no errors.

pi@RailCoreII:~ $ journalctl -u duetcontrolserver -f
-- Logs begin at Mon 2021-03-29 21:18:43 BST. --
Mar 30 11:29:13 RailCoreII DuetControlServer[4869]: [info] Bed Traming Cycle: 1 - Difference was 0.003mm
Mar 30 11:29:13 RailCoreII DuetControlServer[4869]: [info] Starting macro file homez.g on channel File
Mar 30 11:29:13 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel File
Mar 30 11:29:14 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 11:29:21 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel File
Mar 30 11:29:21 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 11:29:22 RailCoreII DuetControlServer[4869]: [info] Finished macro file homez.g
Mar 30 11:29:26 RailCoreII DuetControlServer[4869]: [info] Height map loaded from file heightmap.csv
Mar 30 11:53:39 RailCoreII DuetControlServer[4869]: [info] Finished job file
Mar 30 11:53:39 RailCoreII DuetControlServer[4869]: [info] Finished printing file 0:/gcodes/ABS Shape-Box-1.61566g-22m.gcode, print time was 0h 27m

Regards,

Paul.

[PaulHew]

considering the logs begin at 21:18 last night, there have not been many entries..
I have been testing tramming, homing, bed mesh multiple times this morning.
P.

[chrishamm]

@paulhew Thanks, so nothing is wrong there. Perhaps G28 and G29 just take too long and time out and/or the connection is interrupted while the web interface is waiting for a response. In SBC mode a code HTTP request remains active as long as the code hasn't finished.

[PaulHew]

@chrishamm Since running that command on the Pi no issues with network errors etc.
I spoke too soon!

Console

30/03/2021, 12:37:45 	G32
Error: Network error
30/03/2021, 12:36:33 	g32
Leadscrew adjustments made: 0.051 0.042 0.038, points used 3, (mean, deviation) before (0.044, 0.005) after (-0.000, 0.000)

Bed Traming Cycle: 1 - Difference was 0.005mm
30/03/2021, 12:35:24 	g28

Mar 30 12:37:04 RailCoreII DuetControlServer[4869]: [info] Starting macro file homeall.g on channel HTTP
Mar 30 12:37:19 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:37:19 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:37:27 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:37:27 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:37:27 RailCoreII DuetControlServer[4869]: [info] Finished macro file homeall.g
Mar 30 12:37:39 RailCoreII DuetControlServer[4869]: [info] Starting macro file bed.g on channel HTTP
Mar 30 12:37:39 RailCoreII DuetControlServer[4869]: [info] Starting macro file 0:/sys/homex.g on channel HTTP
Mar 30 12:37:46 RailCoreII DuetControlServer[4869]: [info] Finished macro file 0:/sys/homex.g
Mar 30 12:37:46 RailCoreII DuetControlServer[4869]: [info] Starting macro file 0:/sys/homey.g on channel HTTP
Mar 30 12:37:53 RailCoreII DuetControlServer[4869]: [info] Finished macro file 0:/sys/homey.g
Mar 30 12:37:53 RailCoreII DuetControlServer[4869]: [info] Starting macro file 0:/sys/homez.g on channel HTTP
Mar 30 12:37:56 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:37:56 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:38:04 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:38:04 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:38:05 RailCoreII DuetControlServer[4869]: [info] Finished macro file 0:/sys/homez.g
Mar 30 12:38:08 RailCoreII DuetControlServer[4869]: [info] Starting macro file 0:/sys/bed_ThreeScrews.g on channel HTTP
Mar 30 12:38:11 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:38:11 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:38:13 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:38:13 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:38:17 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:38:17 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:38:19 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:38:19 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:38:23 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:38:23 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:38:26 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:38:26 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:38:26 RailCoreII DuetControlServer[4869]: [info] Finished macro file 0:/sys/bed_ThreeScrews.g
Mar 30 12:38:27 RailCoreII DuetControlServer[4869]: [info] Starting macro file homez.g on channel HTTP
Mar 30 12:38:29 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:38:29 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:38:34 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:38:34 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:38:35 RailCoreII DuetControlServer[4869]: [info] Finished macro file homez.g
Mar 30 12:38:38 RailCoreII DuetControlServer[4869]: [info] Finished macro file bed.g

[droftarts]

@paulhew If the timing is right, you got the error when it ran homex.g. Can you post that?

Ian

[PaulHew]

@droftarts Homex.g as requested.

G91               ; relative positioning
G1 H2 Z5 F3000    ; lift Z relative to current position
G1 H1 X-340 F1800 ; move quickly to X axis endstop and stop there (first pass)
G1 X5 F6000       ; go back a few mm
G1 H1 X-15 F360  ; move slowly to X axis endstop once more (second pass)
G1 H2 Z-5 F6000   ; lower Z again
G90               ; absolute positioning

[droftarts]

@paulhew Looks unequivocally correct!

Ian

[PaulHew]

@droftarts
Just popped up with a network error whilst running a G32, continued to run the g32.

30/03/2021, 12:53:44 	g32
Error: Network error
30/03/2021, 12:53:19 	g32
Leadscrew adjustments made: 0.013 0.020 0.027, points used 3, (mean, deviation) before (0.019, 0.005) after (0.000, 0.000)

Bed Traming Cycle: 1 - Difference was 0.005mm
30/03/2021, 12:52:16 	g32
Leadscrew adjustments made: 0.026 0.023 0.017, points used 3, (mean, deviation) before (0.022, 0.003) after (0.000, 0.000)

Bed Traming Cycle: 1 - Difference was 0.003mm
30/03/2021, 12:51:12 	g28
30/03/2021, 12:50:42 	g28
30/03/2021, 12:50:11 	g28

pi log - note the bottom line, issue possibly?

Mar 30 12:49:44 RailCoreII DuetControlServer[4869]: [info] Starting macro file homeall.g on channel HTTP
Mar 30 12:49:59 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:49:59 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:50:07 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:50:07 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:50:08 RailCoreII DuetControlServer[4869]: [info] Finished macro file homeall.g
Mar 30 12:50:16 RailCoreII DuetControlServer[4869]: [info] Starting macro file homeall.g on channel HTTP
Mar 30 12:50:31 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:50:31 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:50:39 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:50:39 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:50:39 RailCoreII DuetControlServer[4869]: [info] Finished macro file homeall.g
Mar 30 12:50:45 RailCoreII DuetControlServer[4869]: [info] Starting macro file homeall.g on channel HTTP
Mar 30 12:51:00 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:51:00 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:51:08 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:51:08 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:51:09 RailCoreII DuetControlServer[4869]: [info] Finished macro file homeall.g
Mar 30 12:51:17 RailCoreII DuetControlServer[4869]: [info] Starting macro file bed.g on channel HTTP
Mar 30 12:51:17 RailCoreII DuetControlServer[4869]: [info] Starting macro file 0:/sys/homex.g on channel HTTP
Mar 30 12:51:25 RailCoreII DuetControlServer[4869]: [info] Finished macro file 0:/sys/homex.g
Mar 30 12:51:25 RailCoreII DuetControlServer[4869]: [info] Starting macro file 0:/sys/homey.g on channel HTTP
Mar 30 12:51:32 RailCoreII DuetControlServer[4869]: [info] Finished macro file 0:/sys/homey.g
Mar 30 12:51:32 RailCoreII DuetControlServer[4869]: [info] Starting macro file 0:/sys/homez.g on channel HTTP
Mar 30 12:51:35 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:51:35 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:51:42 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:51:43 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:51:43 RailCoreII DuetControlServer[4869]: [info] Finished macro file 0:/sys/homez.g
Mar 30 12:51:46 RailCoreII DuetControlServer[4869]: [info] Starting macro file 0:/sys/bed_ThreeScrews.g on channel HTTP
Mar 30 12:51:49 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:51:49 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:51:52 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:51:52 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:51:55 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:51:55 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:51:58 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:51:58 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:52:01 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:52:01 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:52:04 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:52:04 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:52:05 RailCoreII DuetControlServer[4869]: [info] Finished macro file 0:/sys/bed_ThreeScrews.g
Mar 30 12:52:05 RailCoreII DuetControlServer[4869]: [info] Starting macro file homez.g on channel HTTP
Mar 30 12:52:07 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:52:07 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:52:12 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:52:12 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:52:13 RailCoreII DuetControlServer[4869]: [info] Finished macro file homez.g
Mar 30 12:52:16 RailCoreII DuetControlServer[4869]: [info] Finished macro file bed.g
Mar 30 12:52:20 RailCoreII DuetControlServer[4869]: [info] Starting macro file bed.g on channel HTTP
Mar 30 12:52:20 RailCoreII DuetControlServer[4869]: [info] Starting macro file 0:/sys/homex.g on channel HTTP
Mar 30 12:52:28 RailCoreII DuetControlServer[4869]: [info] Finished macro file 0:/sys/homex.g
Mar 30 12:52:28 RailCoreII DuetControlServer[4869]: [info] Starting macro file 0:/sys/homey.g on channel HTTP
Mar 30 12:52:35 RailCoreII DuetControlServer[4869]: [info] Finished macro file 0:/sys/homey.g
Mar 30 12:52:35 RailCoreII DuetControlServer[4869]: [info] Starting macro file 0:/sys/homez.g on channel HTTP
Mar 30 12:52:38 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:52:38 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:52:45 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:52:45 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:52:46 RailCoreII DuetControlServer[4869]: [info] Finished macro file 0:/sys/homez.g
Mar 30 12:52:49 RailCoreII DuetControlServer[4869]: [info] Starting macro file 0:/sys/bed_ThreeScrews.g on channel HTTP
Mar 30 12:52:52 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:52:52 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:52:54 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:52:55 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:52:58 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:52:58 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:53:00 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:53:00 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:53:04 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:53:04 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:53:07 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:53:07 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:53:08 RailCoreII DuetControlServer[4869]: [info] Finished macro file 0:/sys/bed_ThreeScrews.g
Mar 30 12:53:08 RailCoreII DuetControlServer[4869]: [info] Starting macro file homez.g on channel HTTP
Mar 30 12:53:10 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:53:10 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:53:15 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:53:15 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:53:16 RailCoreII DuetControlServer[4869]: [info] Finished macro file homez.g
Mar 30 12:53:19 RailCoreII DuetControlServer[4869]: [info] Finished macro file bed.g
Mar 30 12:53:24 RailCoreII DuetControlServer[4869]: [info] Starting macro file bed.g on channel HTTP
Mar 30 12:53:24 RailCoreII DuetControlServer[4869]: [info] Starting macro file 0:/sys/homex.g on channel HTTP
Mar 30 12:53:32 RailCoreII DuetControlServer[4869]: [info] Finished macro file 0:/sys/homex.g
Mar 30 12:53:32 RailCoreII DuetControlServer[4869]: [info] Starting macro file 0:/sys/homey.g on channel HTTP
Mar 30 12:53:39 RailCoreII DuetControlServer[4869]: [info] Finished macro file 0:/sys/homey.g
Mar 30 12:53:39 RailCoreII DuetControlServer[4869]: [info] Starting macro file 0:/sys/homez.g on channel HTTP
Mar 30 12:53:42 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:53:42 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:53:50 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:53:50 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:53:50 RailCoreII DuetControlServer[4869]: [info] Finished macro file 0:/sys/homez.g
Mar 30 12:53:53 RailCoreII DuetControlServer[4869]: [info] Starting macro file 0:/sys/bed_ThreeScrews.g on channel HTTP
Mar 30 12:53:56 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:53:56 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:53:59 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:53:59 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:54:02 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:54:02 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:54:05 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:54:05 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:54:08 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:54:09 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:54:11 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:54:11 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:54:12 RailCoreII DuetControlServer[4869]: [info] Finished macro file 0:/sys/bed_ThreeScrews.g
Mar 30 12:54:12 RailCoreII DuetControlServer[4869]: [info] Starting macro file homez.g on channel HTTP
Mar 30 12:54:14 RailCoreII DuetControlServer[4869]: [info] Starting macro file deployprobe.g on channel HTTP
Mar 30 12:54:14 RailCoreII DuetControlServer[4869]: [info] Finished macro file deployprobe.g
Mar 30 12:54:20 RailCoreII DuetControlServer[4869]: [info] Starting macro file retractprobe.g on channel HTTP
Mar 30 12:54:20 RailCoreII DuetControlServer[4869]: [info] Finished macro file retractprobe.g
Mar 30 12:54:20 RailCoreII DuetControlServer[4869]: [info] Finished macro file homez.g
Mar 30 12:54:23 RailCoreII DuetControlServer[4869]: [info] Finished macro file bed.g
Mar 30 12:55:51 RailCoreII DuetControlServer[4869]: [warn] RepRapFirmware got a bad header checksum

[PaulHew]

random! Throws error but completes task

30/03/2021, 13:02:29 	g28
Error: Network error
30/03/2021, 13:02:21 	g28

[PaulHew]

[chrishamm]

@paulhew Yes, started codes always complete, even if the underlying connection is terminated. I suggest you press F12 to open the dev tools, go to Network, and check the cause for interrupted connections. It sounds like either the browser or OS kills the HTTP connection(s) after a brief moment.