Additional logging of do_blocking_move_to

[thinkyhead]

"If you want to make an omelette you've got to break a few eggs." #4370

[ghost]

This is a new log.

Commands:

m502
m500
m111 s32
g28
g29

log

16:34:55.743 : echo:SD card ok
16:34:55.743 : N11 M20*33
16:34:55.774 : echo:SD card ok
16:34:55.802 : FIRMWARE_NAME:Marlin 1.1.0-RCBugFix (Github) SOURCE_CODE_URL:https://github.com/MarlinFirmware/Marlin PROTOCOL_VERSION:1.0 MACHINE_TYPE:Micromake EXTRUDER_COUNT:1 UUID:cede2a2f-41a2-4748-9b12-c55c62f367ff EMERGENCY_CODES:M108,M112,M410
16:34:55.805 : N12 M20*34
16:34:55.813 : N13 M220 S100*83
16:34:55.813 : X:0.00 Y:0.00 Z:0.00 E:0.00 Count X: 39087 Y:39087 Z:39087
16:34:55.813 : echo:DEBUG:ECHO,INFO,ERRORS
16:34:55.813 : echo:N6 T0*60
16:34:55.813 : N14 M221 S100*85
16:34:55.813 : echo:Active Extruder: 0
16:34:55.814 : N15 M111 S7*82
16:34:55.814 : echo:N7 M20*22
16:34:55.814 : Begin file list
16:34:55.817 : End file list
16:34:55.822 : echo:N8 M80*19
16:34:55.824 : N16 T0*13
16:34:55.826 : echo:N11 M20*33
16:34:55.826 : Begin file list
16:34:55.831 : End file list
16:34:55.834 : echo:N12 M20*34
16:34:55.834 : Begin file list
16:34:55.842 : End file list
16:34:55.842 : echo:N13 M220 S100*83
16:34:55.842 : echo:N14 M221 S100*85
16:34:55.843 : echo:N15 M111 S7*82
16:34:55.846 : echo:DEBUG:ECHO,INFO,ERRORS
16:34:55.846 : echo:N16 T0*13
16:34:55.846 : echo:Active Extruder: 0
16:34:57.135 : Printer reset detected - initalizing
16:34:57.136 : start
16:34:57.140 : echo: External Reset
16:34:57.140 : Marlin 1.1.0-RCBugFix
16:34:57.140 : echo: Last Updated: 2016-04-27 12:00 | Author: (Micromake)
16:34:57.144 : Compiled: Jul 23 2016
16:34:57.144 : echo: Free Memory: 2589  PlannerBufferBytes: 1408
16:34:57.149 : echo:V24 stored settings retrieved (427 bytes)
16:34:57.149 : echo:Steps per unit:
16:34:57.149 : echo:  M92 X200.00 Y200.00 Z200.00 E476.55
16:34:57.149 : echo:Maximum feedrates (mm/s):
16:34:57.153 : echo:  M203 X300.00 Y300.00 Z300.00 E300.00
16:34:57.153 : echo:Maximum Acceleration (mm/s2):
16:34:57.157 : echo:  M201 X3000 Y3000 Z3000 E9000
16:34:57.157 : echo:Accelerations: P=printing, R=retract and T=travel
16:34:57.157 : echo:  M204 P3000.00 R9000.00 T3000.00
16:34:57.165 : echo:Advanced variables: S=Min feedrate (mm/s), T=Min travel feedrate (mm/s), B=minimum segment time (ms), X=maximum XY jerk (mm/s),  Z=maximum Z jerk (mm/s),  E=maximum E jerk (mm/s)
16:34:57.169 : echo:  M205 S0.00 T0.00 B20000 X10.00 Z10.00 E5.00
16:34:57.169 : echo:Home offset (mm)
16:34:57.169 : echo:  M206 X0.00 Y0.00 Z0.00
16:34:57.173 : echo:Endstop adjustment (mm):
16:34:57.173 : echo:  M666 X0.00 Y0.00 Z0.00
16:34:57.177 : echo:Delta settings: L=diagonal_rod, R=radius, S=segments_per_second, ABC=diagonal_rod_trim_tower_[123]
16:34:57.181 : echo:  M665 L217.30 R95.00 S80.00 A0.00 B0.00 C0.00
16:34:57.181 : echo:Material heatup parameters:
16:34:57.181 : echo:  M145 S0 H200 B70 F255
16:34:57.181 : echo:  M145 S1 H240 B100 F255
16:34:57.185 : echo:PID settings:
16:34:57.185 : echo:  M301 P46.03 I6.24 D84.84 C100.00 L20
16:34:57.189 : echo:Retract: S=Length (mm) F:Speed (mm/m) Z: ZLift (mm)
16:34:57.189 : echo:  M207 S3.00 F2700.00 Z0.00
16:34:57.189 : echo:Recover: S=Extra length (mm) F:Speed (mm/m)
16:34:57.193 : echo:  M208 S0.00 F480.00
16:34:57.197 : echo:Auto-Retract: S=0 to disable, 1 to interpret extrude-only moves as retracts or recoveries
16:34:57.197 : echo:  M209 S0
16:34:57.197 : echo:Filament settings: Disabled
16:34:57.198 : echo:  M200 D1.75
16:34:57.198 : echo:  M200 D0
16:34:57.201 : echo:Z-Probe Offset (mm):
16:34:57.202 : echo:  M851 Z0.75
16:34:57.202 : current_position=(0.00, 0.00, 0.00) : sync_plan_position_delta
16:34:57.309 : N1 M110*34
16:34:57.309 : N2 M115*36
16:34:57.309 : N4 M114*35
16:34:57.336 : N5 M111 S7*99
16:34:57.339 : N6 T0*60
16:34:57.339 : N7 M20*22
16:34:57.339 : N8 M80*19
16:35:00.639 : N10 M20*32
16:35:00.640 : echo:SD card ok
16:35:00.671 : N11 M20*33
16:35:00.675 : echo:SD card ok
16:35:00.704 : FIRMWARE_NAME:Marlin 1.1.0-RCBugFix (Github) SOURCE_CODE_URL:https://github.com/MarlinFirmware/Marlin PROTOCOL_VERSION:1.0 MACHINE_TYPE:Micromake EXTRUDER_COUNT:1 UUID:cede2a2f-41a2-4748-9b12-c55c62f367ff EMERGENCY_CODES:M108,M112,M410
16:35:00.704 : N12 M220 S100*82
16:35:00.712 : X:0.00 Y:0.00 Z:0.00 E:0.00 Count X: 39087 Y:39087 Z:39087
16:35:00.712 : N13 M221 S100*82
16:35:00.712 : echo:DEBUG:ECHO,INFO,ERRORS
16:35:00.712 : N14 M111 S7*83
16:35:00.712 : echo:N6 T0*60
16:35:00.712 : echo:Active Extruder: 0
16:35:00.712 : echo:N7 M20*22
16:35:00.713 : N15 T0*14
16:35:00.715 : Begin file list
16:35:00.720 : End file list
16:35:00.720 : echo:N8 M80*19
16:35:00.725 : echo:N10 M20*32
16:35:00.725 : Begin file list
16:35:00.733 : End file list
16:35:00.734 : echo:N11 M20*33
16:35:00.734 : Begin file list
16:35:00.741 : End file list
16:35:00.741 : echo:N12 M220 S100*82
16:35:00.745 : echo:N13 M221 S100*82
16:35:00.745 : echo:N14 M111 S7*83
16:35:00.745 : echo:DEBUG:ECHO,INFO,ERRORS
16:35:00.745 : echo:N15 T0*14
16:35:00.748 : echo:Active Extruder: 0
16:35:05.659 : N18 M502*29
16:35:05.664 : echo:N18 M502*29
16:35:05.664 : echo:Hardcoded Default Settings Loaded
16:35:07.810 : N19 M500*30
16:35:07.813 : echo:N19 M500*30
16:35:08.928 : echo:Settings Stored (427 bytes)
16:35:20.301 : N25 M111 S32*103
16:35:20.306 : echo:N25 M111 S32*103
16:35:20.306 : echo:DEBUG:LEVELING
16:35:23.174 : N27 G28*38
16:35:23.177 : >>> gcode_G28
16:35:23.177 : reset_bed_level
16:35:23.182 : current_position=(0.00, 0.00, 0.00) : setup_for_endstop_or_probe_move
16:35:23.182 : > endstops.enable(true)
16:35:23.185 : current_position=(0.00, 0.00, 0.00) : sync_plan_position
16:35:24.779 : >>> homeaxis(0)
16:35:24.783 : current_position=(0.00, 0.00, 0.00) : sync_plan_position
16:35:25.159 : current_position=(0.00, 0.00, 0.00) : sync_plan_position
16:35:25.746 : current_position=(10.00, 0.00, 0.00) : > TRIGGER ENDSTOP
16:35:25.746 : >>> set_axis_is_at_home(0)
16:35:25.746 : For X axis:
16:35:25.746 : home_offset = 0.00
16:35:25.750 : position_shift = 0.00
16:35:25.750 : sw_endstop_min = -75.00
16:35:25.750 : sw_endstop_max = 75.00
16:35:25.750 : > home_offset[X] = 0.00
16:35:25.754 : current_position=(0.00, 0.00, 0.00) :
16:35:25.754 : <<< set_axis_is_at_home(0)
16:35:25.754 : current_position=(0.00, 0.00, 0.00) : sync_plan_position_delta
16:35:25.758 : current_position=(0.00, 0.00, 0.00) : > AFTER set_axis_is_at_home
16:35:25.758 : <<< homeaxis(0)
16:35:25.762 : >>> homeaxis(1)
16:35:25.762 : current_position=(0.00, 0.00, 0.00) : sync_plan_position
16:35:25.868 : current_position=(0.00, 0.00, 0.00) : sync_plan_position
16:35:26.450 : current_position=(0.00, 10.00, 0.00) : > TRIGGER ENDSTOP
16:35:26.454 : >>> set_axis_is_at_home(1)
16:35:26.454 : For Y axis:
16:35:26.454 : home_offset = 0.00
16:35:26.454 : position_shift = 0.00
16:35:26.454 : sw_endstop_min = -75.00
16:35:26.458 : sw_endstop_max = 75.00
16:35:26.458 : > home_offset[Y] = 0.00
16:35:26.458 : current_position=(0.00, 0.00, 0.00) :
16:35:26.462 : <<< set_axis_is_at_home(1)
16:35:26.462 : current_position=(0.00, 0.00, 0.00) : sync_plan_position_delta
16:35:26.466 : current_position=(0.00, 0.00, 0.00) : > AFTER set_axis_is_at_home
16:35:26.466 : <<< homeaxis(1)
16:35:26.466 : >>> homeaxis(2)
16:35:26.470 : current_position=(0.00, 0.00, 0.00) : sync_plan_position
16:35:26.470 : current_position=(0.00, 0.00, 0.00) : sync_plan_position
16:35:27.052 : current_position=(0.00, 0.00, 10.00) : > TRIGGER ENDSTOP
16:35:27.052 : >>> set_axis_is_at_home(2)
16:35:27.056 : For Z axis:
16:35:27.056 : home_offset = 0.00
16:35:27.056 : position_shift = 0.00
16:35:27.056 : sw_endstop_min = 0.00
16:35:27.056 : sw_endstop_max = 338.00
16:35:27.060 : > home_offset[Z] = 0.00
16:35:27.060 : current_position=(0.00, 0.00, 338.00) :
16:35:27.060 : <<< set_axis_is_at_home(2)
16:35:27.064 : current_position=(0.00, 0.00, 338.00) : sync_plan_position_delta
16:35:27.064 : current_position=(0.00, 0.00, 338.00) : > AFTER set_axis_is_at_home
16:35:27.068 : <<< homeaxis(2)
16:35:27.068 : current_position=(0.00, 0.00, 338.00) : sync_plan_position_delta
16:35:27.072 : current_position=(0.00, 0.00, 338.00) : (DELTA)
16:35:27.072 : > endstops.not_homing()
16:35:27.073 : >>> do_blocking_move_to(0.00, 0.00, 317.06)
16:35:27.077 : destination=(0.00, 0.00, 317.06) : set_destination_to_current
16:35:27.081 : current_position=(0.00, 0.00, 317.06) : xy move
16:35:27.081 : <<< do_blocking_move_to
16:35:27.081 : current_position=(0.00, 0.00, 317.06) : clean_up_after_endstop_or_probe_move
16:35:27.085 : <<< gcode_G28
16:35:27.085 : X:0.00 Y:0.00 Z:317.06 E:0.00 Count X: 106687 Y:106687 Z:106687
16:35:29.607 : N30 G29*33
16:35:29.612 : >>> gcode_G29
16:35:29.612 : current_position=(0.00, 0.00, 317.06) :
16:35:29.612 : G29 Auto Bed Leveling
16:35:29.612 : reset_bed_level
16:35:29.616 : current_position=(0.00, 0.00, 317.06) : setup_for_endstop_or_probe_move
16:35:29.620 : current_position=(0.00, 0.00, 317.06) : set_probe_deployed
16:35:29.620 : deploy: 1
16:35:29.620 : do_probe_raise(50.00)
16:35:29.624 : >>> do_blocking_move_to(0.00, 0.00, 317.06)
16:35:29.624 : destination=(0.00, 0.00, 317.06) : set_destination_to_current
16:35:29.624 : current_position=(0.00, 0.00, 317.06) : xy move
16:35:29.628 : <<< do_blocking_move_to
16:35:29.628 : >>> probe_pt(30.00, -34.00, 1)
16:35:29.632 : current_position=(0.00, 0.00, 317.06) :
16:35:29.632 : do_probe_raise(5.00)
16:35:29.632 : > do_blocking_move_to_xy(30.00, -34.00)
16:35:29.633 : >>> do_blocking_move_to(30.00, -34.00, 317.06)
16:35:29.636 : destination=(0.00, 0.00, 317.06) : set_destination_to_current
16:35:30.840 : current_position=(30.00, -34.00, 317.06) : xy move
16:35:30.840 : <<< do_blocking_move_to
16:35:31.001 : > current_position=(30.00, -34.00, 317.06) : set_probe_deployed
16:35:31.001 : deploy: 1
16:35:31.001 : >>> do_blocking_move_to(30.00, -34.00, -348.00)
16:35:31.004 : destination=(30.00, -34.00, -348.00) : set_destination_to_current
16:35:42.252 : current_position=(30.00, -34.00, 0.00) : xy move
16:35:42.253 : destination=(30.00, -34.00, -348.00) : prepare_move_to_destination_raw
16:35:42.256 : current_position=(30.00, -34.00, -348.00) : z lower move
16:35:42.256 : <<< do_blocking_move_to
16:35:47.920 : current_position=(30.00, -34.00, -1.28) : sync_plan_position_delta
16:35:47.920 : >>> do_blocking_move_to(30.00, -34.00, 3.72)
16:35:47.924 : destination=(30.00, -34.00, 3.72) : set_destination_to_current
16:35:47.924 : current_position=(30.00, -34.00, 3.72) : xy move
16:35:47.924 : <<< do_blocking_move_to
16:35:47.928 : >>> do_blocking_move_to(30.00, -34.00, -6.28)
16:35:47.928 : destination=(30.00, -34.00, -6.28) : set_destination_to_current
16:35:47.965 : current_position=(30.00, -34.00, 0.00) : xy move
16:35:47.965 : destination=(30.00, -34.00, -6.28) : prepare_move_to_destination_raw
16:35:47.969 : current_position=(30.00, -34.00, -6.28) : z lower move
16:35:47.972 : <<< do_blocking_move_to
16:35:48.350 : current_position=(30.00, -34.00, -1.13) : sync_plan_position_delta
16:35:48.350 : current_position=(30.00, -34.00, -1.13) : run_z_probe
16:35:48.350 : > do_probe_raise
16:35:48.354 : do_probe_raise(5.00)
16:35:48.354 : >>> do_blocking_move_to(30.00, -34.00, 5.00)
16:35:48.358 : destination=(30.00, -34.00, 5.00) : set_destination_to_current
16:35:48.358 : current_position=(30.00, -34.00, 5.00) : xy move
16:35:48.358 : <<< do_blocking_move_to
16:35:48.358 : <<< probe_pt
16:35:48.362 : >>> probe_pt(14.00, -34.00, 1)
16:35:48.362 : current_position=(30.00, -34.00, 5.00) :
16:35:48.362 : do_probe_raise(5.00)
16:35:48.366 : > do_blocking_move_to_xy(14.00, -34.00)
16:35:48.366 : >>> do_blocking_move_to(14.00, -34.00, 5.00)
16:35:48.370 : destination=(30.00, -34.00, 5.00) : set_destination_to_current
16:35:48.698 : current_position=(14.00, -34.00, 5.00) : xy move
16:35:48.699 : <<< do_blocking_move_to
16:35:48.805 : > current_position=(14.00, -34.00, 5.00) : set_probe_deployed
16:35:48.805 : deploy: 1
16:35:48.809 : >>> do_blocking_move_to(14.00, -34.00, -348.00)
16:35:48.809 : destination=(14.00, -34.00, -348.00) : set_destination_to_current
16:35:54.682 : current_position=(14.00, -34.00, 0.00) : xy move
16:35:54.686 : destination=(14.00, -34.00, -348.00) : prepare_move_to_destination_raw
16:35:54.699 : current_position=(14.00, -34.00, -348.00) : z lower move
16:35:54.699 : <<< do_blocking_move_to
16:36:00.441 : current_position=(14.01, -34.00, -1.29) : sync_plan_position_delta
16:36:00.441 : >>> do_blocking_move_to(14.01, -34.00, 3.71)
16:36:00.445 : destination=(14.01, -34.00, 3.71) : set_destination_to_current
16:36:00.445 : current_position=(14.01, -34.00, 3.71) : xy move
16:36:00.449 : <<< do_blocking_move_to
16:36:00.449 : >>> do_blocking_move_to(14.01, -34.00, -6.29)
16:36:00.449 : destination=(14.01, -34.00, -6.29) : set_destination_to_current
16:36:00.486 : current_position=(14.01, -34.00, 0.00) : xy move
16:36:00.486 : destination=(14.01, -34.00, -6.29) : prepare_move_to_destination_raw
16:36:00.490 : current_position=(14.01, -34.00, -6.29) : z lower move
16:36:00.493 : <<< do_blocking_move_to
16:36:00.871 : current_position=(14.01, -34.00, -1.15) : sync_plan_position_delta
16:36:00.871 : current_position=(14.01, -34.00, -1.15) : run_z_probe
16:36:00.875 : > do_probe_raise
16:36:00.875 : do_probe_raise(5.00)
16:36:00.875 : >>> do_blocking_move_to(14.01, -34.00, 5.00)
16:36:00.879 : destination=(14.01, -34.00, 5.00) : set_destination_to_current
16:36:00.879 : current_position=(14.01, -34.00, 5.00) : xy move
16:36:00.883 : <<< do_blocking_move_to
16:36:00.883 : <<< probe_pt
16:36:00.883 : >>> probe_pt(-2.00, -34.00, 1)
16:36:00.887 : current_position=(14.01, -34.00, 5.00) :
16:36:00.887 : do_probe_raise(5.00)
16:36:00.887 : > do_blocking_move_to_xy(-2.00, -34.00)
16:36:00.888 : >>> do_blocking_move_to(-2.00, -34.00, 5.00)
16:36:00.891 : destination=(14.01, -34.00, 5.00) : set_destination_to_current
16:36:01.206 : current_position=(-2.00, -34.00, 5.00) : xy move
16:36:01.206 : <<< do_blocking_move_to
16:36:01.313 : > current_position=(-2.00, -34.00, 5.00) : set_probe_deployed
16:36:01.313 : deploy: 1
16:36:01.313 : >>> do_blocking_move_to(-2.00, -34.00, -348.00)
16:36:01.317 : destination=(-2.00, -34.00, -348.00) : set_destination_to_current
16:36:07.186 : current_position=(-2.00, -34.00, 0.00) : xy move
16:36:07.190 : destination=(-2.00, -34.00, -348.00) : prepare_move_to_destination_raw
16:36:07.210 : current_position=(-2.00, -34.00, -348.00) : z lower move
16:36:07.210 : <<< do_blocking_move_to
16:36:13.097 : current_position=(-2.00, -34.00, -1.32) : sync_plan_position_delta
16:36:13.097 : >>> do_blocking_move_to(-2.00, -34.00, 3.68)
16:36:13.101 : destination=(-2.00, -34.00, 3.68) : set_destination_to_current
16:36:13.101 : current_position=(-2.00, -34.00, 3.68) : xy move
16:36:13.101 : <<< do_blocking_move_to
16:36:13.104 : >>> do_blocking_move_to(-2.00, -34.00, -6.32)
16:36:13.105 : destination=(-2.00, -34.00, -6.32) : set_destination_to_current
16:36:13.141 : current_position=(-2.00, -34.00, 0.00) : xy move
16:36:13.142 : destination=(-2.00, -34.00, -6.32) : prepare_move_to_destination_raw
16:36:13.145 : current_position=(-2.00, -34.00, -6.32) : z lower move
16:36:13.149 : <<< do_blocking_move_to
16:36:13.531 : current_position=(-2.00, -34.00, -1.23) : sync_plan_position_delta
16:36:13.531 : current_position=(-2.00, -34.00, -1.23) : run_z_probe
16:36:13.535 : > do_probe_raise
16:36:13.535 : do_probe_raise(5.00)
16:36:13.535 : >>> do_blocking_move_to(-2.00, -34.00, 5.00)
16:36:13.539 : destination=(-2.00, -34.00, 5.00) : set_destination_to_current
16:36:13.539 : current_position=(-2.00, -34.00, 5.00) : xy move
16:36:13.543 : <<< do_blocking_move_to
16:36:13.543 : <<< probe_pt
16:36:13.544 : >>> probe_pt(-18.00, -34.00, 1)
16:36:13.547 : current_position=(-2.00, -34.00, 5.00) :
16:36:13.547 : do_probe_raise(5.00)
16:36:13.548 : > do_blocking_move_to_xy(-18.00, -34.00)
16:36:13.548 : >>> do_blocking_move_to(-18.00, -34.00, 5.00)
16:36:13.551 : destination=(-2.00, -34.00, 5.00) : set_destination_to_current
16:36:13.867 : current_position=(-18.00, -34.00, 5.00) : xy move
16:36:13.867 : <<< do_blocking_move_to
16:36:13.973 : > current_position=(-18.00, -34.00, 5.00) : set_probe_deployed
16:36:13.977 : deploy: 1
16:36:13.977 : >>> do_blocking_move_to(-18.00, -34.00, -348.00)
16:36:13.981 : destination=(-18.00, -34.00, -348.00) : set_destination_to_current
16:36:19.847 : current_position=(-18.00, -34.00, 0.00) : xy move
16:36:19.847 : destination=(-18.00, -34.00, -348.00) : prepare_move_to_destination_raw
16:36:19.851 : current_position=(-18.00, -34.00, -348.00) : z lower move
16:36:19.851 : <<< do_blocking_move_to
16:36:25.577 : current_position=(-18.00, -34.00, -1.47) : sync_plan_position_delta
16:36:25.577 : >>> do_blocking_move_to(-18.00, -34.00, 3.53)
16:36:25.581 : destination=(-18.00, -34.00, 3.53) : set_destination_to_current
16:36:25.582 : current_position=(-18.00, -34.00, 3.53) : xy move
16:36:25.582 : <<< do_blocking_move_to
16:36:25.585 : >>> do_blocking_move_to(-18.00, -34.00, -6.47)
16:36:25.585 : destination=(-18.00, -34.00, -6.47) : set_destination_to_current
16:36:25.622 : current_position=(-18.00, -34.00, 0.00) : xy move
16:36:25.622 : destination=(-18.00, -34.00, -6.47) : prepare_move_to_destination_raw
16:36:25.625 : current_position=(-18.00, -34.00, -6.47) : z lower move
16:36:25.629 : <<< do_blocking_move_to
16:36:26.020 : current_position=(-18.00, -34.00, -1.34) : sync_plan_position_delta
16:36:26.020 : current_position=(-18.00, -34.00, -1.34) : run_z_probe
16:36:26.020 : > do_probe_raise
16:36:26.023 : do_probe_raise(5.00)
16:36:26.023 : >>> do_blocking_move_to(-18.00, -34.00, 5.00)
16:36:26.027 : destination=(-18.00, -34.00, 5.00) : set_destination_to_current
16:36:26.028 : current_position=(-18.00, -34.00, 5.00) : xy move
16:36:26.028 : <<< do_blocking_move_to
16:36:26.031 : <<< probe_pt
16:36:26.031 : >>> probe_pt(-34.00, -34.00, 1)
16:36:26.031 : current_position=(-18.00, -34.00, 5.00) :
16:36:26.035 : do_probe_raise(5.00)
16:36:26.035 : > do_blocking_move_to_xy(-34.00, -34.00)
16:36:26.035 : >>> do_blocking_move_to(-34.00, -34.00, 5.00)
16:36:26.039 : destination=(-18.00, -34.00, 5.00) : set_destination_to_current
16:36:26.354 : current_position=(-34.00, -34.00, 5.00) : xy move
16:36:26.354 : <<< do_blocking_move_to
16:36:26.482 : > current_position=(-34.00, -34.00, 5.00) : set_probe_deployed
16:36:26.482 : deploy: 1
16:36:26.486 : >>> do_blocking_move_to(-34.00, -34.00, -348.00)
16:36:26.486 : destination=(-34.00, -34.00, -348.00) : set_destination_to_current
16:36:32.289 : current_position=(-34.00, -34.00, 0.00) : xy move
16:36:32.289 : destination=(-34.00, -34.00, -348.00) : prepare_move_to_destination_raw
16:36:32.293 : current_position=(-34.00, -34.00, -348.00) : z lower move
16:36:32.293 : <<< do_blocking_move_to
16:36:37.943 : current_position=(-34.00, -34.00, -1.49) : sync_plan_position_delta
16:36:37.946 : >>> do_blocking_move_to(-34.00, -34.00, 3.51)
16:36:37.947 : destination=(-34.00, -34.00, 3.51) : set_destination_to_current
16:36:37.951 : current_position=(-34.00, -34.00, 3.51) : xy move
16:36:37.951 : <<< do_blocking_move_to
16:36:37.955 : >>> do_blocking_move_to(-34.00, -34.00, -6.49)
16:36:37.955 : destination=(-34.00, -34.00, -6.49) : set_destination_to_current
16:36:37.987 : current_position=(-34.00, -34.00, 0.00) : xy move
16:36:37.991 : destination=(-34.00, -34.00, -6.49) : prepare_move_to_destination_raw
16:36:37.995 : current_position=(-34.00, -34.00, -6.49) : z lower move
16:36:37.995 : <<< do_blocking_move_to
16:36:38.393 : current_position=(-34.00, -34.00, -1.52) : sync_plan_position_delta
16:36:38.397 : current_position=(-34.00, -34.00, -1.52) : run_z_probe
16:36:38.397 : > do_probe_raise
16:36:38.397 : do_probe_raise(5.00)
16:36:38.401 : >>> do_blocking_move_to(-34.00, -34.00, 5.00)
16:36:38.402 : destination=(-34.00, -34.00, 5.00) : set_destination_to_current
16:36:38.406 : current_position=(-34.00, -34.00, 5.00) : xy move
16:36:38.406 : <<< do_blocking_move_to
16:36:38.406 : <<< probe_pt
16:36:38.406 : >>> probe_pt(-34.00, -18.00, 1)
16:36:38.409 : current_position=(-34.00, -34.00, 5.00) :
16:36:38.410 : do_probe_raise(5.00)
16:36:38.413 : > do_blocking_move_to_xy(-34.00, -18.00)
16:36:38.414 : >>> do_blocking_move_to(-34.00, -18.00, 5.00)
16:36:38.417 : destination=(-34.00, -34.00, 5.00) : set_destination_to_current
16:36:38.757 : current_position=(-34.00, -18.00, 5.00) : xy move
16:36:38.757 : <<< do_blocking_move_to
16:36:38.883 : > current_position=(-34.00, -18.00, 5.00) : set_probe_deployed
16:36:38.887 : deploy: 1
16:36:38.887 : >>> do_blocking_move_to(-34.00, -18.00, -348.00)
16:36:38.891 : destination=(-34.00, -18.00, -348.00) : set_destination_to_current
16:36:44.720 : current_position=(-34.00, -18.00, 0.00) : xy move
16:36:44.720 : destination=(-34.00, -18.00, -348.00) : prepare_move_to_destination_raw
16:36:44.724 : current_position=(-34.00, -18.00, -348.00) : z lower move
16:36:44.724 : <<< do_blocking_move_to
16:36:50.401 : current_position=(-33.99, -18.01, -1.49) : sync_plan_position_delta
16:36:50.405 : >>> do_blocking_move_to(-33.99, -18.01, 3.51)
16:36:50.405 : destination=(-33.99, -18.01, 3.51) : set_destination_to_current
16:36:50.409 : current_position=(-33.99, -18.01, 3.51) : xy move
16:36:50.410 : <<< do_blocking_move_to
16:36:50.410 : >>> do_blocking_move_to(-33.99, -18.01, -6.49)
16:36:50.413 : destination=(-33.99, -18.01, -6.49) : set_destination_to_current
16:36:50.446 : current_position=(-33.99, -18.01, 0.00) : xy move
16:36:50.450 : destination=(-33.99, -18.01, -6.49) : prepare_move_to_destination_raw
16:36:50.454 : current_position=(-33.99, -18.01, -6.49) : z lower move
16:36:50.454 : <<< do_blocking_move_to
16:36:50.847 : current_position=(-33.99, -18.01, -1.43) : sync_plan_position_delta
16:36:50.852 : current_position=(-33.99, -18.01, -1.43) : run_z_probe
16:36:50.852 : > do_probe_raise
16:36:50.852 : do_probe_raise(5.00)
16:36:50.855 : >>> do_blocking_move_to(-33.99, -18.01, 5.00)
16:36:50.855 : destination=(-33.99, -18.01, 5.00) : set_destination_to_current
16:36:50.859 : current_position=(-33.99, -18.01, 5.00) : xy move
16:36:50.859 : <<< do_blocking_move_to
16:36:50.859 : <<< probe_pt
16:36:50.859 : >>> probe_pt(-18.00, -18.00, 1)
16:36:50.864 : current_position=(-33.99, -18.01, 5.00) :
16:36:50.864 : do_probe_raise(5.00)
16:36:50.868 : > do_blocking_move_to_xy(-18.00, -18.00)
16:36:50.868 : >>> do_blocking_move_to(-18.00, -18.00, 5.00)
16:36:50.871 : destination=(-33.99, -18.01, 5.00) : set_destination_to_current
16:36:51.208 : current_position=(-18.00, -18.00, 5.00) : xy move
16:36:51.208 : <<< do_blocking_move_to
16:36:51.323 : > current_position=(-18.00, -18.00, 5.00) : set_probe_deployed
16:36:51.323 : deploy: 1
16:36:51.327 : >>> do_blocking_move_to(-18.00, -18.00, -348.00)
16:36:51.327 : destination=(-18.00, -18.00, -348.00) : set_destination_to_current
16:36:57.204 : current_position=(-18.00, -18.00, 0.00) : xy move
16:36:57.207 : destination=(-18.00, -18.00, -348.00) : prepare_move_to_destination_raw
16:36:57.220 : current_position=(-18.00, -18.00, -348.00) : z lower move
16:36:57.224 : <<< do_blocking_move_to
16:37:02.971 : current_position=(-18.01, -17.99, -1.33) : sync_plan_position_delta
16:37:02.975 : >>> do_blocking_move_to(-18.01, -17.99, 3.67)
16:37:02.975 : destination=(-18.01, -17.99, 3.67) : set_destination_to_current
16:37:02.979 : current_position=(-18.01, -17.99, 3.67) : xy move
16:37:02.979 : <<< do_blocking_move_to
16:37:02.983 : >>> do_blocking_move_to(-18.01, -17.99, -6.33)
16:37:02.983 : destination=(-18.01, -17.99, -6.33) : set_destination_to_current
16:37:03.016 : current_position=(-18.01, -17.99, 0.00) : xy move
16:37:03.021 : destination=(-18.01, -17.99, -6.33) : prepare_move_to_destination_raw
16:37:03.024 : current_position=(-18.01, -17.99, -6.33) : z lower move
16:37:03.024 : <<< do_blocking_move_to
16:37:03.409 : current_position=(-18.01, -17.99, -1.26) : sync_plan_position_delta
16:37:03.410 : current_position=(-18.01, -17.99, -1.26) : run_z_probe
16:37:03.410 : > do_probe_raise
16:37:03.413 : do_probe_raise(5.00)
16:37:03.414 : >>> do_blocking_move_to(-18.01, -17.99, 5.00)
16:37:03.418 : destination=(-18.01, -17.99, 5.00) : set_destination_to_current
16:37:03.418 : current_position=(-18.01, -17.99, 5.00) : xy move
16:37:03.418 : <<< do_blocking_move_to
16:37:03.422 : <<< probe_pt
16:37:03.422 : >>> probe_pt(-2.00, -18.00, 1)
16:37:03.422 : current_position=(-18.01, -17.99, 5.00) :
16:37:03.426 : do_probe_raise(5.00)
16:37:03.426 : > do_blocking_move_to_xy(-2.00, -18.00)
16:37:03.426 : >>> do_blocking_move_to(-2.00, -18.00, 5.00)
16:37:03.430 : destination=(-18.01, -17.99, 5.00) : set_destination_to_current
16:37:03.753 : current_position=(-2.00, -18.00, 5.00) : xy move
16:37:03.754 : <<< do_blocking_move_to
16:37:03.856 : > current_position=(-2.00, -18.00, 5.00) : set_probe_deployed
16:37:03.860 : deploy: 1
16:37:03.860 : >>> do_blocking_move_to(-2.00, -18.00, -348.00)
16:37:03.863 : destination=(-2.00, -18.00, -348.00) : set_destination_to_current
16:37:09.749 : current_position=(-2.00, -18.00, 0.00) : xy move
16:37:09.753 : destination=(-2.00, -18.00, -348.00) : prepare_move_to_destination_raw
16:37:09.762 : current_position=(-2.00, -18.00, -348.00) : z lower move
16:37:09.765 : <<< do_blocking_move_to
16:37:15.713 : current_position=(-1.99, -18.01, -1.27) : sync_plan_position_delta
16:37:15.713 : >>> do_blocking_move_to(-1.99, -18.01, 3.73)
16:37:15.717 : destination=(-1.99, -18.01, 3.73) : set_destination_to_current
16:37:15.721 : current_position=(-1.99, -18.01, 3.73) : xy move
16:37:15.721 : <<< do_blocking_move_to
16:37:15.722 : >>> do_blocking_move_to(-1.99, -18.01, -6.27)
16:37:15.725 : destination=(-1.99, -18.01, -6.27) : set_destination_to_current
16:37:15.758 : current_position=(-1.99, -18.01, 0.00) : xy move
16:37:15.758 : destination=(-1.99, -18.01, -6.27) : prepare_move_to_destination_raw
16:37:15.766 : current_position=(-1.99, -18.01, -6.27) : z lower move
16:37:15.766 : <<< do_blocking_move_to
16:37:16.147 : current_position=(-1.99, -18.01, -1.18) : sync_plan_position_delta
16:37:16.147 : current_position=(-1.99, -18.01, -1.18) : run_z_probe
16:37:16.147 : > do_probe_raise
16:37:16.151 : do_probe_raise(5.00)
16:37:16.151 : >>> do_blocking_move_to(-1.99, -18.01, 5.00)
16:37:16.155 : destination=(-1.99, -18.01, 5.00) : set_destination_to_current
16:37:16.155 : current_position=(-1.99, -18.01, 5.00) : xy move
16:37:16.155 : <<< do_blocking_move_to
16:37:16.156 : <<< probe_pt
16:37:16.159 : >>> probe_pt(14.00, -18.00, 1)
16:37:16.159 : current_position=(-1.99, -18.01, 5.00) :
16:37:16.160 : do_probe_raise(5.00)
16:37:16.163 : > do_blocking_move_to_xy(14.00, -18.00)
16:37:16.164 : >>> do_blocking_move_to(14.00, -18.00, 5.00)
16:37:16.167 : destination=(-1.99, -18.01, 5.00) : set_destination_to_current
16:37:16.479 : current_position=(14.00, -18.00, 5.00) : xy move
16:37:16.479 : <<< do_blocking_move_to
16:37:16.590 : > current_position=(14.00, -18.00, 5.00) : set_probe_deployed
16:37:16.590 : deploy: 1
16:37:16.590 : >>> do_blocking_move_to(14.00, -18.00, -348.00)
16:37:16.594 : destination=(14.00, -18.00, -348.00) : set_destination_to_current
16:37:22.463 : current_position=(14.00, -18.00, 0.00) : xy move
16:37:22.467 : destination=(14.00, -18.00, -348.00) : prepare_move_to_destination_raw
16:37:22.487 : current_position=(14.00, -18.00, -348.00) : z lower move
16:37:22.487 : <<< do_blocking_move_to
16:37:28.274 : current_position=(14.00, -18.00, -1.22) : sync_plan_position_delta
16:37:28.274 : >>> do_blocking_move_to(14.00, -18.00, 3.78)
16:37:28.278 : destination=(14.00, -18.00, 3.78) : set_destination_to_current
16:37:28.278 : current_position=(14.00, -18.00, 3.78) : xy move
16:37:28.283 : <<< do_blocking_move_to
16:37:28.283 : >>> do_blocking_move_to(14.00, -18.00, -6.22)
16:37:28.286 : destination=(14.00, -18.00, -6.22) : set_destination_to_current
16:37:28.315 : current_position=(14.00, -18.00, 0.00) : xy move
16:37:28.320 : destination=(14.00, -18.00, -6.22) : prepare_move_to_destination_raw
16:37:28.324 : current_position=(14.00, -18.00, -6.22) : z lower move
16:37:28.324 : <<< do_blocking_move_to
16:37:28.697 : current_position=(14.00, -18.00, -1.10) : sync_plan_position_delta
16:37:28.701 : current_position=(14.00, -18.00, -1.10) : run_z_probe
16:37:28.701 : > do_probe_raise
16:37:28.701 : do_probe_raise(5.00)
16:37:28.705 : >>> do_blocking_move_to(14.00, -18.00, 5.00)
16:37:28.705 : destination=(14.00, -18.00, 5.00) : set_destination_to_current
16:37:28.709 : current_position=(14.00, -18.00, 5.00) : xy move
16:37:28.709 : <<< do_blocking_move_to
16:37:28.709 : <<< probe_pt
16:37:28.709 : >>> probe_pt(30.00, -18.00, 1)
16:37:28.713 : current_position=(14.00, -18.00, 5.00) :
16:37:28.713 : do_probe_raise(5.00)
16:37:28.713 : > do_blocking_move_to_xy(30.00, -18.00)
16:37:28.717 : >>> do_blocking_move_to(30.00, -18.00, 5.00)
16:37:28.717 : destination=(14.00, -18.00, 5.00) : set_destination_to_current
16:37:29.085 : current_position=(30.00, -18.00, 5.00) : xy move
16:37:29.089 : <<< do_blocking_move_to
16:37:29.151 : > current_position=(30.00, -18.00, 5.00) : set_probe_deployed
16:37:29.151 : deploy: 1
16:37:29.151 : >>> do_blocking_move_to(30.00, -18.00, -348.00)
16:37:29.155 : destination=(30.00, -18.00, -348.00) : set_destination_to_current
16:37:34.984 : current_position=(30.00, -18.00, 0.00) : xy move
16:37:34.988 : destination=(30.00, -18.00, -348.00) : prepare_move_to_destination_raw
16:37:34.989 : current_position=(30.00, -18.00, -348.00) : z lower move
16:37:34.992 : <<< do_blocking_move_to
16:37:40.681 : current_position=(29.99, -18.01, -1.15) : sync_plan_position_delta
16:37:40.681 : >>> do_blocking_move_to(29.99, -18.01, 3.85)
16:37:40.685 : destination=(29.99, -18.01, 3.85) : set_destination_to_current
16:37:40.685 : current_position=(29.99, -18.01, 3.85) : xy move
16:37:40.685 : <<< do_blocking_move_to
16:37:40.689 : >>> do_blocking_move_to(29.99, -18.01, -6.15)
16:37:40.689 : destination=(29.99, -18.01, -6.15) : set_destination_to_current
16:37:40.722 : current_position=(29.99, -18.01, 0.00) : xy move
16:37:40.726 : destination=(29.99, -18.01, -6.15) : prepare_move_to_destination_raw
16:37:40.729 : current_position=(29.99, -18.01, -6.15) : z lower move
16:37:40.729 : <<< do_blocking_move_to
16:37:41.099 : current_position=(29.99, -18.01, -1.07) : sync_plan_position_delta
16:37:41.103 : current_position=(29.99, -18.01, -1.07) : run_z_probe
16:37:41.103 : > do_probe_raise
16:37:41.103 : do_probe_raise(5.00)
16:37:41.107 : >>> do_blocking_move_to(29.99, -18.01, 5.00)
16:37:41.107 : destination=(29.99, -18.01, 5.00) : set_destination_to_current
16:37:41.107 : current_position=(29.99, -18.01, 5.00) : xy move
16:37:41.111 : <<< do_blocking_move_to
16:37:41.111 : <<< probe_pt
16:37:41.111 : >>> probe_pt(46.00, -18.00, 1)
16:37:41.115 : current_position=(29.99, -18.01, 5.00) :
16:37:41.115 : do_probe_raise(5.00)
16:37:41.115 : > do_blocking_move_to_xy(46.00, -18.00)
16:37:41.119 : >>> do_blocking_move_to(46.00, -18.00, 5.00)
16:37:41.119 : destination=(29.99, -18.01, 5.00) : set_destination_to_current
16:37:41.433 : current_position=(46.00, -18.00, 5.00) : xy move
16:37:41.434 : <<< do_blocking_move_to
16:37:41.578 : > current_position=(46.00, -18.00, 5.00) : set_probe_deployed
16:37:41.582 : deploy: 1
16:37:41.582 : >>> do_blocking_move_to(46.00, -18.00, -348.00)
16:37:41.586 : destination=(46.00, -18.00, -348.00) : set_destination_to_current
16:37:47.357 : current_position=(46.00, -18.00, 0.00) : xy move
16:37:47.361 : destination=(46.00, -18.00, -348.00) : prepare_move_to_destination_raw
16:37:47.365 : current_position=(46.00, -18.00, -348.00) : z lower move
16:37:47.365 : <<< do_blocking_move_to
16:37:52.993 : current_position=(46.00, -18.00, -1.12) : sync_plan_position_delta
16:37:52.997 : >>> do_blocking_move_to(46.00, -18.00, 3.88)
16:37:52.998 : destination=(46.00, -18.00, 3.88) : set_destination_to_current
16:37:53.001 : current_position=(46.00, -18.00, 3.88) : xy move
16:37:53.001 : <<< do_blocking_move_to
16:37:53.005 : >>> do_blocking_move_to(46.00, -18.00, -6.12)
16:37:53.005 : destination=(46.00, -18.00, -6.12) : set_destination_to_current
16:37:53.033 : current_position=(46.00, -18.00, 0.00) : xy move
16:37:53.038 : destination=(46.00, -18.00, -6.12) : prepare_move_to_destination_raw
16:37:53.042 : current_position=(46.00, -18.00, -6.12) : z lower move
16:37:53.042 : <<< do_blocking_move_to
16:37:53.423 : current_position=(46.00, -18.00, -1.12) : sync_plan_position_delta
16:37:53.423 : current_position=(46.00, -18.00, -1.12) : run_z_probe
16:37:53.423 : > do_probe_raise
16:37:53.427 : do_probe_raise(5.00)
16:37:53.427 : >>> do_blocking_move_to(46.00, -18.00, 5.00)
16:37:53.456 : destination=(46.00, -18.00, 5.00) : set_destination_to_current
16:37:53.456 : current_position=(46.00, -18.00, 5.00) : xy move
16:37:53.456 : <<< do_blocking_move_to
16:37:53.457 : <<< probe_p2.00)
16:37:53.458 : >>> do_blocking_move_to(46.00, -2.00, 5.00)
16:37:53.458 : destination=(46.00, -18.00, 5.00) : set_destination_to_current
16:37:53.458 : _to_xy(46.00, -2.00)
16:37:53.458 : >>> do_blocking_move_to(46.00, -2.00, 5.00)
16:37:53.458 : destination=(46.00, -18.00, 5.00) : set_destination_to_current
16:37:53.770 : current_position=(46.00, -2.00, 5.00) : xy move
16:37:53.771 : <<< do_blocking_move_to
16:37:53.877 : > current_position=(46.00, -2.00, 5.00) : set_probe_deployed
16:37:53.877 : deploy: 1
16:37:53.877 : >>> do_blocking_move_to(46.00, -2.00, -348.00)
16:37:53.881 : destination=(46.00, -2.00, -348.00) : set_destination_to_current
16:37:59.697 : current_position=(46.00, -2.00, 0.00) : xy move
16:37:59.702 : destination=(46.00, -2.00, -348.00) : prepare_move_to_destination_raw
16:37:59.702 : current_position=(46.00, -2.00, -348.00) : z lower move
16:37:59.705 : <<< do_blocking_move_to
16:38:05.383 : current_position=(46.01, -2.00, -1.03) : sync_plan_position_delta
16:38:05.383 : >>> do_blocking_move_to(46.01, -2.00, 3.97)
16:38:05.387 : destination=(46.01, -2.00, 3.97) : set_destination_to_current
16:38:05.387 : current_position=(46.01, -2.00, 3.97) : xy move
16:38:05.391 : <<< do_blocking_move_to
16:38:05.391 : >>> do_blocking_move_to(46.01, -2.00, -6.03)
16:38:05.391 : destination=(46.01, -2.00, -6.03) : set_destination_to_current
16:38:05.424 : current_position=(46.01, -2.00, 0.00) : xy move
16:38:05.428 : destination=(46.01, -2.00, -6.03) : prepare_move_to_destination_raw
16:38:05.431 : current_position=(46.01, -2.00, -6.03) : z lower move
16:38:05.432 : <<< do_blocking_move_to
16:38:05.796 : current_position=(46.01, -2.00, -0.97) : sync_plan_position_delta
16:38:05.796 : current_position=(46.01, -2.00, -0.97) : run_z_probe
16:38:05.800 : > do_probe_raise
16:38:05.800 : do_probe_raise(5.00)
16:38:05.800 : >>> do_blocking_move_to(46.01, -2.00, 5.00)
16:38:05.804 : destination=(46.01, -2.00, 5.00) : set_destination_to_current
16:38:05.804 : current_position=(46.01, -2.00, 5.00) : xy move
16:38:05.805 : <<< do_blocking_move_to
16:38:05.808 : <<< probe_pt
16:38:05.808 : >>> probe_pt(30.00, -2.00, 1)
16:38:05.808 : current_position=(46.01, -2.00, 5.00) :
16:38:05.812 : do_probe_raise(5.00)
16:38:05.812 : > do_blocking_move_to_xy(30.00, -2.00)
16:38:05.812 : >>> do_blocking_move_to(30.00, -2.00, 5.00)
16:38:05.816 : destination=(46.01, -2.00, 5.00) : set_destination_to_current
16:38:06.144 : current_position=(30.00, -2.00, 5.00) : xy move
16:38:06.144 : <<< do_blocking_move_to
16:38:06.283 : > current_position=(30.00, -2.00, 5.00) : set_probe_deployed
16:38:06.283 : deploy: 1
16:38:06.283 : >>> do_blocking_move_to(30.00, -2.00, -348.00)
16:38:06.287 : destination=(30.00, -2.00, -348.00) : set_destination_to_current
16:38:12.156 : current_position=(30.00, -2.00, 0.00) : xy move
16:38:12.160 : destination=(30.00, -2.00, -348.00) : prepare_move_to_destination_raw
16:38:12.165 : current_position=(30.00, -2.00, -348.00) : z lower move
16:38:12.165 : <<< do_blocking_move_to
16:38:17.907 : current_position=(30.00, -2.00, -1.05) : sync_plan_position_delta
16:38:17.907 : >>> do_blocking_move_to(30.00, -2.00, 3.95)
16:38:17.911 : destination=(30.00, -2.00, 3.95) : set_destination_to_current
16:38:17.912 : current_position=(30.00, -2.00, 3.95) : xy move
16:38:17.915 : <<< do_blocking_move_to
16:38:17.916 : >>> do_blocking_move_to(30.00, -2.00, -6.05)
16:38:17.919 : destination=(30.00, -2.00, -6.05) : set_destination_to_current
16:38:17.948 : current_position=(30.00, -2.00, 0.00) : xy move
16:38:17.952 : destination=(30.00, -2.00, -6.05) : prepare_move_to_destination_raw
16:38:17.956 : current_position=(30.00, -2.00, -6.05) : z lower move
16:38:17.956 : <<< do_blocking_move_to
16:38:18.321 : current_position=(30.00, -2.00, -0.95) : sync_plan_position_delta
16:38:18.321 : current_position=(30.00, -2.00, -0.95) : run_z_probe
16:38:18.321 : > do_probe_raise
16:38:18.325 : do_probe_raise(5.00)
16:38:18.325 : >>> do_blocking_move_to(30.00, -2.00, 5.00)
16:38:18.329 : destination=(30.00, -2.00, 5.00) : set_destination_to_current
16:38:18.329 : current_position=(30.00, -2.00, 5.00) : xy move
16:38:18.329 : <<< do_blocking_move_to
16:38:18.329 : <<< probe_pt
16:38:18.333 : >>> probe_pt(14.00, -2.00, 1)
16:38:18.333 : current_position=(30.00, -2.00, 5.00) :
16:38:18.333 : do_probe_raise(5.00)
16:38:18.337 : > do_blocking_move_to_xy(14.00, -2.00)
16:38:18.337 : >>> do_blocking_move_to(14.00, -2.00, 5.00)
16:38:18.341 : destination=(30.00, -2.00, 5.00) : set_destination_to_current
16:38:18.660 : current_position=(14.00, -2.00, 5.00) : xy move
16:38:18.661 : <<< do_blocking_move_to
16:38:18.772 : > current_position=(14.00, -2.00, 5.00) : set_probe_deployed
16:38:18.776 : deploy: 1
16:38:18.776 : >>> do_blocking_move_to(14.00, -2.00, -348.00)
16:38:18.780 : destination=(14.00, -2.00, -348.00) : set_destination_to_current
16:38:24.649 : current_position=(14.00, -2.00, 0.00) : xy move
16:38:24.652 : destination=(14.00, -2.00, -348.00) : prepare_move_to_destination_raw
16:38:24.674 : current_position=(14.00, -2.00, -348.00) : z lower move
16:38:24.674 : <<< do_blocking_move_to
16:38:30.559 : current_position=(14.00, -1.99, -1.14) : sync_plan_position_delta
16:38:30.563 : >>> do_blocking_move_to(14.00, -1.99, 3.86)
16:38:30.563 : destination=(14.00, -1.99, 3.86) : set_destination_to_current
16:38:30.567 : current_position=(14.00, -1.99, 3.86) : xy move
16:38:30.568 : <<< do_blocking_move_to
16:38:30.571 : >>> do_blocking_move_to(14.00, -1.99, -6.14)
16:38:30.571 : destination=(14.00, -1.99, -6.14) : set_destination_to_current
16:38:30.600 : current_position=(14.00, -1.99, 0.00) : xy move
16:38:30.604 : destination=(14.00, -1.99, -6.14) : prepare_move_to_destination_raw
16:38:30.609 : current_position=(14.00, -1.99, -6.14) : z lower move
16:38:30.609 : <<< do_blocking_move_to
16:38:30.981 : current_position=(14.00, -1.99, -1.06) : sync_plan_position_delta
16:38:30.981 : current_position=(14.00, -1.99, -1.06) : run_z_probe
16:38:30.985 : > do_probe_raise
16:38:30.985 : do_probe_raise(5.00)
16:38:30.985 : >>> do_blocking_move_to(14.00, -1.99, 5.00)
16:38:30.989 : destination=(14.00, -1.99, 5.00) : set_destination_to_current
16:38:30.989 : current_position=(14.00, -1.99, 5.00) : xy move
16:38:30.994 : <<< do_blocking_move_to
16:38:30.994 : <<< probe_pt
16:38:30.994 : >>> probe_pt(-2.00, -2.00, 1)
16:38:30.997 : current_position=(14.00, -1.99, 5.00) :
16:38:30.997 : do_probe_raise(5.00)
16:38:30.997 : > do_blocking_move_to_xy(-2.00, -2.00)
16:38:30.998 : >>> do_blocking_move_to(-2.00, -2.00, 5.00)
16:38:31.001 : destination=(14.00, -1.99, 5.00) : set_destination_to_current
16:38:31.321 : current_position=(-2.00, -2.00, 5.00) : xy move
16:38:31.324 : <<< do_blocking_move_to
16:38:31.424 : > current_position=(-2.00, -2.00, 5.00) : set_probe_deployed
16:38:31.425 : deploy: 1
16:38:31.425 : >>> do_blocking_move_to(-2.00, -2.00, -348.00)
16:38:31.428 : destination=(-2.00, -2.00, -348.00) : set_destination_to_current
16:38:37.293 : current_position=(-2.00, -2.00, 0.00) : xy move
16:38:37.297 : destination=(-2.00, -2.00, -348.00) : prepare_move_to_destination_raw
16:38:37.317 : current_position=(-2.00, -2.00, -348.00) : z lower move
16:38:37.317 : <<< do_blocking_move_to
16:38:43.362 : current_position=(-2.00, -2.00, -1.22) : sync_plan_position_delta
16:38:43.362 : >>> do_blocking_move_to(-2.00, -2.00, 3.78)
16:38:43.367 : destination=(-2.00, -2.00, 3.78) : set_destination_to_current
16:38:43.367 : current_position=(-2.00, -2.00, 3.78) : xy move
16:38:43.367 : <<< do_blocking_move_to
16:38:43.371 : >>> do_blocking_move_to(-2.00, -2.00, -6.22)
16:38:43.372 : destination=(-2.00, -2.00, -6.22) : set_destination_to_current
16:38:43.404 : current_position=(-2.00, -2.00, 0.00) : xy move
16:38:43.404 : destination=(-2.00, -2.00, -6.22) : prepare_move_to_destination_raw
16:38:43.407 : current_position=(-2.00, -2.00, -6.22) : z lower move
16:38:43.411 : <<< do_blocking_move_to
16:38:43.784 : current_position=(-2.00, -2.00, -1.08) : sync_plan_position_delta
16:38:43.785 : current_position=(-2.00, -2.00, -1.08) : run_z_probe
16:38:43.785 : > do_probe_raise
16:38:43.788 : do_probe_raise(5.00)
16:38:43.789 : >>> do_blocking_move_to(-2.00, -2.00, 5.00)
16:38:43.793 : destination=(-2.00, -2.00, 5.00) : set_destination_to_current
16:38:43.793 : current_position=(-2.00, -2.00, 5.00) : xy move
16:38:43.793 : <<< do_blocking_move_to
16:38:43.797 : <<< probe_pt
16:38:43.797 : >>> probe_pt(-18.00, -2.00, 1)
16:38:43.797 : current_position=(-2.00, -2.00, 5.00) :
16:38:43.801 : do_probe_raise(5.00)
16:38:43.801 : > do_blocking_move_to_xy(-18.00, -2.00)
16:38:43.801 : >>> do_blocking_move_to(-18.00, -2.00, 5.00)
16:38:43.804 : destination=(-2.00, -2.00, 5.00) : set_destination_to_current
16:38:44.116 : current_position=(-18.00, -2.00, 5.00) : xy move
16:38:44.116 : <<< do_blocking_move_to
16:38:44.227 : > current_position=(-18.00, -2.00, 5.00) : set_probe_deployed
16:38:44.227 : deploy: 1
16:38:44.231 : >>> do_blocking_move_to(-18.00, -2.00, -348.00)
16:38:44.231 : destination=(-18.00, -2.00, -348.00) : set_destination_to_current
16:38:50.100 : current_position=(-18.00, -2.00, 0.00) : xy move
16:38:50.104 : destination=(-18.00, -2.00, -348.00) : prepare_move_to_destination_raw
16:38:50.124 : current_position=(-18.00, -2.00, -348.00) : z lower move
16:38:50.124 : <<< do_blocking_move_to
16:38:55.969 : current_position=(-18.00, -2.01, -1.27) : sync_plan_position_delta
16:38:55.969 : >>> do_blocking_move_to(-18.00, -2.01, 3.73)
16:38:55.973 : destination=(-18.00, -2.01, 3.73) : set_destination_to_current
16:38:55.977 : current_position=(-18.00, -2.01, 3.73) : xy move
16:38:55.977 : <<< do_blocking_move_to
16:38:55.977 : >>> do_blocking_move_to(-18.00, -2.01, -6.27)
16:38:55.981 : destination=(-18.00, -2.01, -6.27) : set_destination_to_current
16:38:56.014 : current_position=(-18.00, -2.01, 0.00) : xy move
16:38:56.019 : destination=(-18.00, -2.01, -6.27) : prepare_move_to_destination_raw
16:38:56.023 : current_position=(-18.00, -2.01, -6.27) : z lower move
16:38:56.023 : <<< do_blocking_move_to
16:38:56.400 : current_position=(-18.00, -2.01, -1.17) : sync_plan_position_delta
16:38:56.404 : current_position=(-18.00, -2.01, -1.17) : run_z_probe
16:38:56.404 : > do_probe_raise
16:38:56.404 : do_probe_raise(5.00)
16:38:56.408 : >>> do_blocking_move_to(-18.00, -2.01, 5.00)
16:38:56.408 : destination=(-18.00, -2.01, 5.00) : set_destination_to_current
16:38:56.412 : current_position=(-18.00, -2.01, 5.00) : xy move
16:38:56.412 : <<< do_blocking_move_to
16:38:56.412 : <<< probe_pt
16:38:56.413 : >>> probe_pt(-34.00, -2.00, 1)
16:38:56.416 : current_position=(-18.00, -2.01, 5.00) :
16:38:56.416 : do_probe_raise(5.00)
16:38:56.420 : > do_blocking_move_to_xy(-34.00, -2.00)
16:38:56.420 : >>> do_blocking_move_to(-34.00, -2.00, 5.00)
16:38:56.424 : destination=(-18.00, -2.01, 5.00) : set_destination_to_current
16:38:56.792 : current_position=(-34.00, -2.00, 5.00) : xy move
16:38:56.792 : <<< do_blocking_move_to
16:38:56.867 : > current_position=(-34.00, -2.00, 5.00) : set_probe_deployed
16:38:56.867 : deploy: 1
16:38:56.867 : >>> do_blocking_move_to(-34.00, -2.00, -348.00)
16:38:56.871 : destination=(-34.00, -2.00, -348.00) : set_destination_to_current
16:39:02.736 : current_position=(-34.00, -2.00, 0.00) : xy move
16:39:02.736 : destination=(-34.00, -2.00, -348.00) : prepare_move_to_destination_raw
16:39:02.739 : current_position=(-34.00, -2.00, -348.00) : z lower move
16:39:02.740 : <<< do_blocking_move_to
16:39:08.466 : current_position=(-33.99, -2.00, -1.40) : sync_plan_position_delta
16:39:08.469 : >>> do_blocking_move_to(-33.99, -2.00, 3.60)
16:39:08.470 : destination=(-33.99, -2.00, 3.60) : set_destination_to_current
16:39:08.474 : current_position=(-33.99, -2.00, 3.60) : xy move
16:39:08.474 : <<< do_blocking_move_to
16:39:08.474 : >>> do_blocking_move_to(-33.99, -2.00, -6.40)
16:39:08.478 : destination=(-33.99, -2.00, -6.40) : set_destination_to_current
16:39:08.511 : current_position=(-33.99, -2.00, 0.00) : xy move
16:39:08.515 : destination=(-33.99, -2.00, -6.40) : prepare_move_to_destination_raw
16:39:08.518 : current_position=(-33.99, -2.00, -6.40) : z lower move
16:39:08.519 : <<< do_blocking_move_to
16:39:08.908 : current_position=(-33.99, -2.00, -1.30) : sync_plan_position_delta
16:39:08.908 : current_position=(-33.99, -2.00, -1.30) : run_z_probe
16:39:08.908 : > do_probe_raise
16:39:08.909 : do_probe_raise(5.00)
16:39:08.912 : >>> do_blocking_move_to(-33.99, -2.00, 5.00)
16:39:08.916 : destination=(-33.99, -2.00, 5.00) : set_destination_to_current
16:39:08.916 : current_position=(-33.99, -2.00, 5.00) : xy move
16:39:08.916 : <<< do_blocking_move_to
16:39:08.916 : <<< probe_pt
16:39:08.921 : >>> probe_pt(-34.00, 14.00, 1)
16:39:08.921 : current_position=(-33.99, -2.00, 5.00) :
16:39:08.921 : do_probe_raise(5.00)
16:39:08.925 : > do_blocking_move_to_xy(-34.00, 14.00)
16:39:08.925 : >>> do_blocking_move_to(-34.00, 14.00, 5.00)
16:39:08.929 : destination=(-33.99, -2.00, 5.00) : set_destination_to_current
16:39:09.248 : current_position=(-34.00, 14.00, 5.00) : xy move
16:39:09.248 : <<< do_blocking_move_to
16:39:09.358 : > current_position=(-34.00, 14.00, 5.00) : set_probe_deployed
16:39:09.359 : deploy: 1
16:39:09.359 : >>> do_blocking_move_to(-34.00, 14.00, -348.00)
16:39:09.362 : destination=(-34.00, 14.00, -348.00) : set_destination_to_current
16:39:15.232 : current_position=(-34.00, 14.00, 0.00) : xy move
16:39:15.235 : destination=(-34.00, 14.00, -348.00) : prepare_move_to_destination_raw
16:39:15.252 : current_position=(-34.00, 14.00, -348.00) : z lower move
16:39:15.256 : <<< do_blocking_move_to
16:39:21.105 : current_position=(-34.00, 13.99, -1.29) : sync_plan_position_delta
16:39:21.109 : >>> do_blocking_move_to(-34.00, 13.99, 3.71)
16:39:21.109 : destination=(-34.00, 13.99, 3.71) : set_destination_to_current
16:39:21.114 : current_position=(-34.00, 13.99, 3.71) : xy move
16:39:21.114 : <<< do_blocking_move_to
16:39:21.117 : >>> do_blocking_move_to(-34.00, 13.99, -6.29)
16:39:21.118 : destination=(-34.00, 13.99, -6.29) : set_destination_to_current
16:39:21.150 : current_position=(-34.00, 13.99, 0.00) : xy move
16:39:21.154 : destination=(-34.00, 13.99, -6.29) : prepare_move_to_destination_raw
16:39:21.158 : current_position=(-34.00, 13.99, -6.29) : z lower move
16:39:21.158 : <<< do_blocking_move_to
16:39:21.544 : current_position=(-34.00, 13.99, -1.22) : sync_plan_position_delta
16:39:21.544 : current_position=(-34.00, 13.99, -1.22) : run_z_probe
16:39:21.544 : > do_probe_raise
16:39:21.544 : do_probe_raise(5.00)
16:39:21.548 : >>> do_blocking_move_to(-34.00, 13.99, 5.00)
16:39:21.552 : destination=(-34.00, 13.99, 5.00) : set_destination_to_current
16:39:21.552 : current_position=(-34.00, 13.99, 5.00) : xy move
16:39:21.552 : <<< do_blocking_move_to
16:39:21.552 : <<< probe_pt
16:39:21.556 : >>> probe_pt(-18.00, 14.00, 1)
16:39:21.556 : current_position=(-34.00, 13.99, 5.00) :
16:39:21.556 : do_probe_raise(5.00)
16:39:21.560 : > do_blocking_move_to_xy(-18.00, 14.00)
16:39:21.560 : >>> do_blocking_move_to(-18.00, 14.00, 5.00)
16:39:21.564 : destination=(-34.00, 13.99, 5.00) : set_destination_to_current
16:39:21.891 : current_position=(-18.00, 14.00, 5.00) : xy move
16:39:21.892 : <<< do_blocking_move_to
16:39:22.019 : > current_position=(-18.00, 14.00, 5.00) : set_probe_deployed
16:39:22.019 : deploy: 1
16:39:22.019 : >>> do_blocking_move_to(-18.00, 14.00, -348.00)
16:39:22.023 : destination=(-18.00, 14.00, -348.00) : set_destination_to_current
16:39:27.888 : current_position=(-18.00, 14.00, 0.00) : xy move
16:39:27.892 : destination=(-18.00, 14.00, -348.00) : prepare_move_to_destination_raw
16:39:27.912 : current_position=(-18.00, 14.00, -348.00) : z lower move
16:39:27.912 : <<< do_blocking_move_to
16:39:33.815 : current_position=(-18.00, 14.00, -1.22) : sync_plan_position_delta
16:39:33.818 : >>> do_blocking_move_to(-18.00, 14.00, 3.78)
16:39:33.818 : destination=(-18.00, 14.00, 3.78) : set_destination_to_current
16:39:33.823 : current_position=(-18.00, 14.00, 3.78) : xy move
16:39:33.823 : <<< do_blocking_move_to
16:39:33.823 : >>> do_blocking_move_to(-18.00, 14.00, -6.22)
16:39:33.826 : destination=(-18.00, 14.00, -6.22) : set_destination_to_current
16:39:33.856 : current_position=(-18.00, 14.00, 0.00) : xy move
16:39:33.860 : destination=(-18.00, 14.00, -6.22) : prepare_move_to_destination_raw
16:39:33.864 : current_position=(-18.00, 14.00, -6.22) : z lower move
16:39:33.865 : <<< do_blocking_move_to
16:39:34.240 : current_position=(-18.00, 14.00, -1.12) : sync_plan_position_delta
16:39:34.241 : current_position=(-18.00, 14.00, -1.12) : run_z_probe
16:39:34.241 : > do_probe_raise
16:39:34.245 : do_probe_raise(5.00)
16:39:34.245 : >>> do_blocking_move_to(-18.00, 14.00, 5.00)
16:39:34.248 : destination=(-18.00, 14.00, 5.00) : set_destination_to_current
16:39:34.249 : current_position=(-18.00, 14.00, 5.00) : xy move
16:39:34.249 : <<< do_blocking_move_to
16:39:34.249 : <<< probe_pt
16:39:34.253 : >>> probe_pt(-2.00, 14.00, 1)
16:39:34.253 : current_position=(-18.00, 14.00, 5.00) :
16:39:34.257 : do_probe_raise(5.00)
16:39:34.257 : > do_blocking_move_to_xy(-2.00, 14.00)
16:39:34.257 : >>> do_blocking_move_to(-2.00, 14.00, 5.00)
16:39:34.260 : destination=(-18.00, 14.00, 5.00) : set_destination_to_current
16:39:34.584 : current_position=(-2.00, 14.00, 5.00) : xy move
16:39:34.584 : <<< do_blocking_move_to
16:39:34.692 : > current_position=(-2.00, 14.00, 5.00) : set_probe_deployed
16:39:34.692 : deploy: 1
16:39:34.692 : >>> do_blocking_move_to(-2.00, 14.00, -348.00)
16:39:34.695 : destination=(-2.00, 14.00, -348.00) : set_destination_to_current
16:39:40.563 : current_position=(-2.00, 14.00, 0.00) : xy move
16:39:40.567 : destination=(-2.00, 14.00, -348.00) : prepare_move_to_destination_raw
16:39:40.588 : current_position=(-2.00, 14.00, -348.00) : z lower move
16:39:40.588 : <<< do_blocking_move_to
16:39:46.462 : current_position=(-1.99, 14.00, -1.15) : sync_plan_position_delta
16:39:46.462 : >>> do_blocking_move_to(-1.99, 14.00, 3.85)
16:39:46.466 : destination=(-1.99, 14.00, 3.85) : set_destination_to_current
16:39:46.467 : current_position=(-1.99, 14.00, 3.85) : xy move
16:39:46.470 : <<< do_blocking_move_to
16:39:46.470 : >>> do_blocking_move_to(-1.99, 14.00, -6.15)
16:39:46.474 : destination=(-1.99, 14.00, -6.15) : set_destination_to_current
16:39:46.503 : current_position=(-1.99, 14.00, 0.00) : xy move
16:39:46.507 : destination=(-1.99, 14.00, -6.15) : prepare_move_to_destination_raw
16:39:46.511 : current_position=(-1.99, 14.00, -6.15) : z lower move
16:39:46.511 : <<< do_blocking_move_to
16:39:46.880 : current_position=(-1.99, 14.00, -1.04) : sync_plan_position_delta
16:39:46.884 : current_position=(-1.99, 14.00, -1.04) : run_z_probe
16:39:46.884 : > do_probe_raise
16:39:46.884 : do_probe_raise(5.00)
16:39:46.885 : >>> do_blocking_move_to(-1.99, 14.00, 5.00)
16:39:46.889 : destination=(-1.99, 14.00, 5.00) : set_destination_to_current
16:39:46.892 : current_position=(-1.99, 14.00, 5.00) : xy move
16:39:46.892 : <<< do_blocking_move_to
16:39:46.892 : <<< probe_pt
16:39:46.893 : >>> probe_pt(14.00, 14.00, 1)
16:39:46.897 : current_position=(-1.99, 14.00, 5.00) :
16:39:46.897 : do_probe_raise(5.00)
16:39:46.897 : > do_blocking_move_to_xy(14.00, 14.00)
16:39:46.901 : >>> do_blocking_move_to(14.00, 14.00, 5.00)
16:39:46.901 : destination=(-1.99, 14.00, 5.00) : set_destination_to_current
16:39:47.208 : current_position=(14.00, 14.00, 5.00) : xy move
16:39:47.208 : <<< do_blocking_move_to
16:39:47.322 : > current_position=(14.00, 14.00, 5.00) : set_probe_deployed
16:39:47.322 : deploy: 1
16:39:47.326 : >>> do_blocking_move_to(14.00, 14.00, -348.00)
16:39:47.326 : destination=(14.00, 14.00, -348.00) : set_destination_to_current
16:39:53.191 : current_position=(14.00, 14.00, 0.00) : xy move
16:39:53.195 : destination=(14.00, 14.00, -348.00) : prepare_move_to_destination_raw
16:39:53.215 : current_position=(14.00, 14.00, -348.00) : z lower move
16:39:53.215 : <<< do_blocking_move_to
16:39:59.102 : current_position=(13.99, 14.00, -1.07) : sync_plan_position_delta
16:39:59.106 : >>> do_blocking_move_to(13.99, 14.00, 3.93)
16:39:59.106 : destination=(13.99, 14.00, 3.93) : set_destination_to_current
16:39:59.110 : current_position=(13.99, 14.00, 3.93) : xy move
16:39:59.110 : <<< do_blocking_move_to
16:39:59.110 : >>> do_blocking_move_to(13.99, 14.00, -6.07)
16:39:59.114 : destination=(13.99, 14.00, -6.07) : set_destination_to_current
16:39:59.143 : current_position=(13.99, 14.00, 0.00) : xy move
16:39:59.147 : destination=(13.99, 14.00, -6.07) : prepare_move_to_destination_raw
16:39:59.151 : current_position=(13.99, 14.00, -6.07) : z lower move
16:39:59.151 : <<< do_blocking_move_to
16:39:59.520 : current_position=(13.99, 14.00, -0.96) : sync_plan_position_delta
16:39:59.520 : current_position=(13.99, 14.00, -0.96) : run_z_probe
16:39:59.520 : > do_probe_raise
16:39:59.520 : do_probe_raise(5.00)
16:39:59.524 : >>> do_blocking_move_to(13.99, 14.00, 5.00)
16:39:59.524 : destination=(13.99, 14.00, 5.00) : set_destination_to_current
16:39:59.528 : current_position=(13.99, 14.00, 5.00) : xy move
16:39:59.528 : <<< do_blocking_move_to
16:39:59.528 : <<< probe_pt
16:39:59.528 : >>> probe_pt(30.00, 14.00, 1)
16:39:59.532 : current_position=(13.99, 14.00, 5.00) :
16:39:59.532 : do_probe_raise(5.00)
16:39:59.536 : > do_blocking_move_to_xy(30.00, 14.00)
16:39:59.536 : >>> do_blocking_move_to(30.00, 14.00, 5.00)
16:39:59.537 : destination=(13.99, 14.00, 5.00) : set_destination_to_current
16:39:59.839 : current_position=(30.00, 14.00, 5.00) : xy move
16:39:59.842 : <<< do_blocking_move_to
16:39:59.978 : > current_position=(30.00, 14.00, 5.00) : set_probe_deployed
16:39:59.978 : deploy: 1
16:39:59.982 : >>> do_blocking_move_to(30.00, 14.00, -348.00)
16:39:59.982 : destination=(30.00, 14.00, -348.00) : set_destination_to_current
16:40:05.848 : current_position=(30.00, 14.00, 0.00) : xy move
16:40:05.852 : destination=(30.00, 14.00, -348.00) : prepare_move_to_destination_raw
16:40:05.868 : current_position=(30.00, 14.00, -348.00) : z lower move
16:40:05.872 : <<< do_blocking_move_to
16:40:11.733 : current_position=(30.00, 14.00, -0.98) : sync_plan_position_delta
16:40:11.733 : >>> do_blocking_move_to(30.00, 14.00, 4.02)
16:40:11.737 : destination=(30.00, 14.00, 4.02) : set_destination_to_current
16:40:11.737 : current_position=(30.00, 14.00, 4.02) : xy move
16:40:11.741 : <<< do_blocking_move_to
16:40:11.741 : >>> do_blocking_move_to(30.00, 14.00, -5.98)
16:40:11.745 : destination=(30.00, 14.00, -5.98) : set_destination_to_current
16:40:11.774 : current_position=(30.00, 14.00, 0.00) : xy move
16:40:11.778 : destination=(30.00, 14.00, -5.98) : prepare_move_to_destination_raw
16:40:11.782 : current_position=(30.00, 14.00, -5.98) : z lower move
16:40:11.782 : <<< do_blocking_move_to
16:40:12.143 : current_position=(30.00, 14.00, -0.89) : sync_plan_position_delta
16:40:12.147 : current_position=(30.00, 14.00, -0.89) : run_z_probe
16:40:12.147 : > do_probe_raise
16:40:12.147 : do_probe_raise(5.00)
16:40:12.147 : >>> do_blocking_move_to(30.00, 14.00, 5.00)
16:40:12.151 : destination=(30.00, 14.00, 5.00) : set_destination_to_current
16:40:12.151 : current_position=(30.00, 14.00, 5.00) : xy move
16:40:12.155 : <<< do_blocking_move_to
16:40:12.155 : <<< probe_pt
16:40:12.155 : >>> probe_pt(46.00, 14.00, 1)
16:40:12.159 : current_position=(30.00, 14.00, 5.00) :
16:40:12.159 : do_probe_raise(5.00)
16:40:12.159 : > do_blocking_move_to_xy(46.00, 14.00)
16:40:12.159 : >>> do_blocking_move_to(46.00, 14.00, 5.00)
16:40:12.163 : destination=(30.00, 14.00, 5.00) : set_destination_to_current
16:40:12.474 : current_position=(46.00, 14.00, 5.00) : xy move
16:40:12.474 : <<< do_blocking_move_to
16:40:12.626 : > current_position=(46.00, 14.00, 5.00) : set_probe_deployed
16:40:12.626 : deploy: 1
16:40:12.626 : >>> do_blocking_move_to(46.00, 14.00, -348.00)
16:40:12.629 : destination=(46.00, 14.00, -348.00) : set_destination_to_current
16:40:18.491 : current_position=(46.00, 14.00, 0.00) : xy move
16:40:18.495 : destination=(46.00, 14.00, -348.00) : prepare_move_to_destination_raw
16:40:18.511 : current_position=(46.00, 14.00, -348.00) : z lower move
16:40:18.511 : <<< do_blocking_move_to
16:40:24.258 : current_position=(46.01, 13.99, -0.96) : sync_plan_position_delta
16:40:24.258 : >>> do_blocking_move_to(46.01, 13.99, 4.04)
16:40:24.262 : destination=(46.01, 13.99, 4.04) : set_destination_to_current
16:40:24.266 : current_position=(46.01, 13.99, 4.04) : xy move
16:40:24.266 : <<< do_blocking_move_to
16:40:24.266 : >>> do_blocking_move_to(46.01, 13.99, -5.96)
16:40:24.270 : destination=(46.01, 13.99, -5.96) : set_destination_to_current
16:40:24.298 : current_position=(46.01, 13.99, 0.00) : xy move
16:40:24.302 : destination=(46.01, 13.99, -5.96) : prepare_move_to_destination_raw
16:40:24.307 : current_position=(46.01, 13.99, -5.96) : z lower move
16:40:24.307 : <<< do_blocking_move_to
16:40:24.668 : current_position=(46.01, 13.99, -0.88) : sync_plan_position_delta
16:40:24.672 : current_position=(46.01, 13.99, -0.88) : run_z_probe
16:40:24.672 : > do_probe_raise
16:40:24.672 : do_probe_raise(5.00)
16:40:24.672 : >>> do_blocking_move_to(46.01, 13.99, 5.00)
16:40:24.676 : destination=(46.01, 13.99, 5.00) : set_destination_to_current
16:40:24.676 : current_position=(46.01, 13.99, 5.00) : xy move
16:40:24.680 : <<< do_blocking_move_to
16:40:24.680 : <<< probe_pt
16:40:24.680 : >>> probe_pt(30.00, 30.00, 1)
16:40:24.684 : current_position=(46.01, 13.99, 5.00) :
16:40:24.684 : do_probe_raise(5.00)
16:40:24.684 : > do_blocking_move_to_xy(30.00, 30.00)
16:40:24.685 : >>> do_blocking_move_to(30.00, 30.00, 5.00)
16:40:24.688 : destination=(46.01, 13.99, 5.00) : set_destination_to_current
16:40:25.080 : current_position=(30.00, 30.00, 5.00) : xy move
16:40:25.080 : <<< do_blocking_move_to
16:40:25.184 : > current_position=(30.00, 30.00, 5.00) : set_probe_deployed
16:40:25.184 : deploy: 1
16:40:25.188 : >>> do_blocking_move_to(30.00, 30.00, -348.00)
16:40:25.188 : destination=(30.00, 30.00, -348.00) : set_destination_to_current
16:40:31.049 : current_position=(30.00, 30.00, 0.00) : xy move
16:40:31.053 : destination=(30.00, 30.00, -348.00) : prepare_move_to_destination_raw
16:40:31.069 : current_position=(30.00, 30.00, -348.00) : z lower move
16:40:31.069 : <<< do_blocking_move_to
16:40:36.816 : current_position=(30.00, 30.00, -0.91) : sync_plan_position_delta
16:40:36.820 : >>> do_blocking_move_to(30.00, 30.00, 4.09)
16:40:36.822 : destination=(30.00, 30.00, 4.09) : set_destination_to_current
16:40:36.824 : current_position=(30.00, 30.00, 4.09) : xy move
16:40:36.825 : <<< do_blocking_move_to
16:40:36.825 : >>> do_blocking_move_to(30.00, 30.00, -5.91)
16:40:36.828 : destination=(30.00, 30.00, -5.91) : set_destination_to_current
16:40:36.856 : current_position=(30.00, 30.00, 0.00) : xy move
16:40:36.860 : destination=(30.00, 30.00, -5.91) : prepare_move_to_destination_raw
16:40:36.864 : current_position=(30.00, 30.00, -5.91) : z lower move
16:40:36.864 : <<< do_blocking_move_to
16:40:37.225 : current_position=(30.00, 30.00, -0.84) : sync_plan_position_delta
16:40:37.226 : current_position=(30.00, 30.00, -0.84) : run_z_probe
16:40:37.226 : > do_probe_raise
16:40:37.226 : do_probe_raise(5.00)
16:40:37.230 : >>> do_blocking_move_to(30.00, 30.00, 5.00)
16:40:37.230 : destination=(30.00, 30.00, 5.00) : set_destination_to_current
16:40:37.234 : current_position=(30.00, 30.00, 5.00) : xy move
16:40:37.234 : <<< do_blocking_move_to
16:40:37.234 : <<< probe_pt
16:40:37.234 : >>> probe_pt(14.00, 30.00, 1)
16:40:37.238 : current_position=(30.00, 30.00, 5.00) :
16:40:37.238 : do_probe_raise(5.00)
16:40:37.242 : > do_blocking_move_to_xy(14.00, 30.00)
16:40:37.242 : >>> do_blocking_move_to(14.00, 30.00, 5.00)
16:40:37.243 : destination=(30.00, 30.00, 5.00) : set_destination_to_current
16:40:37.557 : current_position=(14.00, 30.00, 5.00) : xy move
16:40:37.557 : <<< do_blocking_move_to
16:40:37.685 : > current_position=(14.00, 30.00, 5.00) : set_probe_deployed
16:40:37.685 : deploy: 1
16:40:37.689 : >>> do_blocking_move_to(14.00, 30.00, -348.00)
16:40:37.689 : destination=(14.00, 30.00, -348.00) : set_destination_to_current
16:40:43.545 : current_position=(14.00, 30.00, 0.00) : xy move
16:40:43.546 : destination=(14.00, 30.00, -348.00) : prepare_move_to_destination_raw
16:40:43.549 : current_position=(14.00, 30.00, -348.00) : z lower move
16:40:43.549 : <<< do_blocking_move_to
16:40:49.271 : current_position=(14.00, 29.99, -1.01) : sync_plan_position_delta
16:40:49.271 : >>> do_blocking_move_to(14.00, 29.99, 3.99)
16:40:49.275 : destination=(14.00, 29.99, 3.99) : set_destination_to_current
16:40:49.279 : current_position=(14.00, 29.99, 3.99) : xy move
16:40:49.279 : <<< do_blocking_move_to
16:40:49.279 : >>> do_blocking_move_to(14.00, 29.99, -6.01)
16:40:49.283 : destination=(14.00, 29.99, -6.01) : set_destination_to_current
16:40:49.312 : current_position=(14.00, 29.99, 0.00) : xy move
16:40:49.316 : destination=(14.00, 29.99, -6.01) : prepare_move_to_destination_raw
16:40:49.320 : current_position=(14.00, 29.99, -6.01) : z lower move
16:40:49.320 : <<< do_blocking_move_to
16:40:49.681 : current_position=(14.00, 29.99, -0.89) : sync_plan_position_delta
16:40:49.685 : current_position=(14.00, 29.99, -0.89) : run_z_probe
16:40:49.685 : > do_probe_raise
16:40:49.685 : do_probe_raise(5.00)
16:40:49.689 : >>> do_blocking_move_to(14.00, 29.99, 5.00)
16:40:49.690 : destination=(14.00, 29.99, 5.00) : set_destination_to_current
16:40:49.693 : current_position=(14.00, 29.99, 5.00) : xy move
16:40:49.693 : <<< do_blocking_move_to
16:40:49.693 : <<< probe_pt
16:40:49.694 : >>> probe_pt(-2.00, 30.00, 1)
16:40:49.698 : current_position=(14.00, 29.99, 5.00) :
16:40:49.698 : do_probe_raise(5.00)
16:40:49.698 : > do_blocking_move_to_xy(-2.00, 30.00)
16:40:49.702 : >>> do_blocking_move_to(-2.00, 30.00, 5.00)
16:40:49.702 : destination=(14.00, 29.99, 5.00) : set_destination_to_current
16:40:50.012 : current_position=(-2.00, 30.00, 5.00) : xy move
16:40:50.013 : <<< do_blocking_move_to
16:40:50.127 : > current_position=(-2.00, 30.00, 5.00) : set_probe_deployed
16:40:50.127 : deploy: 1
16:40:50.127 : >>> do_blocking_move_to(-2.00, 30.00, -348.00)
16:40:50.131 : destination=(-2.00, 30.00, -348.00) : set_destination_to_current
16:40:55.980 : current_position=(-2.00, 30.00, 0.00) : xy move
16:40:55.980 : destination=(-2.00, 30.00, -348.00) : prepare_move_to_destination_raw
16:40:55.984 : current_position=(-2.00, 30.00, -348.00) : z lower move
16:40:55.984 : <<< do_blocking_move_to
16:41:01.698 : current_position=(-2.00, 29.99, -1.09) : sync_plan_position_delta
16:41:01.698 : >>> do_blocking_move_to(-2.00, 29.99, 3.91)
16:41:01.702 : destination=(-2.00, 29.99, 3.91) : set_destination_to_current
16:41:01.705 : current_position=(-2.00, 29.99, 3.91) : xy move
16:41:01.706 : <<< do_blocking_move_to
16:41:01.706 : >>> do_blocking_move_to(-2.00, 29.99, -6.09)
16:41:01.709 : destination=(-2.00, 29.99, -6.09) : set_destination_to_current
16:41:01.738 : current_position=(-2.00, 29.99, 0.00) : xy move
16:41:01.743 : destination=(-2.00, 29.99, -6.09) : prepare_move_to_destination_raw
16:41:01.747 : current_position=(-2.00, 29.99, -6.09) : z lower move
16:41:01.747 : <<< do_blocking_move_to
16:41:02.115 : current_position=(-2.00, 29.99, -0.98) : sync_plan_position_delta
16:41:02.115 : current_position=(-2.00, 29.99, -0.98) : run_z_probe
16:41:02.115 : > do_probe_raise
16:41:02.119 : do_probe_raise(5.00)
16:41:02.119 : >>> do_blocking_move_to(-2.00, 29.99, 5.00)
16:41:02.123 : destination=(-2.00, 29.99, 5.00) : set_destination_to_current
16:41:02.123 : current_position=(-2.00, 29.99, 5.00) : xy move
16:41:02.123 : <<< do_blocking_move_to
16:41:02.123 : <<< probe_pt
16:41:02.127 : >>> probe_pt(-18.00, 30.00, 1)
16:41:02.127 : current_position=(-2.00, 29.99, 5.00) :
16:41:02.127 : do_probe_raise(5.00)
16:41:02.131 : > do_blocking_move_to_xy(-18.00, 30.00)
16:41:02.131 : >>> do_blocking_move_to(-18.00, 30.00, 5.00)
16:41:02.135 : destination=(-2.00, 29.99, 5.00) : set_destination_to_current
16:41:02.438 : current_position=(-18.00, 30.00, 5.00) : xy move
16:41:02.439 : <<< do_blocking_move_to
16:41:02.562 : > current_position=(-18.00, 30.00, 5.00) : set_probe_deployed
16:41:02.562 : deploy: 1
16:41:02.565 : >>> do_blocking_move_to(-18.00, 30.00, -348.00)
16:41:02.566 : destination=(-18.00, 30.00, -348.00) : set_destination_to_current
16:41:08.431 : current_position=(-18.00, 30.00, 0.00) : xy move
16:41:08.431 : destination=(-18.00, 30.00, -348.00) : prepare_move_to_destination_raw
16:41:08.435 : current_position=(-18.00, 30.00, -348.00) : z lower move
16:41:08.435 : <<< do_blocking_move_to
16:41:14.165 : current_position=(-17.99, 30.00, -1.22) : sync_plan_position_delta
16:41:14.165 : >>> do_blocking_move_to(-17.99, 30.00, 3.78)
16:41:14.170 : destination=(-17.99, 30.00, 3.78) : set_destination_to_current
16:41:14.174 : current_position=(-17.99, 30.00, 3.78) : xy move
16:41:14.174 : <<< do_blocking_move_to
16:41:14.174 : >>> do_blocking_move_to(-17.99, 30.00, -6.22)
16:41:14.177 : destination=(-17.99, 30.00, -6.22) : set_destination_to_current
16:41:14.206 : current_position=(-17.99, 30.00, 0.00) : xy move
16:41:14.210 : destination=(-17.99, 30.00, -6.22) : prepare_move_to_destination_raw
16:41:14.214 : current_position=(-17.99, 30.00, -6.22) : z lower move
16:41:14.214 : <<< do_blocking_move_to
16:41:14.587 : current_position=(-17.99, 30.00, -1.08) : sync_plan_position_delta
16:41:14.591 : current_position=(-17.99, 30.00, -1.08) : run_z_probe
16:41:14.591 : > do_probe_raise
16:41:14.591 : do_probe_raise(5.00)
16:41:14.592 : >>> do_blocking_move_to(-17.99, 30.00, 5.00)
16:41:14.595 : destination=(-17.99, 30.00, 5.00) : set_destination_to_current
16:41:14.599 : current_position=(-17.99, 30.00, 5.00) : xy move
16:41:14.599 : <<< do_blocking_move_to
16:41:14.599 : <<< probe_pt
16:41:14.599 : >>> probe_pt(-34.00, 30.00, 1)
16:41:14.603 : current_position=(-17.99, 30.00, 5.00) :
16:41:14.603 : do_probe_raise(5.00)
16:41:14.604 : > do_blocking_move_to_xy(-34.00, 30.00)
16:41:14.608 : >>> do_blocking_move_to(-34.00, 30.00, 5.00)
16:41:14.608 : destination=(-17.99, 30.00, 5.00) : set_destination_to_current
16:41:14.923 : current_position=(-34.00, 30.00, 5.00) : xy move
16:41:14.923 : <<< do_blocking_move_to
16:41:15.062 : > current_position=(-34.00, 30.00, 5.00) : set_probe_deployed
16:41:15.062 : deploy: 1
16:41:15.062 : >>> do_blocking_move_to(-34.00, 30.00, -348.00)
16:41:15.066 : destination=(-34.00, 30.00, -348.00) : set_destination_to_current
16:41:20.936 : current_position=(-34.00, 30.00, 0.00) : xy move
16:41:20.940 : destination=(-34.00, 30.00, -348.00) : prepare_move_to_destination_raw
16:41:20.960 : current_position=(-34.00, 30.00, -348.00) : z lower move
16:41:20.960 : <<< do_blocking_move_to
16:41:26.735 : current_position=(-34.00, 30.00, -1.29) : sync_plan_position_delta
16:41:26.739 : >>> do_blocking_move_to(-34.00, 30.00, 3.71)
16:41:26.739 : destination=(-34.00, 30.00, 3.71) : set_destination_to_current
16:41:26.743 : current_position=(-34.00, 30.00, 3.71) : xy move
16:41:26.743 : <<< do_blocking_move_to
16:41:26.747 : >>> do_blocking_move_to(-34.00, 30.00, -6.29)
16:41:26.747 : destination=(-34.00, 30.00, -6.29) : set_destination_to_current
16:41:26.780 : current_position=(-34.00, 30.00, 0.00) : xy move
16:41:26.784 : destination=(-34.00, 30.00, -6.29) : prepare_move_to_destination_raw
16:41:26.788 : current_position=(-34.00, 30.00, -6.29) : z lower move
16:41:26.788 : <<< do_blocking_move_to
16:41:27.170 : current_position=(-34.00, 30.00, -1.21) : sync_plan_position_delta
16:41:27.174 : current_position=(-34.00, 30.00, -1.21) : run_z_probe
16:41:27.174 : > do_probe_raise
16:41:27.174 : do_probe_raise(5.00)
16:41:27.178 : >>> do_blocking_move_to(-34.00, 30.00, 5.00)
16:41:27.178 : destination=(-34.00, 30.00, 5.00) : set_destination_to_current
16:41:27.182 : current_position=(-34.00, 30.00, 5.00) : xy move
16:41:27.182 : <<< do_blocking_move_to
16:41:27.182 : <<< probe_pt
16:41:27.182 : >>> probe_pt(-18.00, 46.00, 1)
16:41:27.186 : current_position=(-34.00, 30.00, 5.00) :
16:41:27.186 : do_probe_raise(5.00)
16:41:27.186 : > do_blocking_move_to_xy(-18.00, 46.00)
16:41:27.190 : >>> do_blocking_move_to(-18.00, 46.00, 5.00)
16:41:27.190 : destination=(-34.00, 30.00, 5.00) : set_destination_to_current
16:41:27.612 : current_position=(-18.00, 46.00, 5.00) : xy move
16:41:27.616 : <<< do_blocking_move_to
16:41:27.698 : > current_position=(-18.00, 46.00, 5.00) : set_probe_deployed
16:41:27.698 : deploy: 1
16:41:27.702 : >>> do_blocking_move_to(-18.00, 46.00, -348.00)
16:41:27.702 : destination=(-18.00, 46.00, -348.00) : set_destination_to_current
16:41:33.502 : current_position=(-18.00, 46.00, 0.00) : xy move
16:41:33.506 : destination=(-18.00, 46.00, -348.00) : prepare_move_to_destination_raw
16:41:33.506 : current_position=(-18.00, 46.00, -348.00) : z lower move
16:41:33.509 : <<< do_blocking_move_to
16:41:39.162 : current_position=(-18.00, 46.00, -1.17) : sync_plan_position_delta
16:41:39.162 : >>> do_blocking_move_to(-18.00, 46.00, 3.83)
16:41:39.166 : destination=(-18.00, 46.00, 3.83) : set_destination_to_current
16:41:39.166 : current_position=(-18.00, 46.00, 3.83) : xy move
16:41:39.166 : <<< do_blocking_move_to
16:41:39.170 : >>> do_blocking_move_to(-18.00, 46.00, -6.17)
16:41:39.170 : destination=(-18.00, 46.00, -6.17) : set_destination_to_current
16:41:39.203 : current_position=(-18.00, 46.00, 0.00) : xy move
16:41:39.207 : destination=(-18.00, 46.00, -6.17) : prepare_move_to_destination_raw
16:41:39.211 : current_position=(-18.00, 46.00, -6.17) : z lower move
16:41:39.211 : <<< do_blocking_move_to
16:41:39.583 : current_position=(-18.00, 46.00, -1.09) : sync_plan_position_delta
16:41:39.583 : current_position=(-18.00, 46.00, -1.09) : run_z_probe
16:41:39.583 : > do_probe_raise
16:41:39.583 : do_probe_raise(5.00)
16:41:39.587 : >>> do_blocking_move_to(-18.00, 46.00, 5.00)
16:41:39.591 : destination=(-18.00, 46.00, 5.00) : set_destination_to_current
16:41:39.591 : current_position=(-18.00, 46.00, 5.00) : xy move
16:41:39.591 : <<< do_blocking_move_to
16:41:39.591 : <<< probe_pt
16:41:39.596 : >>> probe_pt(-2.00, 46.00, 1)
16:41:39.596 : current_position=(-18.00, 46.00, 5.00) :
16:41:39.596 : do_probe_raise(5.00)
16:41:39.600 : > do_blocking_move_to_xy(-2.00, 46.00)
16:41:39.600 : >>> do_blocking_move_to(-2.00, 46.00, 5.00)
16:41:39.603 : destination=(-18.00, 46.00, 5.00) : set_destination_to_current
16:41:39.919 : current_position=(-2.00, 46.00, 5.00) : xy move
16:41:39.920 : <<< do_blocking_move_to
16:41:40.047 : > current_position=(-2.00, 46.00, 5.00) : set_probe_deployed
16:41:40.047 : deploy: 1
16:41:40.047 : >>> do_blocking_move_to(-2.00, 46.00, -348.00)
16:41:40.050 : destination=(-2.00, 46.00, -348.00) : set_destination_to_current
16:41:45.834 : current_position=(-2.00, 46.00, 0.00) : xy move
16:41:45.834 : destination=(-2.00, 46.00, -348.00) : prepare_move_to_destination_raw
16:41:45.838 : current_position=(-2.00, 46.00, -348.00) : z lower move
16:41:45.838 : <<< do_blocking_move_to
16:41:51.478 : current_position=(-2.00, 46.00, -1.10) : sync_plan_position_delta
16:41:51.478 : >>> do_blocking_move_to(-2.00, 46.00, 3.90)
16:41:51.482 : destination=(-2.00, 46.00, 3.90) : set_destination_to_current
16:41:51.482 : current_position=(-2.00, 46.00, 3.90) : xy move
16:41:51.486 : <<< do_blocking_move_to
16:41:51.486 : >>> do_blocking_move_to(-2.00, 46.00, -6.10)
16:41:51.486 : destination=(-2.00, 46.00, -6.10) : set_destination_to_current
16:41:51.518 : current_position=(-2.00, 46.00, 0.00) : xy move
16:41:51.522 : destination=(-2.00, 46.00, -6.10) : prepare_move_to_destination_raw
16:41:51.526 : current_position=(-2.00, 46.00, -6.10) : z lower move
16:41:51.526 : <<< do_blocking_move_to
16:41:51.892 : current_position=(-2.00, 46.00, -0.95) : sync_plan_position_delta
16:41:51.895 : current_position=(-2.00, 46.00, -0.95) : run_z_probe
16:41:51.896 : > do_probe_raise
16:41:51.896 : do_probe_raise(5.00)
16:41:51.896 : >>> do_blocking_move_to(-2.00, 46.00, 5.00)
16:41:51.900 : destination=(-2.00, 46.00, 5.00) : set_destination_to_current
16:41:51.904 : current_position=(-2.00, 46.00, 5.00) : xy move
16:41:51.904 : <<< do_blocking_move_to
16:41:51.904 : <<< probe_pt
16:41:51.904 : >>> probe_pt(14.00, 46.00, 1)
16:41:51.908 : current_position=(-2.00, 46.00, 5.00) :
16:41:51.908 : do_probe_raise(5.00)
16:41:51.908 : > do_blocking_move_to_xy(14.00, 46.00)
16:41:51.912 : >>> do_blocking_move_to(14.00, 46.00, 5.00)
16:41:51.912 : destination=(-2.00, 46.00, 5.00) : set_destination_to_current
16:41:52.219 : current_position=(14.00, 46.00, 5.00) : xy move
16:41:52.219 : <<< do_blocking_move_to
16:41:52.346 : > current_position=(14.00, 46.00, 5.00) : set_probe_deployed
16:41:52.346 : deploy: 1
16:41:52.350 : >>> do_blocking_move_to(14.00, 46.00, -348.00)
16:41:52.351 : destination=(14.00, 46.00, -348.00) : set_destination_to_current
16:41:58.133 : current_position=(14.00, 46.00, 0.00) : xy move
16:41:58.137 : destination=(14.00, 46.00, -348.00) : prepare_move_to_destination_raw
16:41:58.141 : current_position=(14.00, 46.00, -348.00) : z lower move
16:41:58.141 : <<< do_blocking_move_to
16:42:03.786 : current_position=(13.99, 46.00, -0.97) : sync_plan_position_delta
16:42:03.786 : >>> do_blocking_move_to(13.99, 46.00, 4.03)
16:42:03.790 : destination=(13.99, 46.00, 4.03) : set_destination_to_current
16:42:03.794 : current_position=(13.99, 46.00, 4.03) : xy move
16:42:03.794 : <<< do_blocking_move_to
16:42:03.794 : >>> do_blocking_move_to(13.99, 46.00, -5.97)
16:42:03.797 : destination=(13.99, 46.00, -5.97) : set_destination_to_current
16:42:03.827 : current_position=(13.99, 46.00, 0.00) : xy move
16:42:03.830 : destination=(13.99, 46.00, -5.97) : prepare_move_to_destination_raw
16:42:03.834 : current_position=(13.99, 46.00, -5.97) : z lower move
16:42:03.834 : <<< do_blocking_move_to
16:42:04.195 : current_position=(13.99, 46.00, -0.88) : sync_plan_position_delta
16:42:04.195 : current_position=(13.99, 46.00, -0.88) : run_z_probe
16:42:04.199 : > do_probe_raise
16:42:04.199 : do_probe_raise(5.00)
16:42:04.199 : >>> do_blocking_move_to(13.99, 46.00, 5.00)
16:42:04.203 : destination=(13.99, 46.00, 5.00) : set_destination_to_current
16:42:04.203 : current_position=(13.99, 46.00, 5.00) : xy move
16:42:04.203 : <<< do_blocking_move_to
16:42:04.207 : <<< probe_pt
16:42:04.207 : current_position=(13.99, 46.00, 5.00) : set_probe_deployed
16:42:04.207 : deploy: 0
16:42:04.211 : do_probe_raise(50.00)
16:42:04.211 : >>> do_blocking_move_to(13.99, 46.00, 50.00)
16:42:04.216 : destination=(13.99, 46.00, 50.00) : set_destination_to_current
16:42:04.216 : current_position=(13.99, 46.00, 50.00) : xy move
16:42:04.216 : <<< do_blocking_move_to
16:42:04.220 : >>> do_blocking_move_to(13.99, 46.00, 50.00)
16:42:04.220 : destination=(13.99, 46.00, 50.00) : set_destination_to_current
16:42:04.224 : current_position=(13.99, 46.00, 50.00) : xy move
16:42:04.224 : <<< do_blocking_move_to
16:42:04.228 : current_position=(13.99, 46.00, 50.00) : clean_up_after_endstop_or_probe_move
16:42:04.228 : current_position=(13.99, 46.00, 50.00) : > probing complete
16:42:04.232 : -1.04 -0.83 -0.68 -0.53 -0.44 -0.37 -0.37
16:42:04.232 : -0.95 -0.77 -0.59 -0.48 -0.40 -0.38 -0.37
16:42:04.236 : -0.84 -0.68 -0.51 -0.43 -0.35 -0.32 -0.37
16:42:04.236 : -0.67 -0.55 -0.42 -0.33 -0.31 -0.20 -0.22
16:42:04.236 : -0.58 -0.47 -0.37 -0.29 -0.21 -0.14 -0.13
16:42:04.240 : -0.53 -0.46 -0.33 -0.23 -0.14 -0.09 -0.04
16:42:04.240 : -0.55 -0.45 -0.34 -0.20 -0.13 -0.04 0.04
16:42:04.244 : <<< gcode_G29
16:42:04.245 : X:13.99 Y:46.00 Z:50.00 E:0.00 Count X: 34005 Y:36601 Z:42072

A branch that it used for test:
https://github.com/esenapaj/Marlin/tree/testes2

[ghost]

Hum, danger zone move, zone border move, and z raise move aren't in the log...

...Ah, It isn't itself a problem.
Because
16:35:27.073 : >>> do_blocking_move_to(0.00, 0.00, 317.06)
works only logically, thus current_position[Z_AXIS] isn't in danger zone logically.

[thinkyhead]

There's a good reason for that: #4381!