resume redundant extrusion
-
not sure what I am doing wrong, but M929 S3 P"/sys/log.txt" did not produce any file.
-
Sorry my bad, here's the log that should include a couple of the pause eventslog.txt
-
@bugpwr said in resume redundant extrusion:
I don't see a similar note on M906,
It's the last note in the M906 notes.
I think we need the debug output of the Gcode module, rather than the system log (I don't think this will show much, and is rather impenetrable), which is summoned by M111 https://docs.duet3d.com/en/User_manual/Reference/Gcodes#m111-set-debug-level
SendM111
to see what is enabled currently (nothing), and enable the Gcode module. egM111 Debugging on for modules: Debugging off for modules: Platform(0) Network(1) Webserver(2) Gcodes(3) Move(4) Heat(5) Kinematics(6) InputShaping(7) Debug(8) PrintMonitor(9) Storage(10) PortControl(11) DuetExpansion(12) FilamentSensors(13) WiFi(14) Display(15) SbcInterface(16) CAN(17) Expansion(18) M111 P3 S1 Debugging on for modules: Gcodes(3 - 0xff) Debugging off for modules: Platform(0) Network(1) Webserver(2) Move(4) Heat(5) Kinematics(6) InputShaping(7) Debug(8) PrintMonitor(9) Storage(10) PortControl(11) DuetExpansion(12) FilamentSensors(13) WiFi(14) Display(15) SbcInterface(16) CAN(17) Expansion(18)
Debug output is normally sent to the USB port, so connect a PC with a serial terminal to the Duet, and hopefully you can capture if an errant Gcode is being sent on resume. Possibly turn on the 'Move(4)' module too. Hopefully this will give us a clue what is going on.
Ian
-
@droftarts for now - this is debug(3) output. Personally, I don't see anything criminal here:
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
HTTP: M24
HTTP: G1 R1 X0 Y0 F6000
HTTP: G1 R1 X0 Y0 Z5 F6000
HTTP: G1 R1 X0 Y0 Z0 F6000
HTTP: M400
Aux: M409 F"d99f"
Aux: M409 K"volumes" F"v"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
HTTP: M83
HTTP: G1 E10 F300
Aux: M409 F"d99f"
Aux: M409 K"volumes" F"v"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
File: G1 X316.25 Y205.25 E.39947
File: M73 P21 R5
File: G1 X335.75 Y205.25 E.39947
File: M73 P21 R5
File: G1 X335.75 Y224.7 E.39845
File: G1 E-.5 F2700
Aux: M409 F"d99f"
Aux: M409 F"d99f"
File: G1 Z5.2 F30000
Aux: M409 F"d99f"
File: G1 X335.75 Y224.75 Z5.2
File: G1 Z4.8
File: G1 E.5 F2100
File: G1 F1200
File: G1 X316.25 Y224.75 E.39947
File: G1 X316.25 Y205.25 E.39947 -
and this is the capture with move(4)
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
Aux: M409 F"d99f"
HTTP: M24
HTTP: G1 R1 X0 Y0 F6000
Transformed 316.25 224.75 25.20 to 25300 22475 40318 0
HTTP: G1 R1 X0 Y0 Z5 F6000
Transformed 316.25 224.75 10.20 to 25300 22475 16318 0
HTTP: G1 R1 X0 Y0 Z0 F6000
Transformed 316.25 224.75 5.20 to 25300 22475 8318 0
HTTP: M400
AddLin: st=3217650990 steps=3000.0
addlin 1 ts=3217650990 DDA: start=[316.250000 194.750000 25.238518 0.000000] end=[316.250000 224.750000 25.198977 0.000000] s=3.0000e+1 vec=[0.000000 0.999999 -0.001318 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000]
a=2.2756e-9 d=2.2756e-9 reqv=1.0667e-4 startv=0.0000e+0 topv=1.0667e-4 endv=0.0000e+0 cks=328125 fp=4294967295 fl=0aa3
pp: td=3.000e+1 ad=2.500e+0 dsd=2.750e+1 a=2.276e-9 d=2.276e-9 ac=46875 sc=234375 dc=46875
Add seg: st=3217650990 t=46875 dist=250.00 u=-9.145e-9 a=2.276e-7 f=01
Add seg: st=3217697865 t=234375 dist=2500.00 u=1.067e-2 a=0.000e+0 f=01
Add seg: st=3217932240 t=46875 dist=250.00 u=1.067e-2 a=-2.276e-7 f=01
AddLin: st=3217650990 steps=-64.0
addlin 1 ts=3217650990 DDA: start=[316.250000 194.750000 25.238518 0.000000] end=[316.250000 224.750000 25.198977 0.000000] s=3.0000e+1 vec=[0.000000 0.999999 -0.001318 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000]
a=2.2756e-9 d=2.2756e-9 reqv=1.0667e-4 startv=0.0000e+0 topv=1.0667e-4 endv=0.0000e+0 cks=328125 fp=4294967295 fl=0aa3
pp: td=3.000e+1 ad=2.500e+0 dsd=2.750e+1 a=2.276e-9 d=2.276e-9 ac=46875 sc=234375 dc=46875
Add seg: st=3217650990 t=46875 dist=-5.33 u=1.881e-10 a=-4.855e-9 f=01
Add seg: st=3217697865 t=234375 dist=-53.33 u=-2.276e-4 a=0.000e+0 f=01
Add seg: st=3217932240 t=46875 dist=-5.33 u=-2.276e-4 a=4.855e-9 f=01
pr 2 ts=3217650990 DDA: start=[316.250000 194.750000 25.238518 0.000000] end=[316.250000 224.750000 25.198977 0.000000] s=3.0000e+1 vec=[0.000000 0.999999 -0.001318 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000]
a=2.2756e-9 d=2.2756e-9 reqv=1.0667e-4 startv=0.0000e+0 topv=1.0667e-4 endv=0.0000e+0 cks=328125 fp=4294967295 fl=0aa3
Aux: M409 F"d99f"
Forward transformed 25301 21857 40332 to 316.26 218.57 25.21
AddLin: st=3217979115 steps=-24000.0
addlin 1 ts=3217979115 DDA: start=[316.250000 224.750000 25.198977 -0.000000] end=[316.250000 224.750000 10.198977 -0.000000] s=1.5000e+1 vec=[0.000000 0.000000 -1.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000]
a=1.1378e-10 d=1.1378e-10 reqv=1.0667e-5 startv=0.0000e+0 topv=1.0667e-5 endv=1.0667e-5 cks=1453125 fp=4294967295 fl=0a81
pp: td=1.500e+1 ad=5.000e-1 dsd=1.500e+1 a=1.138e-10 d=1.138e-10 ac=93750 sc=1359375 dc=0
Add seg: st=3217979115 t=93750 dist=-800.00 u=-5.495e-11 a=-1.820e-7 f=05
Add seg: st=3218072865 t=1359375 dist=-23200.00 u=-1.707e-2 a=0.000e+0 f=05
pr 2 ts=3217979115 DDA: start=[316.250000 224.750000 25.198977 -0.000000] end=[316.250000 224.750000 10.198977 -0.000000] s=1.5000e+1 vec=[0.000000 0.000000 -1.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000]
a=1.1378e-10 d=1.1378e-10 reqv=1.0667e-5 startv=0.0000e+0 topv=1.0667e-5 endv=1.0667e-5 cks=1453125 fp=4294967295 fl=0a81
Forward transformed 25301 22475 35920 to 316.26 224.75 22.45
Aux: M409 K"volumes" F"v"
Forward transformed 25301 22475 31482 to 316.26 224.75 19.68
Aux: M409 F"d99f"
Forward transformed 25301 22475 26396 to 316.26 224.75 16.50
Forward transformed 25301 22475 20158 to 316.26 224.75 12.60
Aux: M409 F"d99f"
AddLin: st=3219432240 steps=-8000.0
addlin 1 ts=3219432240 DDA: start=[316.250000 224.750000 10.198977 -0.000000] end=[316.250000 224.750000 5.198977 -0.000000] s=5.0000e+0 vec=[0.000000 0.000000 -1.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000]
a=1.1378e-10 d=1.1378e-10 reqv=1.0667e-5 startv=1.0667e-5 topv=1.0667e-5 endv=0.0000e+0 cks=515625 fp=4294967295 fl=0a83
pp: td=5.000e+0 ad=0.000e+0 dsd=4.500e+0 a=1.138e-10 d=1.138e-10 ac=0 sc=421875 dc=93750
Add seg: st=3219432240 t=421875 dist=-7200.00 u=-1.707e-2 a=0.000e+0 f=05
Add seg: st=3219854115 t=93750 dist=-800.00 u=-1.707e-2 a=1.820e-7 f=05
pr 2 ts=3219432240 DDA: start=[316.250000 224.750000 10.198977 -0.000000] end=[316.250000 224.750000 5.198977 -0.000000] s=5.0000e+0 vec=[0.000000 0.000000 -1.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000]
a=1.1378e-10 d=1.1378e-10 reqv=1.0667e-5 startv=1.0667e-5 topv=1.0667e-5 endv=0.0000e+0 cks=515625 fp=4294967295 fl=0a83
Forward transformed 25301 22475 15679 to 316.26 224.75 9.80
Forward transformed 25301 22475 12358 to 316.26 224.75 7.72
Aux: M409 F"d99f"
HTTP: M83
HTTP: G1 E10 F300
Transformed 316.25 224.75 5.20 to 25300 22475 8318 0
AddLin: st=3220006007 steps=7830.0
addlin 1 ts=3220006007 DDA: start=[316.250000 224.750000 5.198977 -0.000000] end=[316.250000 224.750000 5.198977 -0.000000] s=1.0000e+1 vec=[0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 1.000000]
a=5.1200e-10 d=5.1200e-10 reqv=5.3333e-6 startv=0.0000e+0 topv=5.3333e-6 endv=0.0000e+0 cks=1885417 fp=4294967295 fl=0b83
pp: td=1.000e+1 ad=2.778e-2 dsd=9.972e+0 a=5.120e-10 d=5.120e-10 ac=10417 sc=1864583 dc=10417
Add seg: st=3220006007 t=10417 dist=21.75 u=-1.336e-7 a=4.009e-7 f=05
Add seg: st=3220016424 t=1864583 dist=7786.50 u=4.176e-3 a=0.000e+0 f=05
Add seg: st=3221881007 t=10417 dist=21.75 u=4.176e-3 a=-4.009e-7 f=05
pr 2 ts=3220006007 DDA: start=[316.250000 224.750000 5.198977 -0.000000] end=[316.250000 224.750000 5.198977 -0.000000] s=1.0000e+1 vec=[0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 1.000000]
a=5.1200e-10 d=5.1200e-10 reqv=5.3333e-6 startv=0.0000e+0 topv=5.3333e-6 endv=0.0000e+0 cks=1885417 fp=4294967295 fl=0b83
Forward transformed 25301 22475 8319 to 316.26 224.75 5.20
Aux: M409 F"d99f"
Forward transformed 25301 22475 8319 to 316.26 224.75 5.20
Forward transformed 25301 22475 8319 to 316.26 224.75 5.20
Aux: M409 K"volumes" F"v"
Forward transformed 25301 22475 8319 to 316.26 224.75 5.20
Forward transformed 25301 22475 8319 to 316.26 224.75 5.20
Aux: M409 F"d99f"
Forward transformed 25301 22475 8319 to 316.26 224.75 5.20
Aux: M409 F"d99f"
Forward transformed 25301 22475 8319 to 316.26 224.75 5.20
Transformed 316.25 224.75 5.20 to 25300 22475 8318 0
AddLin: st=3221948491 steps=7830.0
addlin 1 ts=3221948491 DDA: start=[316.250000 224.750000 5.198977 0.000000] end=[316.250000 224.750000 5.198977 0.000000] s=1.0000e+1 vec=[0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 1.000000]
a=5.1200e-10 d=5.1200e-10 reqv=2.1333e-5 startv=0.0000e+0 topv=2.1333e-5 endv=0.0000e+0 cks=510417 fp=4294967295 fl=0b83
pp: td=1.000e+1 ad=4.444e-1 dsd=9.556e+0 a=5.120e-10 d=5.120e-10 ac=41667 sc=427083 dc=41667
Add seg: st=3221948491 t=41667 dist=348.00 u=-1.336e-7 a=4.009e-7 f=05
Add seg: st=3221990158 t=427083 dist=7134.00 u=1.670e-2 a=0.000e+0 f=05
Add seg: st=3222417241 t=41667 dist=348.00 u=1.670e-2 a=-4.009e-7 f=05
pr 2 ts=3221948491 DDA: start=[316.250000 224.750000 5.198977 0.000000] end=[316.250000 224.750000 5.198977 0.000000] s=1.0000e+1 vec=[0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 1.000000]
a=5.1200e-10 d=5.1200e-10 reqv=2.1333e-5 startv=0.0000e+0 topv=2.1333e-5 endv=0.0000e+0 cks=510417 fp=4294967295 fl=0b83
Forward transformed 25301 22475 8319 to 316.26 224.75 5.20
Aux: M409 F"d99f"
Forward transformed 25301 22475 8319 to 316.26 224.75 5.20
File: G1 X316.25 Y205.25 E.39947
Transformed 316.25 205.25 5.22 to 25300 20525 8359 0
File: M73 P24 R5
File: G1 X335.75 Y205.25 E.39947
Transformed 335.75 205.25 5.21 to 26860 20525 8330 0
File: G1 X335.75 Y224.7 E.39845
File: G1 E-.5 F2700
AddLin: st=3222522240 steps=-1950.0
addlin 1 ts=3222522240 DDA: start=[316.250000 224.750000 5.198977 -0.000000] end=[316.250000 205.250000 5.224679 -0.000000] s=1.9500e+1 vec=[0.000000 -0.999999 0.001318 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.020486]
a=5.1200e-10 d=5.1200e-10 reqv=2.1333e-5 startv=0.0000e+0 topv=2.1333e-5 endv=3.5200e-6 cks=949423 fp=17103 fl=0aaf
pp: td=1.950e+1 ad=4.444e-1 dsd=1.907e+1 a=5.120e-10 d=5.120e-10 ac=41667 sc=872964 dc=34792
Add seg: st=3222522240 t=41667 dist=-44.44 u=1.712e-8 a=-5.120e-8 f=00
Add seg: st=3222563907 t=872964 dist=-1862.32 u=-2.133e-3 a=0.000e+0 f=00
Add seg: st=3223436871 t=34792 dist=-43.23 u=-2.133e-3 a=5.120e-8 f=00
AddLin: st=3222522240 steps=41.0
addlin 1 ts=3222522240 DDA: start=[316.250000 224.750000 5.198977 -0.000000] end=[316.250000 205.250000 5.224679 -0.000000] s=1.9500e+1 vec=[0.000000 -0.999999 0.001318 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.020486]
a=5.1200e-10 d=5.1200e-10 reqv=2.1333e-5 startv=0.0000e+0 topv=2.1333e-5 endv=3.5200e-6 cks=949423 fp=17103 fl=0aaf
pp: td=1.950e+1 ad=4.444e-1 dsd=1.907e+1 a=5.120e-10 d=5.120e-10 ac=41667 sc=872964 dc=34792
Add seg: st=3222522240 t=41667 dist=0.93 u=-3.604e-10 a=1.077e-9 f=00
Add seg: st=3222563907 t=872964 dist=39.16 u=4.485e-5 a=0.000e+0 f=00
Add seg: st=3223436871 t=34792 dist=0.91 u=4.485e-5 a=-1.077e-9 f=00
AddLin: st=3222522240 steps=312.8
addlin 1 ts=3222522240 DDA: start=[316.250000 224.750000 5.198977 -0.000000] end=[316.250000 205.250000 5.224679 -0.000000] s=1.9500e+1 vec=[0.000000 -0.999999 0.001318 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.020486]
a=5.1200e-10 d=5.1200e-10 reqv=2.1333e-5 startv=0.0000e+0 topv=2.1333e-5 endv=3.5200e-6 cks=949423 fp=17103 fl=0aaf
pp: td=1.950e+1 ad=4.444e-1 dsd=1.907e+1 a=5.120e-10 d=5.120e-10 ac=41667 sc=872964 dc=34792
Add seg: st=3222522240 t=41667 dist=7.13 u=-2.752e-9 a=8.213e-9 f=00
Add seg: st=3222563907 t=872964 dist=298.72 u=3.422e-4 a=0.000e+0 f=00
Add seg: st=3223436871 t=34792 dist=6.93 u=3.422e-4 a=-8.213e-9 f=00
pr 2 ts=3222522240 DDA: start=[316.250000 224.750000 5.198977 -0.000000] end=[316.250000 205.250000 5.224679 -0.000000] s=1.9500e+1 vec=[0.000000 -0.999999 0.001318 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.020486]
a=5.1200e-10 d=5.1200e-10 reqv=2.1333e-5 startv=0.0000e+0 topv=2.1333e-5 endv=3.5200e-6 cks=949423 fp=17103 fl=0aaf
Forward transformed 25301 22475 8319 to 316.26 224.75 5.20
Aux: M409 F"d99f"
Forward transformed 25301 22081 8326 to 316.26 220.81 5.20
Forward transformed 25301 21442 8339 to 316.26 214.42 5.21
Aux: M409 F"d99f"
Transformed 335.75 224.70 5.18 to 26860 22470 8293 0
Forward transformed 25301 20644 8356 to 316.26 206.44 5.22
File: G1 Z6.1 F30000
AddLin: st=3223471663 steps=1560.0
addlin 1 ts=3223471663 DDA: start=[316.250000 205.250000 5.224679 -0.000000] end=[335.750000 205.250000 5.206129 -0.000000] s=1.9500e+1 vec=[1.000000 0.000000 -0.000951 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.020486]
a=5.1200e-10 d=5.1200e-10 reqv=2.1333e-5 startv=3.5200e-6 topv=2.1333e-5 endv=3.5200e-6 cks=943115 fp=17141 fl=0aaf
pp: td=1.950e+1 ad=4.323e-1 dsd=1.907e+1 a=5.120e-10 d=5.120e-10 ac=34792 sc=873531 dc=34792
Add seg: st=3223471663 t=34792 dist=34.59 u=2.816e-4 a=4.096e-8 f=00
Add seg: st=3223506455 t=873531 dist=1490.82 u=1.707e-3 a=0.000e+0 f=00
Add seg: st=3224379986 t=34792 dist=34.59 u=1.707e-3 a=-4.096e-8 f=00
AddLin: st=3223471663 steps=-29.0
addlin 1 ts=3223471663 DDA: start=[316.250000 205.250000 5.224679 -0.000000] end=[335.750000 205.250000 5.206129 -0.000000] s=1.9500e+1 vec=[1.000000 0.000000 -0.000951 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.020486]
a=5.1200e-10 d=5.1200e-10 reqv=2.1333e-5 startv=3.5200e-6 topv=2.1333e-5 endv=3.5200e-6 cks=943115 fp=17141 fl=0aaf
pp: td=1.950e+1 ad=4.323e-1 dsd=1.907e+1 a=5.120e-10 d=5.120e-10 ac=34792 sc=873531 dc=34792
Add seg: st=3223471663 t=34792 dist=-0.64 u=-5.235e-6 a=-7.614e-10 f=00
Add seg: st=3223506455 t=873531 dist=-27.71 u=-3.173e-5 a=0.000e+0 f=00
Add seg: st=3224379986 t=34792 dist=-0.64 u=-3.173e-5 a=7.614e-10 f=00
AddLin: st=3223471663 steps=312.8
addlin 1 ts=3223471663 DDA: start=[316.250000 205.250000 5.224679 -0.000000] end=[335.750000 205.250000 5.206129 -0.000000] s=1.9500e+1 vec=[1.000000 0.000000 -0.000951 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.020486]
a=5.1200e-10 d=5.1200e-10 reqv=2.1333e-5 startv=3.5200e-6 topv=2.1333e-5 endv=3.5200e-6 cks=943115 fp=17141 fl=0aaf
pp: td=1.950e+1 ad=4.323e-1 dsd=1.907e+1 a=5.120e-10 d=5.120e-10 ac=34792 sc=873531 dc=34792
Add seg: st=3223471663 t=34792 dist=6.93 u=5.646e-5 a=8.213e-9 f=00
Add seg: st=3223506455 t=873531 dist=298.92 u=3.422e-4 a=0.000e+0 f=00
Add seg: st=3224379986 t=34792 dist=6.93 u=3.422e-4 a=-8.213e-9 f=00
pr 2 ts=3223471663 DDA: start=[316.250000 205.250000 5.224679 -0.000000] end=[335.750000 205.250000 5.206129 -0.000000] s=1.9500e+1 vec=[1.000000 0.000000 -0.000951 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.020486]
a=5.1200e-10 d=5.1200e-10 reqv=2.1333e-5 startv=3.5200e-6 topv=2.1333e-5 endv=3.5200e-6 cks=943115 fp=17141 fl=0aaf
Transformed 335.75 224.70 5.18 to 26860 22470 8293 0
Transformed 335.75 224.70 5.88 to 26860 22470 9413 0
File: G1 X335.75 Y224.75 Z6.1
Transformed 335.75 224.75 5.88 to 26860 22475 9413 0
File: G1 Z5.7
Transformed 335.75 224.75 5.48 to 26860 22475 8773 0
File: G1 E.5 F2100
Transformed 335.75 224.75 5.48 to 26860 22475 8773 0
File: G1 F1200
Transformed 335.75 224.75 5.48 to 26860 22475 8773 0
File: G1 X316.25 Y224.75 E.39947
Transformed 316.25 224.75 5.50 to 25300 22475 8798 0
File: M73 P25 R5
File: G1 X316.25 Y205.25 E.39947
File: M73 P25 R5
File: M73 P25 R4
File: G1 X335.75 Y205.25 E.39947
Aux: M409 F"d99f"
Forward transformed 25658 20526 8353 to 320.73 205.26 5.22
Forward transformed 26093 20526 8345 to 326.16 205.26 5.22
Aux: M409 F"d99f"
Forward transformed 26551 20526 8336 to 331.89 205.26 5.21
AddLin: st=3224414778 steps=1945.0
addlin 1 ts=3224414778 DDA: start=[335.750000 205.250000 5.206129 -0.000000] end=[335.750000 224.699997 5.183259 -0.000000] s=1.9450e+1 vec=[0.000000 0.999999 -0.001176 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.020486]
a=5.1200e-10 d=5.1200e-10 reqv=2.1333e-5 startv=3.5200e-6 topv=2.1333e-5 endv=0.0000e+0 cks=947079 fp=17168 fl=0aaf
pp: td=1.945e+1 ad=4.323e-1 dsd=1.901e+1 a=5.120e-10 d=5.120e-10 ac=34792 sc=870620 dc=41667
Add seg: st=3224414778 t=34792 dist=43.23 u=3.520e-4 a=5.120e-8 f=00
Add seg: st=3224449570 t=870620 dist=1857.32 u=2.133e-3 a=0.000e+0 f=00
Add seg: st=3225320190 t=41667 dist=44.44 u=2.133e-3 a=-5.120e-8 f=00
AddLin: st=3224414778 steps=-37.0
addlin 1 ts=3224414778 DDA: start=[335.750000 205.250000 5.206129 -0.000000] end=[335.750000 224.699997 5.183259 -0.000000] s=1.9450e+1 vec=[0.000000 0.999999 -0.001176 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.020486]
a=5.1200e-10 d=5.1200e-10 reqv=2.1333e-5 startv=3.5200e-6 topv=2.1333e-5 endv=0.0000e+0 cks=947079 fp=17168 fl=0aaf
pp: td=1.945e+1 ad=4.323e-1 dsd=1.901e+1 a=5.120e-10 d=5.120e-10 ac=34792 sc=870620 dc=41667
Add seg: st=3224414778 t=34792 dist=-0.82 u=-6.696e-6 a=-9.740e-10 f=00
Add seg: st=3224449570 t=870620 dist=-35.33 u=-4.058e-5 a=0.000e+0 f=00
Add seg: st=3225320190 t=41667 dist=-0.85 u=-4.058e-5 a=9.740e-10 f=00
AddLin: st=3224414778 steps=312.0
addlin 1 ts=3224414778 DDA: start=[335.750000 205.250000 5.206129 -0.000000] end=[335.750000 224.699997 5.183259 -0.000000] s=1.9450e+1 vec=[0.000000 0.999999 -0.001176 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.020486]
a=5.1200e-10 d=5.1200e-10 reqv=2.1333e-5 startv=3.5200e-6 topv=2.1333e-5 endv=0.0000e+0 cks=947079 fp=17168 fl=0aaf
pp: td=1.945e+1 ad=4.323e-1 dsd=1.901e+1 a=5.120e-10 d=5.120e-10 ac=34792 sc=870620 dc=41667
Add seg: st=3224414778 t=34792 dist=6.93 u=5.646e-5 a=8.213e-9 f=00
Add seg: st=3224449570 t=870620 dist=297.92 u=3.422e-4 a=0.000e+0 f=00
Add seg: st=3225320190 t=41667 dist=7.13 u=3.422e-4 a=-8.213e-9 f=00
pr 2 ts=3224414778 DDA: start=[335.750000 205.250000 5.206129 -0.000000] end=[335.750000 224.699997 5.183259 -0.000000] s=1.9450e+1 vec=[0.000000 0.999999 -0.001176 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.000000 0.020486]
a=5.1200e-10 d=5.1200e-10 reqv=2.1333e-5 startv=3.5200e-6 topv=2.1333e-5 endv=0.0000e+0 cks=947079 fp=17168 fl=0aaf
Transformed 316.25 205.25 5.52 to 25300 20525 8839 0
File: M73 P25 R4
File: G1 X335.75 Y224.7 E.39845
Aux: M409 F"d99f"
Forward transformed 26860 20674 8328 to 335.75 206.74 5.20
Forward transformed 26860 21407 8314 to 335.75 214.07 5.20
Aux: M409 F"d99f"
Forward transformed 26860 21968 8303 to 335.75 219.68 5.19[Warning: 7644 received bytes dropped.] -
-
@bugpwr I've taken a look at your debug output and I don't see anything abnormal in it. I can see the 10mm reprime move being generated correctly. After that I see some small extruder movements in combination with XYZ movements as commanded by the file.
Are you certain that the 10mm retract operation is being performed correctly? It might be helpful to try the pause/resume with the nozzle removed so that you can see whether the correct amount of filament is being retracted. If the retraction is not being fully performed, that would account for the reprime move ending up with the extruder skipping that we can hear. Perhaps you should try reducing the speed of that retraction in pause.g.
If that doesn't resolve it, please can you try putting a
G1G4 S2
command at the end of resume.g to add a 2 second delay. Then see whether the uncommanded extrusion follows on immediately from the 10mm reprime move (before the delay), or after the delay. -
@bugpwr dc42 means
G4 S2
and notG1 S2
-
@dc42 hi dc42, first - thanks for stepping in, this is much appreciated.
I have performed the experiments. Starting from the end - after adding the G4 delay, it's seen clearly that this extra E move happens after the whole file. (should I try adding M400 before the wait?)
The "redundant extrusion" happens very fast, unaffected by the F parameter in "G1 E10 F300" from resume.g, while the priming move is indeed affected by the F setting (with F300 for example, it is fairly slow and completed just fine, but then comes that extra move which is ultra fast and causes extruder skips). By the way, the F300 speed would not cause the skips, it would just extrude the filament. I tried making this even slower and I see the change in the normal priming move.So, the source of the move is elsewhere (my honest guess would be that it has something to do with the "confinement" of relative move coordinates between the macro and the job file and switching between the two, but I have no evidence). Also, judging by the speed of this, it does not seem to come from any "actual" gcode in any of the files.
Here's another strange observation that is probably unrelated but may provide some useful evidence: the print head does not decend to the model before the G4 wait I have inserted; instead, it remains 5mm above the model, then the wait, then the failed extrusion, and then the print proceeds with print head descending to the last move. Thanks again, P
-
It might be just coincidence, but I remember having a similar issues all the way back in 3.5.0 and never found a fix for it
https://forum.duet3d.com/topic/35544/resume-g-activating-twice-with-fw3-5 -
@Notepad Thanks, I knew there was another report of something similar, couldn't find it! Do you still have this problem?
Ian
-
@droftarts unfortunately so. My only solution was to half the de-retraction amount knowing it would double itself
-
@Notepad okay, reading the word 'double' sent me to do more tests. Indeed - the overextruded amount seems to depend on what's written oin resume.g, but not exactly double - it seems like tripple to me. That is, changing "G1 E10 F300" to E1 (1mm) makes the additional extrusion something like 2mm. If this command is completely removed, there's no extrusion before or after the G4. Hope this could give some insight.
-
@bugpwr I'm looking at your debug trace again and now I can see the extra extrusion. Following the G1 E10 command there are 7830 microsteps of extrusion at a top speed of 3915 microsteps/sec (5mm/sec) with acceleration at the start and deceleration at the end. Then there are another 7830 microsteps of extrusion at a top speed of 15660 microsteps/sec (20mm/sec), again with acceleration at the start and deceleration at the end.
I will take a look at the 3.5.4 source code to identify the reason for this. Meanwhile, please can you try upgrading to 3.6.0-beta.3. There have been fairly substantial changes to the movement code in that version since beta 2.
-
@dc42 this is not 3.5.4, this was actually the latest beta2 (I will try with beta3 later today).
-
@bugpwr I think I found the problem. It only affects Duet 2 and Duet Maestro. Please try the 3.5.4+1 firmware binary at https://www.dropbox.com/scl/fo/xx7tpppxwbirz4zm9yr0o/AEb98egoCKGGVfCydwsFit8?rlkey=q1eg5g59zt1rbr9wqam80zygx&dl=0.
Edit: the same bug is present in the Duet 3 builds of 3.6.0-beta.3.
-
@dc42 looks like it is completely solved in this fix.
-
@bugpwr thanks for confirming. I will generate a new 3.6beta3+1 for Duet 2 when I have fixed another bug.
-
@bugpwr I've put a 3.6.0-beta.3+1 build that includes this fix at https://www.dropbox.com/scl/fo/bx70c7u0bshq79ez83mnn/AKMj4UCEimtQuGYxRj_d0ew?rlkey=7yiq3x5fcae3v2ogslfocx1op&dl=0.
-
-
@dc42 many thanks, the beta3+1 update works like a charm!!
(completely unrelated: speaking of 2.85mm systems, I don't want to bother you with a minor thing, but it would be awesome if M404 would upate move.extruders[].filamentDiameter. As of now, DWC always shows incorrect volumetric rate for 2.85 machines)