UBL issue/probing air

[cdedwards]

I've been attempting to use UBL again and I'm thinking that these numbers are not good.. In fact, when I G29 P1, the probe never actually hits the bed. for some reason, I am about 10mm too high. I'm getting the same thing with G33 P1 though, so not sure where the issue comes in. I can print and actually get some really nice prints but this has me stumped.
Marlin.zip
file included is actually a rar file since we can't upload them here.

SENT: G29 T
READ: 
READ: Bed Topography Report:
READ: 
READ: (0,6)                                           (6,6)
READ: (-135,135)                                        (135,135)
READ:      .          .       8.321    8.152    8.735       .          .     
READ:  
READ:      .       10.610    8.201    7.945    8.764    8.221       .     
READ:  
READ:   8.235    8.646    8.507    8.449    8.033    8.241    8.209  
READ:  
READ:   8.345    8.096    8.015  [ 8.008]   8.645    7.896    7.506  
READ:  
READ:   8.260    8.284    8.395    2.419    8.027    8.114    7.633  
READ:  
SENT: M105
READ:      .       8.059    8.310    8.290    8.212    2.116       .     
READ:  
READ:      .          .       7.693    7.844    8.098       .          .     
READ: (-135,-135)                                            (135,-135)
READ: (0,0)                                             (6,0)

[Roxy-3D]

Please turn on the #define DEBUG_LEVELING_FEATURE

It is going to be a little hard for me to help you because you have a Delta. But UBL uses the standard probing sub-system. So things can only be getting so crazy.

[cdedwards]

Debug log

READ: <<< do_blocking_move_to
READ:   current_position=(0.00, 0.00, 10.07) : sync_plan_position_kinematic
READ:   current_position=(0.00, 0.00, 10.07) : <<< do_probe_move
READ: 1st Probe Z:10.07
READ: >>> do_blocking_move_to(0.00, 0.00, 15.07)
READ:   destination=(0.00, 0.00, 10.07) : set_destination_from_current
READ:   destination=(0.00, 0.00, 15.07) : prepare_uninterpolated_move_to_destination
READ:   current_position=(0.00, 0.00, 15.07) : z raise move
READ:   current_position=(0.00, 0.00, 15.07) : xy move
READ: <<< do_blocking_move_to
READ:   current_position=(0.00, 0.00, 15.07) : >>> do_probe_move
READ: >>> do_blocking_move_to(0.00, 0.00, -10.00)
READ:   destination=(0.00, 0.00, 15.07) : set_destination_from_current
READ:   current_position=(0.00, 0.00, 15.07) : xy move
READ:   destination=(0.00, 0.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(0.00, 0.00, -10.00) : z lower move
SENT: M105
READ: <<< do_blocking_move_to
READ:   current_position=(0.00, 0.00, 10.18) : sync_plan_position_kinematic
READ:   current_position=(0.00, 0.00, 10.18) : <<< do_probe_move
READ:   current_position=(0.00, 0.00, 10.18) : <<< run_z_probe
READ: 2nd Probe Z:10.18 Discrepancy:-0.11
READ: >>> do_blocking_move_to(0.00, 0.00, 15.18)
READ:   destination=(0.00, 0.00, 10.18) : set_destination_from_current
READ:   destination=(0.00, 0.00, 15.18) : prepare_uninterpolated_move_to_destination
READ:   current_position=(0.00, 0.00, 15.18) : z raise move
READ:   current_position=(0.00, 0.00, 15.18) : xy move
READ: <<< do_blocking_move_to
READ: <<< probe_pt
READ: >>> probe_pt(-45.00, 0.00, no stow)
READ:   current_position=(0.00, 0.00, 15.18) : 
READ: >>> do_blocking_move_to(-45.00, 0.00, 15.18)
READ:   destination=(0.00, 0.00, 15.18) : set_destination_from_current
READ:   current_position=(-45.00, 0.00, 15.18) : xy move
READ: <<< do_blocking_move_to
READ:   current_position=(-45.00, 0.00, 15.18) : set_probe_deployed
READ: deploy: 1
READ:   current_position=(-45.00, 0.00, 15.18) : >>> run_z_probe
READ:   current_position=(-45.00, 0.00, 15.18) : >>> do_probe_move
READ: >>> do_blocking_move_to(-45.00, 0.00, -10.00)
READ:   destination=(-45.00, 0.00, 15.18) : set_destination_from_current
READ:   current_position=(-45.00, 0.00, 15.18) : xy move
READ:   destination=(-45.00, 0.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-45.00, 0.00, -10.00) : z lower move
READ: <<< do_blocking_move_to
READ:   current_position=(-45.00, 0.00, 9.95) : sync_plan_position_kinematic
READ:   current_position=(-45.00, 0.00, 9.95) : <<< do_probe_move
READ: 1st Probe Z:9.95
READ: >>> do_blocking_move_to(-45.00, 0.00, 14.95)
READ:   destination=(-45.00, 0.00, 9.95) : set_destination_from_current
READ:   destination=(-45.00, 0.00, 14.95) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-45.00, 0.00, 14.95) : z raise move
READ:   current_position=(-45.00, 0.00, 14.95) : xy move
READ: echo:busy: processing
busy: processing
READ: <<< do_blocking_move_to
READ:   current_position=(-45.00, 0.00, 14.95) : >>> do_probe_move
READ: >>> do_blocking_move_to(-45.00, 0.00, -10.00)
READ:   destination=(-45.00, 0.00, 14.95) : set_destination_from_current
READ:   current_position=(-45.00, 0.00, 14.95) : xy move
READ:   destination=(-45.00, 0.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-45.00, 0.00, -10.00) : z lower move
READ: <<< do_blocking_move_to
READ:   current_position=(-45.00, 0.00, 9.99) : sync_plan_position_kinematic
READ:   current_position=(-45.00, 0.00, 9.99) : <<< do_probe_move
READ:   current_position=(-45.00, 0.00, 9.99) : <<< run_z_probe
READ: 2nd Probe Z:9.99 Discrepancy:-0.04
READ: >>> do_blocking_move_to(-45.00, 0.00, 14.99)
READ:   destination=(-45.00, 0.00, 9.99) : set_destination_from_current
READ:   destination=(-45.00, 0.00, 14.99) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-45.00, 0.00, 14.99) : z raise move
READ:   current_position=(-45.00, 0.00, 14.99) : xy move
READ: <<< do_blocking_move_to
READ: <<< probe_pt
READ: >>> probe_pt(0.00, -45.00, no stow)
READ:   current_position=(-45.00, 0.00, 14.99) : 
READ: >>> do_blocking_move_to(0.00, -45.00, 14.99)
READ:   destination=(-45.00, 0.00, 14.99) : set_destination_from_current
SENT: M112

I only let it run for a couple of points. I have double probe on.

[cdedwards]

Very long debug log

READ:   current_position=(90.00, -90.00, -10.00) : z lower move
READ: <<< do_blocking_move_to
READ:   current_position=(90.00, -90.00, 4.23) : sync_plan_position_kinematic
READ:   current_position=(90.00, -90.00, 4.23) : <<< do_probe_move
READ:   current_position=(90.00, -90.00, 4.23) : <<< run_z_probe
READ: 2nd Probe Z:4.23 Discrepancy:-0.08
READ: >>> do_blocking_move_to(90.00, -90.00, 9.23)
READ:   destination=(90.00, -90.00, 4.23) : set_destination_from_current
READ:   destination=(90.00, -90.00, 9.23) : prepare_uninterpolated_move_to_destination
READ:   current_position=(90.00, -90.00, 9.23) : z raise move
READ:   current_position=(90.00, -90.00, 9.23) : xy move
READ: <<< do_blocking_move_to
READ: <<< probe_pt
READ: >>> probe_pt(135.00, 0.00, no stow)
READ:   current_position=(90.00, -90.00, 9.23) : 
READ: >>> do_blocking_move_to(135.00, 0.00, 9.23)
READ:   destination=(90.00, -90.00, 9.23) : set_destination_from_current
READ:   current_position=(135.00, 0.00, 9.23) : xy move
READ: <<< do_blocking_move_to
READ:   current_position=(135.00, 0.00, 9.23) : set_probe_deployed
READ: deploy: 1
READ:   current_position=(135.00, 0.00, 9.23) : >>> run_z_probe
READ:   current_position=(135.00, 0.00, 9.23) : >>> do_probe_move
READ: >>> do_blocking_move_to(135.00, 0.00, -10.00)
READ:   destination=(135.00, 0.00, 9.23) : set_destination_from_current
READ:   current_position=(135.00, 0.00, 9.23) : xy move
READ:   destination=(135.00, 0.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(135.00, 0.00, -10.00) : z lower move
READ: <<< do_blocking_move_to
READ:   current_position=(135.00, 0.00, 9.19) : sync_plan_position_kinematic
READ:   current_position=(135.00, 0.00, 9.19) : <<< do_probe_move
READ: 1st Probe Z:9.19
READ: >>> do_blocking_move_to(135.00, 0.00, 14.19)
READ:   destination=(135.00, 0.00, 9.19) : set_destination_from_current
READ:   destination=(135.00, 0.00, 14.19) : prepare_uninterpolated_move_to_destination
READ:   current_position=(135.00, 0.00, 14.19) : z raise move
READ:   current_position=(135.00, 0.00, 14.19) : xy move
READ: <<< do_blocking_move_to
READ:   current_position=(135.00, 0.00, 14.19) : >>> do_probe_move
READ: >>> do_blocking_move_to(135.00, 0.00, -10.00)
READ:   destination=(135.00, 0.00, 14.19) : set_destination_from_current
READ:   current_position=(135.00, 0.00, 14.19) : xy move
READ:   destination=(135.00, 0.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(135.00, 0.00, -10.00) : z lower move
READ: echo:busy: processing
busy: processing
READ: <<< do_blocking_move_to
READ:   current_position=(135.00, 0.00, 9.63) : sync_plan_position_kinematic
READ:   current_position=(135.00, 0.00, 9.63) : <<< do_probe_move
READ:   current_position=(135.00, 0.00, 9.63) : <<< run_z_probe
READ: 2nd Probe Z:9.63 Discrepancy:-0.44
READ: >>> do_blocking_move_to(135.00, 0.00, 14.63)
READ:   destination=(135.00, 0.00, 9.63) : set_destination_from_current
READ:   destination=(135.00, 0.00, 14.63) : prepare_uninterpolated_move_to_destination
READ:   current_position=(135.00, 0.00, 14.63) : z raise move
READ:   current_position=(135.00, 0.00, 14.63) : xy move
READ: <<< do_blocking_move_to
READ: <<< probe_pt
READ: >>> probe_pt(135.00, -45.00, no stow)
READ:   current_position=(135.00, 0.00, 14.63) : 
READ: >>> do_blocking_move_to(135.00, -45.00, 14.63)
READ:   destination=(135.00, 0.00, 14.63) : set_destination_from_current
READ:   current_position=(135.00, -45.00, 14.63) : xy move
READ: <<< do_blocking_move_to
READ:   current_position=(135.00, -45.00, 14.63) : set_probe_deployed
READ: deploy: 1
READ:   current_position=(135.00, -45.00, 14.63) : >>> run_z_probe
READ:   current_position=(135.00, -45.00, 14.63) : >>> do_probe_move
READ: >>> do_blocking_move_to(135.00, -45.00, -10.00)
READ:   destination=(135.00, -45.00, 14.63) : set_destination_from_current
READ:   current_position=(135.00, -45.00, 14.63) : xy move
READ:   destination=(135.00, -45.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(135.00, -45.00, -10.00) : z lower move
READ: <<< do_blocking_move_to
READ:   current_position=(135.00, -45.00, 9.84) : sync_plan_position_kinematic
READ:   current_position=(135.00, -45.00, 9.84) : <<< do_probe_move
READ: 1st Probe Z:9.84
READ: >>> do_blocking_move_to(135.00, -45.00, 14.84)
READ:   destination=(135.00, -45.00, 9.84) : set_destination_from_current
READ:   destination=(135.00, -45.00, 14.84) : prepare_uninterpolated_move_to_destination
READ:   current_position=(135.00, -45.00, 14.84) : z raise move
READ:   current_position=(135.00, -45.00, 14.84) : xy move
READ: <<< do_blocking_move_to
READ:   current_position=(135.00, -45.00, 14.84) : >>> do_probe_move
READ: >>> do_blocking_move_to(135.00, -45.00, -10.00)
READ:   destination=(135.00, -45.00, 14.84) : set_destination_from_current
READ:   current_position=(135.00, -45.00, 14.84) : xy move
READ:   destination=(135.00, -45.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(135.00, -45.00, -10.00) : z lower move
READ: <<< do_blocking_move_to
READ:   current_position=(135.00, -45.00, 10.02) : sync_plan_position_kinematic
READ:   current_position=(135.00, -45.00, 10.02) : <<< do_probe_move
READ:   current_position=(135.00, -45.00, 10.02) : <<< run_z_probe
READ: 2nd Probe Z:10.02 Discrepancy:-0.17
READ: >>> do_blocking_move_to(135.00, -45.00, 15.02)
READ:   destination=(135.00, -45.00, 10.02) : set_destination_from_current
READ:   destination=(135.00, -45.00, 15.02) : prepare_uninterpolated_move_to_destination
READ:   current_position=(135.00, -45.00, 15.02) : z raise move
READ:   current_position=(135.00, -45.00, 15.02) : xy move
READ: <<< do_blocking_move_to
READ: <<< probe_pt
READ: >>> probe_pt(135.00, 45.00, no stow)
READ:   current_position=(135.00, -45.00, 15.02) : 
READ: >>> do_blocking_move_to(135.00, 45.00, 15.02)
READ:   destination=(135.00, -45.00, 15.02) : set_destination_from_current
READ:   current_position=(135.00, 45.00, 15.02) : xy move
READ: echo:busy: processing
busy: processing
READ: <<< do_blocking_move_to
READ:   current_position=(135.00, 45.00, 15.02) : set_probe_deployed
READ: deploy: 1
READ:   current_position=(135.00, 45.00, 15.02) : >>> run_z_probe
READ:   current_position=(135.00, 45.00, 15.02) : >>> do_probe_move
READ: >>> do_blocking_move_to(135.00, 45.00, -10.00)
READ:   destination=(135.00, 45.00, 15.02) : set_destination_from_current
READ:   current_position=(135.00, 45.00, 15.02) : xy move
READ:   destination=(135.00, 45.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(135.00, 45.00, -10.00) : z lower move
READ: <<< do_blocking_move_to
READ:   current_position=(135.00, 45.00, 10.02) : sync_plan_position_kinematic
READ:   current_position=(135.00, 45.00, 10.02) : <<< do_probe_move
READ: 1st Probe Z:10.02
READ: >>> do_blocking_move_to(135.00, 45.00, 15.02)
READ:   destination=(135.00, 45.00, 10.02) : set_destination_from_current
READ:   destination=(135.00, 45.00, 15.02) : prepare_uninterpolated_move_to_destination
READ:   current_position=(135.00, 45.00, 15.02) : z raise move
READ:   current_position=(135.00, 45.00, 15.02) : xy move
READ: <<< do_blocking_move_to
READ:   current_position=(135.00, 45.00, 15.02) : >>> do_probe_move
READ: >>> do_blocking_move_to(135.00, 45.00, -10.00)
READ:   destination=(135.00, 45.00, 15.02) : set_destination_from_current
READ:   current_position=(135.00, 45.00, 15.02) : xy move
READ:   destination=(135.00, 45.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(135.00, 45.00, -10.00) : z lower move
READ: <<< do_blocking_move_to
READ:   current_position=(135.00, 45.00, 10.03) : sync_plan_position_kinematic
READ:   current_position=(135.00, 45.00, 10.03) : <<< do_probe_move
READ:   current_position=(135.00, 45.00, 10.03) : <<< run_z_probe
READ: 2nd Probe Z:10.03 Discrepancy:-0.01
READ: >>> do_blocking_move_to(135.00, 45.00, 15.03)
READ:   destination=(135.00, 45.00, 10.03) : set_destination_from_current
READ:   destination=(135.00, 45.00, 15.03) : prepare_uninterpolated_move_to_destination
READ:   current_position=(135.00, 45.00, 15.03) : z raise move
READ:   current_position=(135.00, 45.00, 15.03) : xy move
READ: <<< do_blocking_move_to
READ: <<< probe_pt
READ: >>> probe_pt(45.00, 135.00, no stow)
READ:   current_position=(135.00, 45.00, 15.03) : 
READ: >>> do_blocking_move_to(45.00, 135.00, 15.03)
READ:   destination=(135.00, 45.00, 15.03) : set_destination_from_current
READ:   current_position=(45.00, 135.00, 15.03) : xy move
READ: echo:busy: processing
busy: processing
READ: <<< do_blocking_move_to
READ:   current_position=(45.00, 135.00, 15.03) : set_probe_deployed
READ: deploy: 1
READ:   current_position=(45.00, 135.00, 15.03) : >>> run_z_probe
READ:   current_position=(45.00, 135.00, 15.03) : >>> do_probe_move
READ: >>> do_blocking_move_to(45.00, 135.00, -10.00)
READ:   destination=(45.00, 135.00, 15.03) : set_destination_from_current
READ:   current_position=(45.00, 135.00, 15.03) : xy move
READ:   destination=(45.00, 135.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(45.00, 135.00, -10.00) : z lower move
READ: <<< do_blocking_move_to
READ:   current_position=(45.00, 135.00, 10.41) : sync_plan_position_kinematic
READ:   current_position=(45.00, 135.00, 10.41) : <<< do_probe_move
READ: 1st Probe Z:10.41
READ: >>> do_blocking_move_to(45.00, 135.00, 15.41)
READ:   destination=(45.00, 135.00, 10.41) : set_destination_from_current
READ:   destination=(45.00, 135.00, 15.41) : prepare_uninterpolated_move_to_destination
READ:   current_position=(45.00, 135.00, 15.41) : z raise move
READ:   current_position=(45.00, 135.00, 15.41) : xy move
READ: <<< do_blocking_move_to
READ:   current_position=(45.00, 135.00, 15.41) : >>> do_probe_move
READ: >>> do_blocking_move_to(45.00, 135.00, -10.00)
READ:   destination=(45.00, 135.00, 15.41) : set_destination_from_current
READ:   current_position=(45.00, 135.00, 15.41) : xy move
READ:   destination=(45.00, 135.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(45.00, 135.00, -10.00) : z lower move
READ: <<< do_blocking_move_to
READ:   current_position=(45.00, 135.00, 10.60) : sync_plan_position_kinematic
READ:   current_position=(45.00, 135.00, 10.60) : <<< do_probe_move
READ:   current_position=(45.00, 135.00, 10.60) : <<< run_z_probe
READ: 2nd Probe Z:10.60 Discrepancy:-0.18
READ: >>> do_blocking_move_to(45.00, 135.00, 15.60)
READ:   destination=(45.00, 135.00, 10.60) : set_destination_from_current
READ:   destination=(45.00, 135.00, 15.60) : prepare_uninterpolated_move_to_destination
READ:   current_position=(45.00, 135.00, 15.60) : z raise move
READ:   current_position=(45.00, 135.00, 15.60) : xy move
READ: <<< do_blocking_move_to
READ: <<< probe_pt
READ: >>> probe_pt(-45.00, 135.00, no stow)
READ:   current_position=(45.00, 135.00, 15.60) : 
READ: >>> do_blocking_move_to(-45.00, 135.00, 15.60)
READ:   destination=(45.00, 135.00, 15.60) : set_destination_from_current
READ:   current_position=(-45.00, 135.00, 15.60) : xy move
READ: <<< do_blocking_move_to
READ:   current_position=(-45.00, 135.00, 15.60) : set_probe_deployed
READ: deploy: 1
READ:   current_position=(-45.00, 135.00, 15.60) : >>> run_z_probe
READ:   current_position=(-45.00, 135.00, 15.60) : >>> do_probe_move
READ: >>> do_blocking_move_to(-45.00, 135.00, -10.00)
READ:   destination=(-45.00, 135.00, 15.60) : set_destination_from_current
READ:   current_position=(-45.00, 135.00, 15.60) : xy move
READ:   destination=(-45.00, 135.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-45.00, 135.00, -10.00) : z lower move
READ: echo:busy: processing
busy: processing
READ: <<< do_blocking_move_to
READ:   current_position=(-45.00, 135.00, 9.55) : sync_plan_position_kinematic
READ:   current_position=(-45.00, 135.00, 9.55) : <<< do_probe_move
READ: 1st Probe Z:9.55
READ: >>> do_blocking_move_to(-45.00, 135.00, 14.55)
READ:   destination=(-45.00, 135.00, 9.55) : set_destination_from_current
READ:   destination=(-45.00, 135.00, 14.55) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-45.00, 135.00, 14.55) : z raise move
READ:   current_position=(-45.00, 135.00, 14.55) : xy move
READ: <<< do_blocking_move_to
READ:   current_position=(-45.00, 135.00, 14.55) : >>> do_probe_move
READ: >>> do_blocking_move_to(-45.00, 135.00, -10.00)
READ:   destination=(-45.00, 135.00, 14.55) : set_destination_from_current
READ:   current_position=(-45.00, 135.00, 14.55) : xy move
READ:   destination=(-45.00, 135.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-45.00, 135.00, -10.00) : z lower move
READ: <<< do_blocking_move_to
READ:   current_position=(-45.00, 135.00, 9.73) : sync_plan_position_kinematic
READ:   current_position=(-45.00, 135.00, 9.73) : <<< do_probe_move
READ:   current_position=(-45.00, 135.00, 9.73) : <<< run_z_probe
READ: 2nd Probe Z:9.73 Discrepancy:-0.17
READ: >>> do_blocking_move_to(-45.00, 135.00, 14.73)
READ:   destination=(-45.00, 135.00, 9.73) : set_destination_from_current
READ:   destination=(-45.00, 135.00, 14.73) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-45.00, 135.00, 14.73) : z raise move
READ:   current_position=(-45.00, 135.00, 14.73) : xy move
READ: <<< do_blocking_move_to
READ: <<< probe_pt
READ: >>> probe_pt(-135.00, 45.00, no stow)
READ:   current_position=(-45.00, 135.00, 14.73) : 
READ: >>> do_blocking_move_to(-135.00, 45.00, 14.73)
READ:   destination=(-45.00, 135.00, 14.73) : set_destination_from_current
READ:   current_position=(-135.00, 45.00, 14.73) : xy move
READ: echo:busy: processing
busy: processing
READ: <<< do_blocking_move_to
READ:   current_position=(-135.00, 45.00, 14.73) : set_probe_deployed
READ: deploy: 1
READ:   current_position=(-135.00, 45.00, 14.73) : >>> run_z_probe
READ:   current_position=(-135.00, 45.00, 14.73) : >>> do_probe_move
READ: >>> do_blocking_move_to(-135.00, 45.00, -10.00)
READ:   destination=(-135.00, 45.00, 14.73) : set_destination_from_current
READ:   current_position=(-135.00, 45.00, 14.73) : xy move
READ:   destination=(-135.00, 45.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-135.00, 45.00, -10.00) : z lower move
READ: <<< do_blocking_move_to
READ:   current_position=(-135.00, 45.00, 9.98) : sync_plan_position_kinematic
READ:   current_position=(-135.00, 45.00, 9.98) : <<< do_probe_move
READ: 1st Probe Z:9.98
READ: >>> do_blocking_move_to(-135.00, 45.00, 14.98)
READ:   destination=(-135.00, 45.00, 9.98) : set_destination_from_current
READ:   destination=(-135.00, 45.00, 14.98) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-135.00, 45.00, 14.98) : z raise move
READ:   current_position=(-135.00, 45.00, 14.98) : xy move
READ: <<< do_blocking_move_to
READ:   current_position=(-135.00, 45.00, 14.98) : >>> do_probe_move
READ: >>> do_blocking_move_to(-135.00, 45.00, -10.00)
READ:   destination=(-135.00, 45.00, 14.98) : set_destination_from_current
READ:   current_position=(-135.00, 45.00, 14.98) : xy move
READ:   destination=(-135.00, 45.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-135.00, 45.00, -10.00) : z lower move
READ: <<< do_blocking_move_to
READ:   current_position=(-135.00, 45.00, 10.01) : sync_plan_position_kinematic
READ:   current_position=(-135.00, 45.00, 10.01) : <<< do_probe_move
READ:   current_position=(-135.00, 45.00, 10.01) : <<< run_z_probe
READ: 2nd Probe Z:10.01 Discrepancy:-0.04
READ: >>> do_blocking_move_to(-135.00, 45.00, 15.01)
READ:   destination=(-135.00, 45.00, 10.01) : set_destination_from_current
READ:   destination=(-135.00, 45.00, 15.01) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-135.00, 45.00, 15.01) : z raise move
READ:   current_position=(-135.00, 45.00, 15.01) : xy move
READ: <<< do_blocking_move_to
READ: <<< probe_pt
READ: >>> probe_pt(-135.00, -45.00, no stow)
READ:   current_position=(-135.00, 45.00, 15.01) : 
READ: >>> do_blocking_move_to(-135.00, -45.00, 15.01)
READ:   destination=(-135.00, 45.00, 15.01) : set_destination_from_current
READ:   current_position=(-135.00, -45.00, 15.01) : xy move
READ: <<< do_blocking_move_to
READ:   current_position=(-135.00, -45.00, 15.01) : set_probe_deployed
READ: deploy: 1
READ:   current_position=(-135.00, -45.00, 15.01) : >>> run_z_probe
READ:   current_position=(-135.00, -45.00, 15.01) : >>> do_probe_move
READ: >>> do_blocking_move_to(-135.00, -45.00, -10.00)
READ:   destination=(-135.00, -45.00, 15.01) : set_destination_from_current
READ:   current_position=(-135.00, -45.00, 15.01) : xy move
READ:   destination=(-135.00, -45.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-135.00, -45.00, -10.00) : z lower move
READ: echo:busy: processing
busy: processing
READ: <<< do_blocking_move_to
READ:   current_position=(-135.00, -45.00, 10.23) : sync_plan_position_kinematic
READ:   current_position=(-135.00, -45.00, 10.23) : <<< do_probe_move
READ: 1st Probe Z:10.23
READ: >>> do_blocking_move_to(-135.00, -45.00, 15.23)
READ:   destination=(-135.00, -45.00, 10.23) : set_destination_from_current
READ:   destination=(-135.00, -45.00, 15.23) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-135.00, -45.00, 15.23) : z raise move
READ:   current_position=(-135.00, -45.00, 15.23) : xy move
READ: <<< do_blocking_move_to
READ:   current_position=(-135.00, -45.00, 15.23) : >>> do_probe_move
READ: >>> do_blocking_move_to(-135.00, -45.00, -10.00)
READ:   destination=(-135.00, -45.00, 15.23) : set_destination_from_current
READ:   current_position=(-135.00, -45.00, 15.23) : xy move
READ:   destination=(-135.00, -45.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-135.00, -45.00, -10.00) : z lower move
READ: <<< do_blocking_move_to
READ:   current_position=(-135.00, -45.00, 10.31) : sync_plan_position_kinematic
READ:   current_position=(-135.00, -45.00, 10.31) : <<< do_probe_move
READ:   current_position=(-135.00, -45.00, 10.31) : <<< run_z_probe
READ: 2nd Probe Z:10.31 Discrepancy:-0.09
READ: >>> do_blocking_move_to(-135.00, -45.00, 15.31)
READ:   destination=(-135.00, -45.00, 10.31) : set_destination_from_current
READ:   destination=(-135.00, -45.00, 15.31) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-135.00, -45.00, 15.31) : z raise move
READ:   current_position=(-135.00, -45.00, 15.31) : xy move
READ: <<< do_blocking_move_to
READ: <<< probe_pt
READ: >>> probe_pt(-45.00, -135.00, no stow)
READ:   current_position=(-135.00, -45.00, 15.31) : 
READ: >>> do_blocking_move_to(-45.00, -135.00, 15.31)
READ:   destination=(-135.00, -45.00, 15.31) : set_destination_from_current
READ:   current_position=(-45.00, -135.00, 15.31) : xy move
READ: echo:busy: processing
busy: processing
READ: <<< do_blocking_move_to
READ:   current_position=(-45.00, -135.00, 15.31) : set_probe_deployed
READ: deploy: 1
READ:   current_position=(-45.00, -135.00, 15.31) : >>> run_z_probe
READ:   current_position=(-45.00, -135.00, 15.31) : >>> do_probe_move
READ: >>> do_blocking_move_to(-45.00, -135.00, -10.00)
READ:   destination=(-45.00, -135.00, 15.31) : set_destination_from_current
READ:   current_position=(-45.00, -135.00, 15.31) : xy move
READ:   destination=(-45.00, -135.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-45.00, -135.00, -10.00) : z lower move
READ: <<< do_blocking_move_to
READ:   current_position=(-45.00, -135.00, 9.82) : sync_plan_position_kinematic
READ:   current_position=(-45.00, -135.00, 9.82) : <<< do_probe_move
READ: 1st Probe Z:9.82
READ: >>> do_blocking_move_to(-45.00, -135.00, 14.82)
READ:   destination=(-45.00, -135.00, 9.82) : set_destination_from_current
READ:   destination=(-45.00, -135.00, 14.82) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-45.00, -135.00, 14.82) : z raise move
READ:   current_position=(-45.00, -135.00, 14.82) : xy move
READ: <<< do_blocking_move_to
READ:   current_position=(-45.00, -135.00, 14.82) : >>> do_probe_move
READ: >>> do_blocking_move_to(-45.00, -135.00, -10.00)
READ:   destination=(-45.00, -135.00, 14.82) : set_destination_from_current
READ:   current_position=(-45.00, -135.00, 14.82) : xy move
READ:   destination=(-45.00, -135.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-45.00, -135.00, -10.00) : z lower move
READ: <<< do_blocking_move_to
READ:   current_position=(-45.00, -135.00, 10.09) : sync_plan_position_kinematic
READ:   current_position=(-45.00, -135.00, 10.09) : <<< do_probe_move
READ:   current_position=(-45.00, -135.00, 10.09) : <<< run_z_probe
READ: 2nd Probe Z:10.09 Discrepancy:-0.27
READ: >>> do_blocking_move_to(-45.00, -135.00, 15.09)
READ:   destination=(-45.00, -135.00, 10.09) : set_destination_from_current
READ:   destination=(-45.00, -135.00, 15.09) : prepare_uninterpolated_move_to_destination
READ:   current_position=(-45.00, -135.00, 15.09) : z raise move
READ:   current_position=(-45.00, -135.00, 15.09) : xy move
READ: <<< do_blocking_move_to
READ: <<< probe_pt
READ: >>> probe_pt(45.00, -135.00, no stow)
READ:   current_position=(-45.00, -135.00, 15.09) : 
READ: >>> do_blocking_move_to(45.00, -135.00, 15.09)
READ:   destination=(-45.00, -135.00, 15.09) : set_destination_from_current
READ:   current_position=(45.00, -135.00, 15.09) : xy move
READ: <<< do_blocking_move_to
READ:   current_position=(45.00, -135.00, 15.09) : set_probe_deployed
READ: deploy: 1
READ:   current_position=(45.00, -135.00, 15.09) : >>> run_z_probe
READ:   current_position=(45.00, -135.00, 15.09) : >>> do_probe_move
READ: >>> do_blocking_move_to(45.00, -135.00, -10.00)
READ:   destination=(45.00, -135.00, 15.09) : set_destination_from_current
READ:   current_position=(45.00, -135.00, 15.09) : xy move
READ:   destination=(45.00, -135.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(45.00, -135.00, -10.00) : z lower move
READ: <<< do_blocking_move_to
READ:   current_position=(45.00, -135.00, 10.09) : sync_plan_position_kinematic
READ:   current_position=(45.00, -135.00, 10.09) : <<< do_probe_move
READ: 1st Probe Z:10.09
READ: >>> do_blocking_move_to(45.00, -135.00, 15.09)
READ:   destination=(45.00, -135.00, 10.09) : set_destination_from_current
READ:   destination=(45.00, -135.00, 15.09) : prepare_uninterpolated_move_to_destination
READ:   current_position=(45.00, -135.00, 15.09) : z raise move
READ:   current_position=(45.00, -135.00, 15.09) : xy move
READ: echo:busy: processing
busy: processing
READ: <<< do_blocking_move_to
READ:   current_position=(45.00, -135.00, 15.09) : >>> do_probe_move
READ: >>> do_blocking_move_to(45.00, -135.00, -10.00)
READ:   destination=(45.00, -135.00, 15.09) : set_destination_from_current
READ:   current_position=(45.00, -135.00, 15.09) : xy move
READ:   destination=(45.00, -135.00, -10.00) : prepare_uninterpolated_move_to_destination
READ:   current_position=(45.00, -135.00, -10.00) : z lower move
READ: <<< do_blocking_move_to
READ:   current_position=(45.00, -135.00, 10.28) : sync_plan_position_kinematic
READ:   current_position=(45.00, -135.00, 10.28) : <<< do_probe_move
READ:   current_position=(45.00, -135.00, 10.28) : <<< run_z_probe
READ: 2nd Probe Z:10.28 Discrepancy:-0.19
READ: >>> do_blocking_move_to(45.00, -135.00, 15.28)
READ:   destination=(45.00, -135.00, 10.28) : set_destination_from_current
READ:   destination=(45.00, -135.00, 15.28) : prepare_uninterpolated_move_to_destination
READ:   current_position=(45.00, -135.00, 15.28) : z raise move
READ:   current_position=(45.00, -135.00, 15.28) : xy move
READ: <<< do_blocking_move_to
READ: <<< probe_pt
READ:   current_position=(45.00, -135.00, 15.28) : set_probe_deployed
READ: deploy: 0
READ: do_probe_raise(5.00)
READ: >>> do_blocking_move_to(45.00, -135.00, 15.28)
READ:   destination=(45.00, -135.00, 15.28) : set_destination_from_current
READ:   current_position=(45.00, -135.00, 15.28) : xy move
READ: <<< do_blocking_move_to
READ: >>> do_blocking_move_to(0.00, 0.00, 15.28)
READ:   destination=(45.00, -135.00, 15.28) : set_destination_from_current
READ:   current_position=(0.00, 0.00, 15.28) : xy move

[Roxy-3D]

It sure looks like the probing system thinks the Z-Probe is firing at +10 mm from the bed.

• is the nozzle at 15mm above the bed when the probe starts? That is what the probing system thinks is happening.
• does the probe move down 5 mm before it 'triggers' ? That is what the probing system thinks is happening.

I wonder if your Z-Probe is always triggered? Can you please home the machine and do a M119 and see what it says about the Z-Probe.

[cdedwards]

Z probe is off. it's an IR sensor and will trigger with my finger. I can tell by the LED on it.

Nozzle is homed when I start so yes it's 354.44mm above the bed.
from 15mm it moves down 5mm and then bounces back up to 15mm. occasionally it drops down further than 5mm. which gives the weird spots on the bed.

[Roxy-3D]

With the nozzle 15mm above the bed is the Z-Probe triggered? What does M119 say?

With the nozzle 5mm above the bed is the Z-Probe triggered? What does M119 say?

It looks from the debug information that the firmware thinks the probe is triggered well before the nozzle gets to 0.0 mm.

[cdedwards]

READ: X:0.00 Y:0.00 Z:15.00 E:0.00 Count X:52446 Y:52446 Z:52446
READ: Reporting endstop status
READ: x_max: open
READ: y_max: open
READ: z_min: open
READ: z_max: open

SENT: M119
READ: Reporting endstop status
READ: x_max: open
READ: y_max: open
READ: z_min: open
READ: z_max: open
READ: X:0.00 Y:0.00 Z:5.00 E:0.00 Count X:50846 Y:50846 Z:50846

I did a G28 to home. then G1Z15 and then M114/119
then I did a G1Z5 with finally a M114/119

The probe does not trigger at during the G29/G33. It's like Marlin is making a best guess

[cdedwards]

It's really cool when you hit a limit I guess you could call it and instead of stopping or giving an error, it reverses direction. I'm giving a G91G1Z1G90 and it should be dropping down to the bed. instead it gets to a certain point and starts rising instead 👎

[Roxy-3D]

Is the nozzle in the center of the bed when this happens? There used to be a problem where if the nozzle went outside of the Delta_Probable_Radius, it would go up to the Z-Max. I don't think that can happen any more. But the fact you are seeing it reverse direction and go up makes me wonder.

And... Ignoring UBL. When you home the machine, can you do a M48 and see if that works? That will be a lot easier to debug if it doesn't work.

[cdedwards]

it's at the center of the bed.. it starts at the first point, and continues from there

[Tannoo]

Did the bed surface change? I was going to use an ir sensor, but couldn't get reliable positions from it.

[cdedwards]

umm problem is not the sensor. sensor is not even triggering at all. I've been getting very good results with my DC42 IR sensor. std dev was 0.09 or so over 40 taps on the bed according to M48

[Roxy-3D]

@thinkyhead Can you take a look at his DEBUG_LEVELING traces? I'm sure what ever is wrong is something small. But it isn't obvious to me what is causing this.

[thinkyhead]

@cdedwards It's hard to tell from the log output exactly what's going on, but with a little extra detail we might have a better clue.

Please grab the latest bugfix-1.1.x and with DEBUG_LEVELING_FEATURE enabled do M111 S247 before starting to enable the most detailed logging possible. Then do a G28 followed by a G29 again and post the log output of both of those commands here.

Thanks!

[Roxy-3D]

This has some similarity to #8298