info: Checking engine data directory tree... [engine] info: Loading engine configuration... [engine] info: Getting engine version... [engine] debug: Previous engine version: 341444dae3ce011f2ec29e2b3ef10f68752124a0 [engine] debug: Current engine version: 341444dae3ce011f2ec29e2b3ef10f68752124a0 [engine] info: Engine version is unchanged since last run. [engine] debug: Saving config to /opt/fabmo/config/engine.json [config] info: Applying engine configuration... [engine] info: Configuring database... [engine] debug: fsync()ed /opt/fabmo/config/engine.json [config] warn: No callback passed to setMany [config] info: Databases are clean. [db] info: Cleaning up database... [engine] info: Connecting to G2... [engine] info: Opening control port /dev/ttyACM0 [g2] info: Dual USB since control port and gcode port are different. (/dev/ttyACM0,/dev/ttyACM1) [g2] info: Got a machine state change: idle [machine] info: Launching detection daemon... [engine] info: Loading the machine configuration... [engine] info: Configuring G2... [engine] info: Configuring G2 Driver... [config] info: Getting G2 firmware version... [engine] info: G2 Firmware Build: 89.02 [engine] debug: Running G2 Shim... [engine] debug: No obsolete entries in G2 config. [engine] info: Loading OpenSBP Commands... [engine] debug: Loaded OpenSBP commands from "/fabmo/engine/runtime/opensbp/commands/custom.js" [opensbp] debug: Loaded OpenSBP commands from "/fabmo/engine/runtime/opensbp/commands/cut.js" [opensbp] debug: Loaded OpenSBP commands from "/fabmo/engine/runtime/opensbp/commands/experimental.js" [opensbp] debug: Loaded OpenSBP commands from "/fabmo/engine/runtime/opensbp/commands/file.js" [opensbp] debug: Loaded OpenSBP commands from "/fabmo/engine/runtime/opensbp/commands/jog.js" [opensbp] debug: Loaded OpenSBP commands from "/fabmo/engine/runtime/opensbp/commands/leveler.js" [opensbp] debug: Loaded OpenSBP commands from "/fabmo/engine/runtime/opensbp/commands/move.js" [opensbp] debug: Loaded OpenSBP commands from "/fabmo/engine/runtime/opensbp/commands/setting.js" [opensbp] debug: Loaded OpenSBP commands from "/fabmo/engine/runtime/opensbp/commands/value.js" [opensbp] debug: Loaded OpenSBP commands from "/fabmo/engine/runtime/opensbp/commands/zero.js" [opensbp] info: Configuring OpenSBP runtime... [engine] info: Applying machine configuration... [engine] info: Machine is deauthorized. [machine] info: SETTING PREFERRED UNITS [machine] info: Changing default units to INCH [machine] info: Setting driver units to INCH [g2] debug: Saving config to /opt/fabmo/config/g2.json [config] debug: fsync()ed /opt/fabmo/config/g2.json [config] info: Done setting driver units [machine] info: Setting preferred units for [GCodeRuntime] [machine] debug: Enabling display for x axis. [machine] debug: Enabling display for y axis. [machine] debug: Enabling display for z axis. [machine] debug: Disabling display for a axis. [machine] debug: Disabling display for b axis. [machine] info: Setting preferred units for [SBPRuntime] [machine] info: SBP runtime is setting the preferred units to 0 [sbp] info: Setting SBP runtime units to in [sbp] debug: Stack Trace: at SBPRuntime._setUnits (/fabmo/engine/runtime/opensbp/opensbp.js:1148:6) at SBPRuntime.setPreferredUnits (/fabmo/engine/runtime/opensbp/opensbp.js:1141:8) at Machine.runtime_set_units (/fabmo/engine/machine.js:396:20) at /fabmo/engine/node_modules/async/lib/async.js:187:20 at iterate (/fabmo/engine/node_modules/async/lib/async.js:265:13) at process._tickCallback (node.js:458:13) [sbp] debug: Saving config to /opt/fabmo/config/opensbp.json [config] debug: fsync()ed /opt/fabmo/config/opensbp.json [config] info: Setting preferred units for [ManualRuntime] [machine] info: Setting preferred units for [object Object] [machine] info: Setting preferred units for [IdleRuntime] [machine] info: Configuring dashboard... [engine] info: Loading dashboard apps... [engine] debug: Not copying app "/fabmo/engine/dashboard/apps/configuration.fma" because it already exists. [app_manager] debug: Not copying app "/fabmo/engine/dashboard/apps/editor.fma" because it already exists. [app_manager] debug: Not copying app "/fabmo/engine/dashboard/apps/job_manager.fma" because it already exists. [app_manager] debug: Not copying app "/fabmo/engine/dashboard/apps/macro_manager.fma" because it already exists. [app_manager] debug: Not copying app "/fabmo/engine/dashboard/apps/network_manager.fma" because it already exists. [app_manager] debug: Not copying app "/fabmo/engine/dashboard/apps/previewer.fma" because it already exists. [app_manager] debug: Not copying app "/fabmo/engine/dashboard/apps/selftest.fma" because it already exists. [app_manager] debug: Not copying app "/fabmo/engine/dashboard/apps/video.fma" because it already exists. [app_manager] debug: Not decompressing app "/opt/fabmo/apps/Fire-Up!_v1.0.0.fma" because it already exists. [app_manager] debug: Not decompressing app "/opt/fabmo/apps/Quick.Launch_v1.0.1.fma" because it already exists. [app_manager] debug: Not decompressing app "/opt/fabmo/apps/Sb4_v4.0.12.fma" because it already exists. [app_manager] debug: Not decompressing app "/opt/fabmo/apps/TerrainMan_v0.0.2.fma" because it already exists. [app_manager] debug: Not decompressing app "/opt/fabmo/apps/beamer_v1.0.0.fma" because it already exists. [app_manager] debug: Not decompressing app "/opt/fabmo/apps/example-app_v1.0.0.fma" because it already exists. [app_manager] debug: Not decompressing app "/opt/fabmo/apps/holecutter_v1.0.0.fma" because it already exists. [app_manager] debug: Not decompressing app "/opt/fabmo/apps/theNEWS_v1.0.1.fma" because it already exists. [app_manager] debug: Not decompressing app "/opt/fabmo/apps/touchandgo_v0.1.0.fma" because it already exists. [app_manager] info: Loading macros... [engine] info: Loading instance info... [engine] info: Applying instance configuration... [engine] info: Configuring secret key... [engine] info: Secret key already exists, using that. [engine] info: Setting up the webserver... [engine] info: Configuring cross-origin requests... [engine] info: Cofiguring upload directory... [engine] info: Cofiguring authentication... [engine] info: Secret Key: 69169...e0c06 [engine] info: Enabling gzip for transport... [engine] info: Loading routes... [engine] debug: Loaded routes from "/fabmo/engine/routes/authentication.js" [routes] debug: Loaded routes from "/fabmo/engine/routes/config.js" [routes] debug: Loaded routes from "/fabmo/engine/routes/dashboard.js" [routes] debug: Loaded routes from "/fabmo/engine/routes/direct.js" [routes] debug: Loaded routes from "/fabmo/engine/routes/jobs.js" [routes] debug: Loaded routes from "/fabmo/engine/routes/kill.js" [routes] debug: Loaded routes from "/fabmo/engine/routes/log.js" [routes] debug: Loaded routes from "/fabmo/engine/routes/macros.js" [routes] debug: Loaded routes from "/fabmo/engine/routes/network.js" [routes] debug: Loaded routes from "/fabmo/engine/routes/passthrough.js" [routes] debug: Loaded routes from "/fabmo/engine/routes/state.js" [routes] debug: Loaded routes from "/fabmo/engine/routes/time.js" [routes] debug: (Skipping route load for /fabmo/engine/routes/util.js) [routes] warn: No video support. (Could not load udev module) [routes] debug: Loaded routes from "/fabmo/engine/routes/video.js" [routes] debug: Loaded routes from "/fabmo/engine/routes/websocket.js" [routes] info: FabMo Engine listening at http://0.0.0.0:80 [engine] info: Anonymous client at 192.168.42.21 connected. [websocket] debug: Client disconnected [websocket] info: Anonymous client at 192.168.42.21 connected. [websocket] info: Client #2 at 192.168.42.21 connected. [websocket] info: Anonymous client at 192.168.42.21 connected. [websocket] debug: Client disconnected [websocket] debug: Client disconnected [websocket] info: Anonymous client at 192.168.42.21 connected. [websocket] info: Client #2 at 192.168.42.21 connected. [websocket] info: Anonymous client at 192.168.42.21 connected. [websocket] debug: Client disconnected [websocket] debug: Client disconnected [websocket] info: Anonymous client at 192.168.42.21 connected. [websocket] info: Client #2 at 192.168.42.21 connected. [websocket] info: Anonymous client at 192.168.42.21 connected. [websocket] info: Arming the machine for runtimeCode [machine] info: Got a machine state change: armed [machine] info: Fire button hit! [machine] info: Machine is deauthorized. [machine] debug: Firing a runtimeCode [machine] info: Got a machine state change: idle [machine] info: Connected OpenSBP runtime. [sbp] debug: Starting a timer for AP mode collapse (AP button was pressed) [machine] debug: _setupTransforms [sbp] debug: Transforms configured... [sbp] debug: Labels analyzed... [sbp] debug: GOTOs analyzed... [sbp] debug: emit_gcode = G90 [sbp] debug: Rainbows organized... [sbp] info: Starting OpenSBP program [sbp] info: Got a machine state change: running [machine] debug: Stack break: {"type":"cmd","cmd":"C_POUND","args":[3]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Returning from run... [sbp] debug: Saving config to /opt/fabmo/config/instance.json [config] debug: fsync()ed /opt/fabmo/config/instance.json [config] debug: Stack break: {"type":"cmd","cmd":"C_POUND","args":[3]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"C_POUND","args":[3]} [sbp] debug: Calling handler for C_POUND With arguments: [3] [sbp] debug: Running macro: {"name":"Set Zero Locations","description":"Automatically Set Axis Zero for XYZ","filename":"/opt/fabmo/macros/macro_3.sbp","content":"'Set XYZ Zero Locations -- MACRO #3 -- [C3] in OpenSBP Language // HANDIBOT VERSION\n' ... written in OpenSBP; 3/1/2016 th\n\n'Initialize\n 'Read Offset or Set Defaults\n $current_cutter_Zoffset := .25\n $x_backoff := .075\n $y_backoff := .075\n 'Get Speeds at Startup\n\t\t&startXY_speed = %(71)\n\t\t&startZ_speed = %(73)\n\t'Get Acc/Dec Ramps at Startup\n\t\t&startXY_ramp = %(81) ' X and Y ramps are the same, treated as single parameter in OpenSBP\n\t\t&startZ_ramp = %(83)\n VS, 4,4\t\t\t\t' Set Approach Speeds\n VR, 250, 250 \t' Set Aggressive Ramp to reduce pounding ...\n\tZT,\t\t\t\t\t' ??Initialize all locations and TBC's to zero\n\t\t\t\t\t\t' [* To insure consistency, tool needs to be at nomimal \"Full Step\" position.\n ' So this macro is best run just after powering-on your Handibot.]\n\n'[Z Axis is set first to make sure cutter is clear before making X or Y move.]\n'Z-Axis Set Zero Routine (setting the Table Base Zero Coordinate; BASED ON CUTTER LENGTH OFFSET)\n\tMZ, 5.0\t\t\t\t' Hit Top Hardstop\n\tPAUSE .25\n MZ, 4.5\t\t\t\t' Position for final approach\n VS, ,5\t\t\t\t' ... approach fast (less force)\n VR, ,1000 ' ... limit ramp bounce\n MZ, 5.5\n\t&z_dist = 0.0 + $current_cutter_Zoffset ' This persistent var = distance for Z move from tip at 0 til top stop\n VA, ,, &z_dist,,,,,, &z_dist ' Set Z Table Base Coordinate (offset to Zero) \n VS, ,4\t\t\t\t' ... reset\n\tVR, ,50\n\t&tempPark = $current_cutter_Zoffset - .25 ' about as high as you can safely be\n\tMZ, &tempPark\t\t' Move to Z-Zero // Z-Zero location now accurate\n\n'X-Axis Set Zero Routine (setting the Table Base Zero Coordinate)\n\tMX, 7.0\t\t\t\t' Hit Right-Side Hardstop\n\tPAUSE .25\n MX, 6.0\t\t\t\t' Position for final approach\n VS, 5\t\t\t\t' ... approach fast (less force)\n VR, 1000 ' ... limit ramp bounce\n MX, 8.0\n\tPAUSE .25\n\t&temp_loc = 6 + $x_backoff\n VA, &temp_loc,,,,,, &temp_loc ' Set X Table Base Coordinate (offset to Zero) \n VS, 4\t\t\t\t' ... reset\n\tVR, 50\t\t\t\n\tMX, 0.0\t\t\t\t' Move to X-Zero // X-Zero location now accurate\n\n'Y-Axis Set Zero Routine (setting the Table Base Zero Coordinate)\n\tMY, 9.0\t\t\t\t' Hit Rear Hardstop\n\tPAUSE .25\n MY, 8.0\t\t\t\t' Position for final approach\n VS, 5\t\t\t\t' ... approach fast (less force)\n VR, 1000 ' ... limit ramp bounce\n MY, 10.0\n\tPAUSE .25\n\t&temp_loc = 8 + $y_backoff\n VA, ,&temp_loc ,,,,,, &temp_loc' Set Y Table Base Coordinate (offset to Zero) \n VS, 4\t\t\t\t' ... reset\n\tVR, 50\t\t\t\n\tMY, 0.0\t\t\t\t' Move to Y-Zero // Y-Zero location now accurate\n\n\n' Reset Starting Values\n VS, &startXY_speed, &startZ_speed\n VR, &startXY_ramp, &startZ_ramp\n\nEND","index":3,"type":"sbp"} [sbp] debug: _setupTransforms [sbp] debug: Transforms configured... [sbp] debug: Labels analyzed... [sbp] debug: GOTOs analyzed... [sbp] debug: emit_gcode = G90 [sbp] debug: Rainbows organized... [sbp] info: Starting OpenSBP program [sbp] info: Got a machine state change: running [machine] debug: Non-Stack break: {"type":"comment","comment":["!FABMO!name:Set Zero Locations"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["!FABMO!description:Automatically Set Axis Zero for XYZ"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Set XYZ Zero Locations -- MACRO #3 -- [C3] in OpenSBP Language // HANDIBOT VERSION"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[" ... written in OpenSBP; 3/1/2016 th"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Initialize"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Read Offset or Set Defaults"]} [sbp] debug: Non-Stack break: {"type":"weak_assign","var":"$current_cutter_Zoffset","expr":".25"} [sbp] debug: Non-Stack break: {"type":"weak_assign","var":"$x_backoff","expr":".075"} [sbp] debug: Non-Stack break: {"type":"weak_assign","var":"$y_backoff","expr":".075"} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Get Speeds at Startup"]} [sbp] debug: Stack break: {"type":"assign","var":"&startXY_speed","expr":"%(71)"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Returning from run... [sbp] debug: Stack break: {"type":"assign","var":"&startXY_speed","expr":"%(71)"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&startXY_speed","expr":"%(71)"} [sbp] debug: Cancelling AP collapse (AP button was released) [machine] debug: Stack break: {"type":"assign","var":"&startZ_speed","expr":"%(73)"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&startZ_speed","expr":"%(73)"} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Get Acc/Dec Ramps at Startup"]} [sbp] debug: Stack break: {"type":"assign","var":"&startXY_ramp","expr":"%(81)","comment":[" X and Y ramps are the same, treated as single parameter in OpenSBP"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&startXY_ramp","expr":"%(81)","comment":[" X and Y ramps are the same, treated as single parameter in OpenSBP"]} [sbp] debug: Stack break: {"type":"assign","var":"&startZ_ramp","expr":"%(83)"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&startZ_ramp","expr":"%(83)"} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":[4,4],"comment":[" Set Approach Speeds"]} [sbp] debug: Calling handler for VS With arguments: [4,4,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[250,250],"comment":[" Set Aggressive Ramp to reduce pounding ..."]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":[250,250],"comment":[" Set Aggressive Ramp to reduce pounding ..."]} [sbp] debug: Calling handler for VR With arguments: [250,250,,,,,,,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"ZT","args":[null],"comment":[" ??Initialize all locations and TBC","s to zero"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"ZT","args":[null],"comment":[" ??Initialize all locations and TBC","s to zero"]} [sbp] warn: More parameters passed into ZT (1) than are supported by the command. (0) [sbp] debug: Calling handler for ZT With arguments: [] [sbp] debug: emit_gcode = G28.3 X0 Y0 Z0 [sbp] debug: Saving config to /opt/fabmo/config/g2.json [config] debug: fsync()ed /opt/fabmo/config/g2.json [config] debug: Non-Stack break: {"type":"comment","comment":[" [* To insure consistency, tool needs to be at nomimal \"Full Step\" position."]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[" So this macro is best run just after powering-on your Handibot.]"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["[Z Axis is set first to make sure cutter is clear before making X or Y move.]"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Z-Axis Set Zero Routine (setting the Table Base Zero Coordinate; BASED ON CUTTER LENGTH OFFSET)"]} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MZ","args":[5],"comment":[" Hit Top Hardstop"]} [sbp] debug: Calling handler for MZ With arguments: [5] [sbp] debug: Emit_move: G1 {"Z":5,"F":240} [sbp] debug: emit_move: N0"G1Z5.00000F240.00000" [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"pause","expr":".25"} [sbp] debug: emit_gcode = G4 P0.25 [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MZ","args":[4.5],"comment":[" Position for final approach"]} [sbp] debug: Calling handler for MZ With arguments: [4.5] [sbp] debug: Emit_move: G1 {"Z":4.5,"F":240} [sbp] debug: emit_move: N0"G1Z4.50000F240.00000" [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":[null,5],"comment":[" ... approach fast (less force)"]} [sbp] debug: Calling handler for VS With arguments: [,5,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[null,1000],"comment":[" ... limit ramp bounce"]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[null,1000],"comment":[" ... limit ramp bounce"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":[null,1000],"comment":[" ... limit ramp bounce"]} [sbp] debug: Calling handler for VR With arguments: [,1000,,,,,,,,,,,,,,] [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MZ","args":[5.5]} [sbp] debug: Calling handler for MZ With arguments: [5.5] [sbp] debug: Emit_move: G1 {"Z":5.5,"F":300} [sbp] debug: emit_move: N0"G1Z5.50000F300.00000" [sbp] debug: Stack break: {"type":"assign","var":"&z_dist","expr":{"left":0,"right":"$current_cutter_Zoffset","op":"+"},"comment":[" This persistent var = distance for Z move from tip at 0 til top stop"]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"assign","var":"&z_dist","expr":{"left":0,"right":"$current_cutter_Zoffset","op":"+"},"comment":[" This persistent var = distance for Z move from tip at 0 til top stop"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&z_dist","expr":{"left":0,"right":"$current_cutter_Zoffset","op":"+"},"comment":[" This persistent var = distance for Z move from tip at 0 til top stop"]} [sbp] debug: Stack break: {"type":"cmd","cmd":"VA","args":["","","&z_dist","","","","","","&z_dist"],"comment":[" Set Z Table Base Coordinate (offset to Zero) "]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VA","args":["","","&z_dist","","","","","","&z_dist"],"comment":[" Set Z Table Base Coordinate (offset to Zero) "]} [sbp] debug: Calling handler for VA With arguments: [,,3.353,,,,,,3.353,,,] [sbp] debug: VA Command: ,,3.353,,,,,,3.353,,, [sbp] debug: emit_gcode = G28.3 Z3.353 [sbp] debug: Saving config to /opt/fabmo/config/g2.json [config] debug: fsync()ed /opt/fabmo/config/g2.json [config] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":[null,4],"comment":[" ... reset"]} [sbp] debug: Calling handler for VS With arguments: [,4,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[null,50]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[null,50]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":[null,50]} [sbp] debug: Calling handler for VR With arguments: [,50,,,,,,,,,,,,,,] [sbp] debug: Stack break: {"type":"assign","var":"&tempPark","expr":{"left":"$current_cutter_Zoffset","right":".25","op":"-"},"comment":[" about as high as you can safely be"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&tempPark","expr":{"left":"$current_cutter_Zoffset","right":".25","op":"-"},"comment":[" about as high as you can safely be"]} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MZ","args":["&tempPark"],"comment":[" Move to Z-Zero // Z-Zero location now accurate"]} [sbp] debug: Calling handler for MZ With arguments: [3.103] [sbp] debug: Emit_move: G1 {"Z":3.103,"F":240} [sbp] debug: emit_move: N0"G1Z3.10300F240.00000" [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["X-Axis Set Zero Routine (setting the Table Base Zero Coordinate)"]} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MX","args":[7],"comment":[" Hit Right-Side Hardstop"]} [sbp] debug: Calling handler for MX With arguments: [7] [sbp] debug: Emit_move: G1 {"X":7,"F":240} [sbp] debug: emit_move: N0"G1X7.00000F240.00000" [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"pause","expr":".25"} [sbp] debug: emit_gcode = G4 P0.25 [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MX","args":[6],"comment":[" Position for final approach"]} [sbp] debug: Calling handler for MX With arguments: [6] [sbp] debug: Emit_move: G1 {"X":6,"F":240} [sbp] debug: emit_move: N0"G1X6.00000F240.00000" [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":[5],"comment":[" ... approach fast (less force)"]} [sbp] debug: Calling handler for VS With arguments: [5,,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[1000],"comment":[" ... limit ramp bounce"]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[1000],"comment":[" ... limit ramp bounce"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":[1000],"comment":[" ... limit ramp bounce"]} [sbp] debug: Calling handler for VR With arguments: [1000,,,,,,,,,,,,,,,] [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MX","args":[8]} [sbp] debug: Calling handler for MX With arguments: [8] [sbp] debug: Emit_move: G1 {"X":8,"F":300} [sbp] debug: emit_move: N0"G1X8.00000F300.00000" [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"pause","expr":".25"} [sbp] debug: emit_gcode = G4 P0.25 [sbp] debug: Stack break: {"type":"assign","var":"&temp_loc","expr":{"left":6,"right":"$x_backoff","op":"+"}} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Stack break: {"type":"assign","var":"&temp_loc","expr":{"left":6,"right":"$x_backoff","op":"+"}} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&temp_loc","expr":{"left":6,"right":"$x_backoff","op":"+"}} [sbp] debug: Stack break: {"type":"cmd","cmd":"VA","args":["&temp_loc","","","","","","&temp_loc"],"comment":[" Set X Table Base Coordinate (offset to Zero) "]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VA","args":["&temp_loc","","","","","","&temp_loc"],"comment":[" Set X Table Base Coordinate (offset to Zero) "]} [sbp] debug: Calling handler for VA With arguments: [6.075,,,,,,6.075,,,,,] [sbp] debug: VA Command: 6.075,,,,,,6.075,,,,, [sbp] debug: emit_gcode = G28.3 X6.075 [sbp] debug: g55X0 MPO.x = 154.304998981587 args[0] = 6.075 [sbp] debug: Saving config to /opt/fabmo/config/g2.json [config] debug: fsync()ed /opt/fabmo/config/g2.json [config] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":[4],"comment":[" ... reset"]} [sbp] debug: Calling handler for VS With arguments: [4,,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[50]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[50]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":[50]} [sbp] debug: Calling handler for VR With arguments: [50,,,,,,,,,,,,,,,] [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MX","args":[0],"comment":[" Move to X-Zero // X-Zero location now accurate"]} [sbp] debug: Calling handler for MX With arguments: [0] [sbp] debug: Emit_move: G1 {"X":0,"F":240} [sbp] debug: emit_move: N0"G1X0.00000F240.00000" [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Y-Axis Set Zero Routine (setting the Table Base Zero Coordinate)"]} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MY","args":[9],"comment":[" Hit Rear Hardstop"]} [sbp] debug: Calling handler for MY With arguments: [9] [sbp] debug: Emit_move: G1 {"Y":9,"F":240} [sbp] debug: emit_move: N0"G1Y9.00000F240.00000" [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"pause","expr":".25"} [sbp] debug: emit_gcode = G4 P0.25 [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MY","args":[8],"comment":[" Position for final approach"]} [sbp] debug: Calling handler for MY With arguments: [8] [sbp] debug: Emit_move: G1 {"Y":8,"F":240} [sbp] debug: emit_move: N0"G1Y8.00000F240.00000" [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":[5],"comment":[" ... approach fast (less force)"]} [sbp] debug: Calling handler for VS With arguments: [5,,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[1000],"comment":[" ... limit ramp bounce"]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[1000],"comment":[" ... limit ramp bounce"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":[1000],"comment":[" ... limit ramp bounce"]} [sbp] debug: Calling handler for VR With arguments: [1000,,,,,,,,,,,,,,,] [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MY","args":[10]} [sbp] debug: Calling handler for MY With arguments: [10] [sbp] debug: Emit_move: G1 {"Y":10,"F":300} [sbp] debug: emit_move: N0"G1Y10.00000F300.00000" [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"pause","expr":".25"} [sbp] debug: emit_gcode = G4 P0.25 [sbp] debug: Stack break: {"type":"assign","var":"&temp_loc","expr":{"left":8,"right":"$y_backoff","op":"+"}} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Stack break: {"type":"assign","var":"&temp_loc","expr":{"left":8,"right":"$y_backoff","op":"+"}} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&temp_loc","expr":{"left":8,"right":"$y_backoff","op":"+"}} [sbp] debug: Stack break: {"type":"cmd","cmd":"VA","args":["","&temp_loc","","","","","","&temp_loc"],"comment":[" Set Y Table Base Coordinate (offset to Zero) "]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VA","args":["","&temp_loc","","","","","","&temp_loc"],"comment":[" Set Y Table Base Coordinate (offset to Zero) "]} [sbp] debug: Calling handler for VA With arguments: [,8.075,,,,,,8.075,,,,] [sbp] debug: VA Command: ,8.075,,,,,,8.075,,,, [sbp] debug: emit_gcode = G28.3 Y8.075 [sbp] debug: g55Y0 MPO.y = 205.10499864630697 args[1] = 8.075 [sbp] debug: Saving config to /opt/fabmo/config/g2.json [config] debug: fsync()ed /opt/fabmo/config/g2.json [config] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":[4],"comment":[" ... reset"]} [sbp] debug: Calling handler for VS With arguments: [4,,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[50]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[50]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":[50]} [sbp] debug: Calling handler for VR With arguments: [50,,,,,,,,,,,,,,,] [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MY","args":[0],"comment":[" Move to Y-Zero // Y-Zero location now accurate"]} [sbp] debug: Calling handler for MY With arguments: [0] [sbp] debug: Emit_move: G1 {"Y":0,"F":240} [sbp] debug: emit_move: N0"G1Y0.00000F240.00000" [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[" Reset Starting Values"]} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":["&startXY_speed","&startZ_speed"]} [sbp] debug: Calling handler for VS With arguments: [1,0.5,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":["&startXY_ramp","&startZ_ramp"]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":["&startXY_ramp","&startZ_ramp"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":["&startXY_ramp","&startZ_ramp"]} [sbp] debug: Calling handler for VR With arguments: [50,50,,,,,,,,,,,,,,] [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"end","message":null} [sbp] info: End of program reached. (pc = 71) [sbp] info: No g-codes remain to dispatch. [sbp] debug: Doing the nested end. [sbp] debug: Calling the nested end. [sbp] info: End of program reached. (pc = 1) [sbp] info: No g-codes remain to dispatch. [sbp] debug: Doing the outermost end. [sbp] debug: Calling the non-nested (toplevel) end [sbp] info: Setting driver units to INCH [g2] debug: Saving config to /opt/fabmo/config/g2.json [config] debug: fsync()ed /opt/fabmo/config/g2.json [config] info: Setting driver units to INCH [g2] info: Machine is authorized for the next 30 seconds. [machine] info: Got a machine state change: idle [machine] debug: Saving config to /opt/fabmo/config/instance.json [config] debug: fsync()ed /opt/fabmo/config/instance.json [config] debug: _setupTransforms [sbp] debug: Transforms configured... [sbp] debug: Labels analyzed... [sbp] debug: GOTOs analyzed... [sbp] debug: emit_gcode = G90 [sbp] debug: Rainbows organized... [sbp] info: Starting OpenSBP program [sbp] info: Got a machine state change: running [machine] debug: Non-Stack break: {"type":"cmd","cmd":"M2","args":[3,4]} [sbp] debug: Calling handler for M2 With arguments: [3,4] [sbp] debug: X param = 3 Y param = 4 [sbp] debug: (process_move)movespeed_xy = 1 [sbp] debug: Emit_move: G1 {"X":3,"Y":4,"F":60} [sbp] debug: emit_move: N0"G1X3.00000Y4.00000F60.00000" [sbp] info: End of program reached. (pc = 1) [sbp] info: Dispatching final g-codes [sbp] debug: Returning from run... [sbp] debug: Expected a running state change and got one. [sbp] info: End of program reached. (pc = 1) [sbp] info: No g-codes remain to dispatch. [sbp] debug: Doing the outermost end. [sbp] debug: Calling the non-nested (toplevel) end [sbp] info: Setting driver units to INCH [g2] debug: Saving config to /opt/fabmo/config/g2.json [config] debug: fsync()ed /opt/fabmo/config/g2.json [config] info: Setting driver units to INCH [g2] info: Machine is authorized for the next 30 seconds. [machine] info: Got a machine state change: idle [machine] debug: Saving config to /opt/fabmo/config/instance.json [config] debug: fsync()ed /opt/fabmo/config/instance.json [config] debug: _setupTransforms [sbp] debug: Transforms configured... [sbp] debug: Labels analyzed... [sbp] debug: GOTOs analyzed... [sbp] debug: emit_gcode = G90 [sbp] debug: Rainbows organized... [sbp] info: Starting OpenSBP program [sbp] info: Got a machine state change: running [machine] debug: Stack break: {"type":"cmd","cmd":"MH","args":[null]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Returning from run... [sbp] debug: Stack break: {"type":"cmd","cmd":"MH","args":[null]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"MH","args":[null]} [sbp] warn: More parameters passed into MH (1) than are supported by the command. (0) [sbp] debug: Calling handler for MH With arguments: [] [sbp] debug: MH [sbp] debug: z = 3.103 [sbp] debug: Emit_move: G1 {"X":0,"Y":0,"F":60} [sbp] debug: emit_move: N0"G1X0.00000Y0.00000F60.00000" [sbp] info: End of program reached. (pc = 1) [sbp] info: Dispatching final g-codes [sbp] debug: Expected a running state change and got one. [sbp] info: End of program reached. (pc = 1) [sbp] info: No g-codes remain to dispatch. [sbp] debug: Doing the outermost end. [sbp] debug: Calling the non-nested (toplevel) end [sbp] info: Setting driver units to INCH [g2] debug: Saving config to /opt/fabmo/config/g2.json [config] debug: fsync()ed /opt/fabmo/config/g2.json [config] info: Setting driver units to INCH [g2] info: Machine is authorized for the next 30 seconds. [machine] info: Got a machine state change: idle [machine] debug: Saving config to /opt/fabmo/config/instance.json [config] debug: fsync()ed /opt/fabmo/config/instance.json [config] debug: _setupTransforms [sbp] debug: Transforms configured... [sbp] debug: Labels analyzed... [sbp] debug: GOTOs analyzed... [sbp] debug: emit_gcode = G90 [sbp] debug: Rainbows organized... [sbp] info: Starting OpenSBP program [sbp] info: Got a machine state change: running [machine] debug: Stack break: {"type":"cmd","cmd":"C_POUND","args":[2]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Returning from run... [sbp] debug: Stack break: {"type":"cmd","cmd":"C_POUND","args":[2]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"C_POUND","args":[2]} [sbp] debug: Calling handler for C_POUND With arguments: [2] [sbp] debug: Running macro: {"name":"Reset Cutter Length","description":"... defines offset for Z-Zero location for #3, and sets Axis Zero for Z (use after changing cutter","filename":"/opt/fabmo/macros/macro_2.sbp","content":"'Reset Cutter Length (sometimes called Z-Zero) -- MACRO #2 -- [C2] in OpenSBP Language // HANDIBOT VERSION\n' ... written in OpenSBP; 3/1/2016 th\n\n'==> Determines the cutter length offset for automated setting of Z-Axis Zero in Macro #3\n' And, it is simultaneously setting the new Axis Zero for Z\n\n'Initialize\n\n 'Do an XYZ Zero so all axes are in a known location so we go to the right target location for zeroing\n C3 ' calls Macro#3 \n\n 'Then, Move to Zeoring Target Location\n M2, 6, 0\n \n '(... next lines displays; feature of OpenSBP)\n 'Attach Aligator Clip to Cutter Shank and Swing-Out Target (-Continue- when Ready)\n PAUSE\n\n 'Make sure we're not accidentally in electrical contact with target \n' IF %(51) = 1 THEN GOTO Already_Triggered ' *not working yet ...\n\n 'Set Zero Plate Adder (i.e. thickness) if not present\n $zero_plate_adder := .75\n \n 'Remove the Cutter Offset Contribution to Location \n VA,,, -.25,,,,,, -.25\n\n 'Get Speeds at Startup\n\t\t&startXY_speed = %(71)\n\t\t&startZ_speed = %(73)\n\t\t&startZ_ramp = %(83)\n\n 'Starting Settings for Measuring Z\n VS, 4, .5 \n &Z_plunge_target = -5\n &Z_pullup = .5\n &Z_final = $zero_plate_adder + .25\n\n'HERE WE GO ! .............................................................\n 'Next command creates an interrupt handler for contact with zero plate\n VS,,0.5\n VR,, 10000 ' quick stop\n ON INPUT(1,1) GOTO afterHit\n MZ, &Z_plunge_target\n GOTO FAIL\n afterHit:\n GOSUB Backoff\n\n 'Now, let's do again with a touch at a reliable distance and speed\n VS,,.25\n VR,, 10000 ' quick stop\n ON INPUT(1,1) GOTO Finish\n MZ, &Z_plunge_target\n GOTO FAIL\n Finish:\n GOSUB Backoff\n\n 'Set Location and Zero\n $current_cutter_Zoffset = (-1 * %(3)) + $zero_plate_adder + &Z_pullup ' remember we're pulled up here\n &new_base_Z_loc = &Z_pullup + $zero_plate_adder\n VA,,, &new_base_Z_loc,,,,,, &new_base_Z_loc\n\n 'Restore Values\n VS, &startXY_speed, &startZ_speed\n VR, , &startZ_ramp \n MZ, &Z_final \n\n 'Measurement Complete. REMOVE Alligator Clip and PARK Target !! (-Continue- when Done)\n PAUSE\n\n '{{Eventually we'd like a choice here to move home or to park}}\n \nEND\n\n'SUBROUTINES BELOW HERE ---------------------------\n\nBackoff:\n &NextPullUp = %(3)\n &NextPullUp = &NextPullUp + &Z_pullup\n MZ, &NextPullUp\n RETURN\n\nFAIL:\n VS, &startXY_speed, &startZ_speed\n VR, , &startZ_ramp \n 'No Contact with Plate ... Ending!\n PAUSE\n END\n\nAlready_Triggered:\n 'Z-contact seems already triggered ... Ending!\n PAUSE\n END\n \n","index":2,"type":"sbp"} [sbp] debug: _setupTransforms [sbp] debug: Transforms configured... [sbp] debug: Labels analyzed... [sbp] debug: GOTOs analyzed... [sbp] debug: emit_gcode = G90 [sbp] debug: Rainbows organized... [sbp] info: Starting OpenSBP program [sbp] info: Got a machine state change: running [machine] debug: Non-Stack break: {"type":"comment","comment":["!FABMO!name:Reset Cutter Length"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["!FABMO!description:... defines offset for Z-Zero location for #3, and sets Axis Zero for Z (use after changing cutter"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Reset Cutter Length (sometimes called Z-Zero) -- MACRO #2 -- [C2] in OpenSBP Language // HANDIBOT VERSION"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[" ... written in OpenSBP; 3/1/2016 th"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["==> Determines the cutter length offset for automated setting of Z-Axis Zero in Macro #3"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[" And, it is simultaneously setting the new Axis Zero for Z"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Initialize"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Do an XYZ Zero so all axes are in a known location so we go to the right target location for zeroing"]} [sbp] debug: Stack break: {"type":"custom","index":3,"comment":[" calls Macro#3 "]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Returning from run... [sbp] debug: Stack break: {"type":"custom","index":3,"comment":[" calls Macro#3 "]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"custom","index":3,"comment":[" calls Macro#3 "]} [sbp] debug: Running macro: {"name":"Set Zero Locations","description":"Automatically Set Axis Zero for XYZ","filename":"/opt/fabmo/macros/macro_3.sbp","content":"'Set XYZ Zero Locations -- MACRO #3 -- [C3] in OpenSBP Language // HANDIBOT VERSION\n' ... written in OpenSBP; 3/1/2016 th\n\n'Initialize\n 'Read Offset or Set Defaults\n $current_cutter_Zoffset := .25\n $x_backoff := .075\n $y_backoff := .075\n 'Get Speeds at Startup\n\t\t&startXY_speed = %(71)\n\t\t&startZ_speed = %(73)\n\t'Get Acc/Dec Ramps at Startup\n\t\t&startXY_ramp = %(81) ' X and Y ramps are the same, treated as single parameter in OpenSBP\n\t\t&startZ_ramp = %(83)\n VS, 4,4\t\t\t\t' Set Approach Speeds\n VR, 250, 250 \t' Set Aggressive Ramp to reduce pounding ...\n\tZT,\t\t\t\t\t' ??Initialize all locations and TBC's to zero\n\t\t\t\t\t\t' [* To insure consistency, tool needs to be at nomimal \"Full Step\" position.\n ' So this macro is best run just after powering-on your Handibot.]\n\n'[Z Axis is set first to make sure cutter is clear before making X or Y move.]\n'Z-Axis Set Zero Routine (setting the Table Base Zero Coordinate; BASED ON CUTTER LENGTH OFFSET)\n\tMZ, 5.0\t\t\t\t' Hit Top Hardstop\n\tPAUSE .25\n MZ, 4.5\t\t\t\t' Position for final approach\n VS, ,5\t\t\t\t' ... approach fast (less force)\n VR, ,1000 ' ... limit ramp bounce\n MZ, 5.5\n\t&z_dist = 0.0 + $current_cutter_Zoffset ' This persistent var = distance for Z move from tip at 0 til top stop\n VA, ,, &z_dist,,,,,, &z_dist ' Set Z Table Base Coordinate (offset to Zero) \n VS, ,4\t\t\t\t' ... reset\n\tVR, ,50\n\t&tempPark = $current_cutter_Zoffset - .25 ' about as high as you can safely be\n\tMZ, &tempPark\t\t' Move to Z-Zero // Z-Zero location now accurate\n\n'X-Axis Set Zero Routine (setting the Table Base Zero Coordinate)\n\tMX, 7.0\t\t\t\t' Hit Right-Side Hardstop\n\tPAUSE .25\n MX, 6.0\t\t\t\t' Position for final approach\n VS, 5\t\t\t\t' ... approach fast (less force)\n VR, 1000 ' ... limit ramp bounce\n MX, 8.0\n\tPAUSE .25\n\t&temp_loc = 6 + $x_backoff\n VA, &temp_loc,,,,,, &temp_loc ' Set X Table Base Coordinate (offset to Zero) \n VS, 4\t\t\t\t' ... reset\n\tVR, 50\t\t\t\n\tMX, 0.0\t\t\t\t' Move to X-Zero // X-Zero location now accurate\n\n'Y-Axis Set Zero Routine (setting the Table Base Zero Coordinate)\n\tMY, 9.0\t\t\t\t' Hit Rear Hardstop\n\tPAUSE .25\n MY, 8.0\t\t\t\t' Position for final approach\n VS, 5\t\t\t\t' ... approach fast (less force)\n VR, 1000 ' ... limit ramp bounce\n MY, 10.0\n\tPAUSE .25\n\t&temp_loc = 8 + $y_backoff\n VA, ,&temp_loc ,,,,,, &temp_loc' Set Y Table Base Coordinate (offset to Zero) \n VS, 4\t\t\t\t' ... reset\n\tVR, 50\t\t\t\n\tMY, 0.0\t\t\t\t' Move to Y-Zero // Y-Zero location now accurate\n\n\n' Reset Starting Values\n VS, &startXY_speed, &startZ_speed\n VR, &startXY_ramp, &startZ_ramp\n\nEND","index":3,"type":"sbp"} [sbp] debug: _setupTransforms [sbp] debug: Transforms configured... [sbp] debug: Labels analyzed... [sbp] debug: GOTOs analyzed... [sbp] debug: emit_gcode = G90 [sbp] debug: Rainbows organized... [sbp] info: Starting OpenSBP program [sbp] info: Got a machine state change: running [machine] debug: Non-Stack break: {"type":"comment","comment":["!FABMO!name:Set Zero Locations"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["!FABMO!description:Automatically Set Axis Zero for XYZ"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Set XYZ Zero Locations -- MACRO #3 -- [C3] in OpenSBP Language // HANDIBOT VERSION"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[" ... written in OpenSBP; 3/1/2016 th"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Initialize"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Read Offset or Set Defaults"]} [sbp] debug: Non-Stack break: {"type":"weak_assign","var":"$current_cutter_Zoffset","expr":".25"} [sbp] debug: Non-Stack break: {"type":"weak_assign","var":"$x_backoff","expr":".075"} [sbp] debug: Non-Stack break: {"type":"weak_assign","var":"$y_backoff","expr":".075"} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Get Speeds at Startup"]} [sbp] debug: Stack break: {"type":"assign","var":"&startXY_speed","expr":"%(71)"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Returning from run... [sbp] debug: Stack break: {"type":"assign","var":"&startXY_speed","expr":"%(71)"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&startXY_speed","expr":"%(71)"} [sbp] debug: Stack break: {"type":"assign","var":"&startZ_speed","expr":"%(73)"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&startZ_speed","expr":"%(73)"} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Get Acc/Dec Ramps at Startup"]} [sbp] debug: Stack break: {"type":"assign","var":"&startXY_ramp","expr":"%(81)","comment":[" X and Y ramps are the same, treated as single parameter in OpenSBP"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&startXY_ramp","expr":"%(81)","comment":[" X and Y ramps are the same, treated as single parameter in OpenSBP"]} [sbp] debug: Stack break: {"type":"assign","var":"&startZ_ramp","expr":"%(83)"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&startZ_ramp","expr":"%(83)"} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":[4,4],"comment":[" Set Approach Speeds"]} [sbp] debug: Calling handler for VS With arguments: [4,4,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[250,250],"comment":[" Set Aggressive Ramp to reduce pounding ..."]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":[250,250],"comment":[" Set Aggressive Ramp to reduce pounding ..."]} [sbp] debug: Calling handler for VR With arguments: [250,250,,,,,,,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"ZT","args":[null],"comment":[" ??Initialize all locations and TBC","s to zero"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"ZT","args":[null],"comment":[" ??Initialize all locations and TBC","s to zero"]} [sbp] warn: More parameters passed into ZT (1) than are supported by the command. (0) [sbp] debug: Calling handler for ZT With arguments: [] [sbp] debug: emit_gcode = G28.3 X0 Y0 Z0 [sbp] debug: Saving config to /opt/fabmo/config/g2.json [config] debug: fsync()ed /opt/fabmo/config/g2.json [config] debug: Non-Stack break: {"type":"comment","comment":[" [* To insure consistency, tool needs to be at nomimal \"Full Step\" position."]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[" So this macro is best run just after powering-on your Handibot.]"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["[Z Axis is set first to make sure cutter is clear before making X or Y move.]"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Z-Axis Set Zero Routine (setting the Table Base Zero Coordinate; BASED ON CUTTER LENGTH OFFSET)"]} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MZ","args":[5],"comment":[" Hit Top Hardstop"]} [sbp] debug: Calling handler for MZ With arguments: [5] [sbp] debug: Emit_move: G1 {"Z":5,"F":240} [sbp] debug: emit_move: N0"G1Z5.00000F240.00000" [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"pause","expr":".25"} [sbp] debug: emit_gcode = G4 P0.25 [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MZ","args":[4.5],"comment":[" Position for final approach"]} [sbp] debug: Calling handler for MZ With arguments: [4.5] [sbp] debug: Emit_move: G1 {"Z":4.5,"F":240} [sbp] debug: emit_move: N0"G1Z4.50000F240.00000" [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":[null,5],"comment":[" ... approach fast (less force)"]} [sbp] debug: Calling handler for VS With arguments: [,5,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[null,1000],"comment":[" ... limit ramp bounce"]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[null,1000],"comment":[" ... limit ramp bounce"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":[null,1000],"comment":[" ... limit ramp bounce"]} [sbp] debug: Calling handler for VR With arguments: [,1000,,,,,,,,,,,,,,] [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MZ","args":[5.5]} [sbp] debug: Calling handler for MZ With arguments: [5.5] [sbp] debug: Emit_move: G1 {"Z":5.5,"F":300} [sbp] debug: emit_move: N0"G1Z5.50000F300.00000" [sbp] debug: Stack break: {"type":"assign","var":"&z_dist","expr":{"left":0,"right":"$current_cutter_Zoffset","op":"+"},"comment":[" This persistent var = distance for Z move from tip at 0 til top stop"]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"assign","var":"&z_dist","expr":{"left":0,"right":"$current_cutter_Zoffset","op":"+"},"comment":[" This persistent var = distance for Z move from tip at 0 til top stop"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&z_dist","expr":{"left":0,"right":"$current_cutter_Zoffset","op":"+"},"comment":[" This persistent var = distance for Z move from tip at 0 til top stop"]} [sbp] debug: Stack break: {"type":"cmd","cmd":"VA","args":["","","&z_dist","","","","","","&z_dist"],"comment":[" Set Z Table Base Coordinate (offset to Zero) "]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VA","args":["","","&z_dist","","","","","","&z_dist"],"comment":[" Set Z Table Base Coordinate (offset to Zero) "]} [sbp] debug: Calling handler for VA With arguments: [,,3.353,,,,,,3.353,,,] [sbp] debug: VA Command: ,,3.353,,,,,,3.353,,, [sbp] debug: emit_gcode = G28.3 Z3.353 [sbp] debug: Saving config to /opt/fabmo/config/g2.json [config] debug: fsync()ed /opt/fabmo/config/g2.json [config] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":[null,4],"comment":[" ... reset"]} [sbp] debug: Calling handler for VS With arguments: [,4,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[null,50]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[null,50]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":[null,50]} [sbp] debug: Calling handler for VR With arguments: [,50,,,,,,,,,,,,,,] [sbp] debug: Stack break: {"type":"assign","var":"&tempPark","expr":{"left":"$current_cutter_Zoffset","right":".25","op":"-"},"comment":[" about as high as you can safely be"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&tempPark","expr":{"left":"$current_cutter_Zoffset","right":".25","op":"-"},"comment":[" about as high as you can safely be"]} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MZ","args":["&tempPark"],"comment":[" Move to Z-Zero // Z-Zero location now accurate"]} [sbp] debug: Calling handler for MZ With arguments: [3.103] [sbp] debug: Emit_move: G1 {"Z":3.103,"F":240} [sbp] debug: emit_move: N0"G1Z3.10300F240.00000" [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["X-Axis Set Zero Routine (setting the Table Base Zero Coordinate)"]} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MX","args":[7],"comment":[" Hit Right-Side Hardstop"]} [sbp] debug: Calling handler for MX With arguments: [7] [sbp] debug: Emit_move: G1 {"X":7,"F":240} [sbp] debug: emit_move: N0"G1X7.00000F240.00000" [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"pause","expr":".25"} [sbp] debug: emit_gcode = G4 P0.25 [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MX","args":[6],"comment":[" Position for final approach"]} [sbp] debug: Calling handler for MX With arguments: [6] [sbp] debug: Emit_move: G1 {"X":6,"F":240} [sbp] debug: emit_move: N0"G1X6.00000F240.00000" [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":[5],"comment":[" ... approach fast (less force)"]} [sbp] debug: Calling handler for VS With arguments: [5,,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[1000],"comment":[" ... limit ramp bounce"]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[1000],"comment":[" ... limit ramp bounce"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":[1000],"comment":[" ... limit ramp bounce"]} [sbp] debug: Calling handler for VR With arguments: [1000,,,,,,,,,,,,,,,] [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MX","args":[8]} [sbp] debug: Calling handler for MX With arguments: [8] [sbp] debug: Emit_move: G1 {"X":8,"F":300} [sbp] debug: emit_move: N0"G1X8.00000F300.00000" [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"pause","expr":".25"} [sbp] debug: emit_gcode = G4 P0.25 [sbp] debug: Stack break: {"type":"assign","var":"&temp_loc","expr":{"left":6,"right":"$x_backoff","op":"+"}} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Stack break: {"type":"assign","var":"&temp_loc","expr":{"left":6,"right":"$x_backoff","op":"+"}} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&temp_loc","expr":{"left":6,"right":"$x_backoff","op":"+"}} [sbp] debug: Stack break: {"type":"cmd","cmd":"VA","args":["&temp_loc","","","","","","&temp_loc"],"comment":[" Set X Table Base Coordinate (offset to Zero) "]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VA","args":["&temp_loc","","","","","","&temp_loc"],"comment":[" Set X Table Base Coordinate (offset to Zero) "]} [sbp] debug: Calling handler for VA With arguments: [6.075,,,,,,6.075,,,,,] [sbp] debug: VA Command: 6.075,,,,,,6.075,,,,, [sbp] debug: emit_gcode = G28.3 X6.075 [sbp] debug: g55X0 MPO.x = 154.304998981587 args[0] = 6.075 [sbp] debug: Saving config to /opt/fabmo/config/g2.json [config] debug: fsync()ed /opt/fabmo/config/g2.json [config] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":[4],"comment":[" ... reset"]} [sbp] debug: Calling handler for VS With arguments: [4,,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[50]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[50]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":[50]} [sbp] debug: Calling handler for VR With arguments: [50,,,,,,,,,,,,,,,] [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MX","args":[0],"comment":[" Move to X-Zero // X-Zero location now accurate"]} [sbp] debug: Calling handler for MX With arguments: [0] [sbp] debug: Emit_move: G1 {"X":0,"F":240} [sbp] debug: emit_move: N0"G1X0.00000F240.00000" [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Y-Axis Set Zero Routine (setting the Table Base Zero Coordinate)"]} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MY","args":[9],"comment":[" Hit Rear Hardstop"]} [sbp] debug: Calling handler for MY With arguments: [9] [sbp] debug: Emit_move: G1 {"Y":9,"F":240} [sbp] debug: emit_move: N0"G1Y9.00000F240.00000" [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"pause","expr":".25"} [sbp] debug: emit_gcode = G4 P0.25 [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MY","args":[8],"comment":[" Position for final approach"]} [sbp] debug: Calling handler for MY With arguments: [8] [sbp] debug: Emit_move: G1 {"Y":8,"F":240} [sbp] debug: emit_move: N0"G1Y8.00000F240.00000" [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":[5],"comment":[" ... approach fast (less force)"]} [sbp] debug: Calling handler for VS With arguments: [5,,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[1000],"comment":[" ... limit ramp bounce"]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[1000],"comment":[" ... limit ramp bounce"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":[1000],"comment":[" ... limit ramp bounce"]} [sbp] debug: Calling handler for VR With arguments: [1000,,,,,,,,,,,,,,,] [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MY","args":[10]} [sbp] debug: Calling handler for MY With arguments: [10] [sbp] debug: Emit_move: G1 {"Y":10,"F":300} [sbp] debug: emit_move: N0"G1Y10.00000F300.00000" [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"pause","expr":".25"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"pause","expr":".25"} [sbp] debug: emit_gcode = G4 P0.25 [sbp] debug: Stack break: {"type":"assign","var":"&temp_loc","expr":{"left":8,"right":"$y_backoff","op":"+"}} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Stack break: {"type":"assign","var":"&temp_loc","expr":{"left":8,"right":"$y_backoff","op":"+"}} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&temp_loc","expr":{"left":8,"right":"$y_backoff","op":"+"}} [sbp] debug: Stack break: {"type":"cmd","cmd":"VA","args":["","&temp_loc","","","","","","&temp_loc"],"comment":[" Set Y Table Base Coordinate (offset to Zero) "]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VA","args":["","&temp_loc","","","","","","&temp_loc"],"comment":[" Set Y Table Base Coordinate (offset to Zero) "]} [sbp] debug: Calling handler for VA With arguments: [,8.075,,,,,,8.075,,,,] [sbp] debug: VA Command: ,8.075,,,,,,8.075,,,, [sbp] debug: emit_gcode = G28.3 Y8.075 [sbp] debug: g55Y0 MPO.y = 205.10499864630697 args[1] = 8.075 [sbp] debug: Saving config to /opt/fabmo/config/g2.json [config] debug: fsync()ed /opt/fabmo/config/g2.json [config] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":[4],"comment":[" ... reset"]} [sbp] debug: Calling handler for VS With arguments: [4,,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[50]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[50]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":[50]} [sbp] debug: Calling handler for VR With arguments: [50,,,,,,,,,,,,,,,] [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MY","args":[0],"comment":[" Move to Y-Zero // Y-Zero location now accurate"]} [sbp] debug: Calling handler for MY With arguments: [0] [sbp] debug: Emit_move: G1 {"Y":0,"F":240} [sbp] debug: emit_move: N0"G1Y0.00000F240.00000" [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[" Reset Starting Values"]} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":["&startXY_speed","&startZ_speed"]} [sbp] debug: Calling handler for VS With arguments: [1,0.5,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":["&startXY_ramp","&startZ_ramp"]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] info: Authorization timeout (30s) expired. [machine] info: Machine is deauthorized. [machine] debug: Stack break: {"type":"cmd","cmd":"VR","args":["&startXY_ramp","&startZ_ramp"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":["&startXY_ramp","&startZ_ramp"]} [sbp] debug: Calling handler for VR With arguments: [50,50,,,,,,,,,,,,,,] [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"end","message":null} [sbp] info: End of program reached. (pc = 71) [sbp] info: No g-codes remain to dispatch. [sbp] debug: Doing the nested end. [sbp] debug: Calling the nested end. [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Then, Move to Zeoring Target Location"]} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"M2","args":[6,0]} [sbp] debug: Calling handler for M2 With arguments: [6,0] [sbp] debug: X param = 6 Y param = 0 [sbp] debug: (process_move)movespeed_xy = 1 [sbp] debug: Emit_move: G1 {"X":6,"Y":0,"F":60} [sbp] debug: emit_move: N0"G1X6.00000Y0.00000F60.00000" [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["(... next lines displays; feature of OpenSBP)"]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Attach Aligator Clip to Cutter Shank and Swing-Out Target (-Continue- when Ready)"]} [sbp] debug: Stack break: {"type":"pause"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"pause"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"pause"} [sbp] info: Got a machine state change: paused [machine] debug: Saving config to /opt/fabmo/config/instance.json [config] debug: fsync()ed /opt/fabmo/config/instance.json [config] info: Arming the machine for resume [machine] info: Got a machine state change: armed [machine] info: Fire button hit! [machine] info: Machine is deauthorized. [machine] debug: Firing a resume [machine] info: Got a machine state change: running [machine] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Make sure we","re not accidentally in electrical contact with target "]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[" IF %(51) = 1 THEN GOTO Already_Triggered "," *not working yet ..."]} [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Set Zero Plate Adder (i.e. thickness) if not present"]} [sbp] debug: Non-Stack break: {"type":"weak_assign","var":"$zero_plate_adder","expr":".75"} [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Remove the Cutter Offset Contribution to Location "]} [sbp] debug: Stack break: {"type":"cmd","cmd":"VA","args":["","","-.25","","","","","","-.25"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VA","args":["","","-.25","","","","","","-.25"]} [sbp] debug: Calling handler for VA With arguments: [,,-0.25,,,,,,-0.25,,,] [sbp] debug: VA Command: ,,-0.25,,,,,,-0.25,,, [sbp] debug: Starting a timer for AP mode collapse (AP button was pressed) [machine] debug: emit_gcode = G28.3 Z-0.25 [sbp] debug: Saving config to /opt/fabmo/config/g2.json [config] debug: fsync()ed /opt/fabmo/config/g2.json [config] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Get Speeds at Startup"]} [sbp] debug: Stack break: {"type":"assign","var":"&startXY_speed","expr":"%(71)"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Stack break: {"type":"assign","var":"&startXY_speed","expr":"%(71)"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&startXY_speed","expr":"%(71)"} [sbp] debug: Stack break: {"type":"assign","var":"&startZ_speed","expr":"%(73)"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&startZ_speed","expr":"%(73)"} [sbp] debug: Stack break: {"type":"assign","var":"&startZ_ramp","expr":"%(83)"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&startZ_ramp","expr":"%(83)"} [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Starting Settings for Measuring Z"]} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":[4,".5"]} [sbp] debug: Calling handler for VS With arguments: [4,0.5,,,,,,,,] [sbp] debug: Stack break: {"type":"assign","var":"&Z_plunge_target","expr":-5} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&Z_plunge_target","expr":-5} [sbp] debug: Stack break: {"type":"assign","var":"&Z_pullup","expr":".5"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&Z_pullup","expr":".5"} [sbp] debug: Stack break: {"type":"assign","var":"&Z_final","expr":{"left":"$zero_plate_adder","right":".25","op":"+"}} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&Z_final","expr":{"left":"$zero_plate_adder","right":".25","op":"+"}} [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["HERE WE GO ! ............................................................."]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Next command creates an interrupt handler for contact with zero plate"]} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":[null,0.5]} [sbp] debug: Calling handler for VS With arguments: [,0.5,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[null,10000],"comment":[" quick stop"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":[null,10000],"comment":[" quick stop"]} [sbp] debug: Calling handler for VR With arguments: [,10000,,,,,,,,,,,,,,] [sbp] debug: Stack break: {"type":"event","sw":1,"state":1,"stmt":{"type":"goto","label":"afterHit"}} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"event","sw":1,"state":1,"stmt":{"type":"goto","label":"afterHit"}} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MZ","args":["&Z_plunge_target"]} [sbp] debug: Calling handler for MZ With arguments: [-5] [sbp] debug: Emit_move: G1 {"Z":-5,"F":30} [sbp] debug: emit_move: N0"G1Z-5.00000F30.00000" [sbp] debug: Stack break: {"type":"goto","label":"FAIL"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Cancelling AP collapse (AP button was released) [machine] info: Expected hold and got one. [sbp] debug: Checking event handlers for in1 [sbp] debug: Checking state 1 against 1 [sbp] debug: Clearing the queue. [g2] debug: Tearing down the input configuration that caused the event. [sbp] debug: Hit a GOTO: Going to line 47(Label: afterHit) [sbp] debug: Non-Stack break: {"type":"label","value":"afterHit"} [sbp] debug: Stack break: {"type":"gosub","label":"Backoff"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"gosub","label":"Backoff"} [sbp] debug: Pushing the current PC onto the stack (49) [sbp] debug: Non-Stack break: {"type":"label","value":"Backoff"} [sbp] debug: Stack break: {"type":"assign","var":"&NextPullUp","expr":"%(3)"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&NextPullUp","expr":"%(3)"} [sbp] debug: Stack break: {"type":"assign","var":"&NextPullUp","expr":{"left":"&NextPullUp","right":"&Z_pullup","op":"+"}} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&NextPullUp","expr":{"left":"&NextPullUp","right":"&Z_pullup","op":"+"}} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MZ","args":["&NextPullUp"]} [sbp] debug: Calling handler for MZ With arguments: [-2.049] [sbp] debug: Emit_move: G1 {"Z":-2.049,"F":30} [sbp] debug: emit_move: N0"G1Z-2.04900F30.00000" [sbp] debug: Stack break: {"type":"return"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"return"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"return"} [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Now, let","s do again with a touch at a reliable distance and speed"]} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":["",".25"]} [sbp] debug: Calling handler for VS With arguments: [,0.25,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":[null,10000],"comment":[" quick stop"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":[null,10000],"comment":[" quick stop"]} [sbp] debug: Calling handler for VR With arguments: [,10000,,,,,,,,,,,,,,] [sbp] debug: Stack break: {"type":"event","sw":1,"state":1,"stmt":{"type":"goto","label":"Finish"}} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"event","sw":1,"state":1,"stmt":{"type":"goto","label":"Finish"}} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MZ","args":["&Z_plunge_target"]} [sbp] debug: Calling handler for MZ With arguments: [-5] [sbp] debug: Emit_move: G1 {"Z":-5,"F":15} [sbp] debug: emit_move: N0"G1Z-5.00000F15.00000" [sbp] debug: Stack break: {"type":"goto","label":"FAIL"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] info: Expected hold and got one. [sbp] debug: Checking event handlers for in1 [sbp] debug: Checking state 1 against 1 [sbp] debug: Clearing the queue. [g2] debug: Tearing down the input configuration that caused the event. [sbp] debug: Hit a GOTO: Going to line 56(Label: Finish) [sbp] debug: Non-Stack break: {"type":"label","value":"Finish"} [sbp] debug: Stack break: {"type":"gosub","label":"Backoff"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"gosub","label":"Backoff"} [sbp] debug: Pushing the current PC onto the stack (58) [sbp] debug: Non-Stack break: {"type":"label","value":"Backoff"} [sbp] debug: Stack break: {"type":"assign","var":"&NextPullUp","expr":"%(3)"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&NextPullUp","expr":"%(3)"} [sbp] debug: Stack break: {"type":"assign","var":"&NextPullUp","expr":{"left":"&NextPullUp","right":"&Z_pullup","op":"+"}} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&NextPullUp","expr":{"left":"&NextPullUp","right":"&Z_pullup","op":"+"}} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MZ","args":["&NextPullUp"]} [sbp] debug: Calling handler for MZ With arguments: [-2.047] [sbp] debug: Emit_move: G1 {"Z":-2.047,"F":15} [sbp] debug: emit_move: N0"G1Z-2.04700F15.00000" [sbp] debug: Stack break: {"type":"return"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"return"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"return"} [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Set Location and Zero"]} [sbp] debug: Stack break: {"type":"assign","var":"$current_cutter_Zoffset","expr":{"left":{"left":-1,"right":"%(3)","op":"*"},"right":{"left":"$zero_plate_adder","right":"&Z_pullup","op":"+"},"op":"+"},"comment":[" remember we","re pulled up here"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"$current_cutter_Zoffset","expr":{"left":{"left":-1,"right":"%(3)","op":"*"},"right":{"left":"$zero_plate_adder","right":"&Z_pullup","op":"+"},"op":"+"},"comment":[" remember we","re pulled up here"]} [sbp] debug: $current_cutter_Zoffset is not a user variable [sbp] debug: Saving config to /opt/fabmo/config/opensbp.json [config] debug: fsync()ed /opt/fabmo/config/opensbp.json [config] debug: Stack break: {"type":"assign","var":"&new_base_Z_loc","expr":{"left":"&Z_pullup","right":"$zero_plate_adder","op":"+"}} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"assign","var":"&new_base_Z_loc","expr":{"left":"&Z_pullup","right":"$zero_plate_adder","op":"+"}} [sbp] debug: Stack break: {"type":"cmd","cmd":"VA","args":["","","&new_base_Z_loc","","","","","","&new_base_Z_loc"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VA","args":["","","&new_base_Z_loc","","","","","","&new_base_Z_loc"]} [sbp] debug: Calling handler for VA With arguments: [,,1.25,,,,,,1.25,,,] [sbp] debug: VA Command: ,,1.25,,,,,,1.25,,, [sbp] debug: emit_gcode = G28.3 Z1.25 [sbp] debug: Saving config to /opt/fabmo/config/g2.json [config] debug: fsync()ed /opt/fabmo/config/g2.json [config] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Restore Values"]} [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"VS","args":["&startXY_speed","&startZ_speed"]} [sbp] debug: Calling handler for VS With arguments: [1,0.5,,,,,,,,] [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":["","&startZ_ramp"]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Stack break: {"type":"cmd","cmd":"VR","args":["","&startZ_ramp"]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"VR","args":["","&startZ_ramp"]} [sbp] debug: Calling handler for VR With arguments: [,50,,,,,,,,,,,,,,] [sbp] debug: Non-Stack break: {"type":"cmd","cmd":"MZ","args":["&Z_final"]} [sbp] debug: Calling handler for MZ With arguments: [1] [sbp] debug: Emit_move: G1 {"Z":1,"F":30} [sbp] debug: emit_move: N0"G1Z1.00000F30.00000" [sbp] debug: Non-Stack break: {"type":"comment","comment":[]} [sbp] debug: Non-Stack break: {"type":"comment","comment":["Measurement Complete. REMOVE Alligator Clip and PARK Target !! (-Continue- when Done)"]} [sbp] debug: Stack break: {"type":"pause"} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Expected a running state change and got one. [sbp] debug: Stack break: {"type":"pause"} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"pause"} [sbp] info: Got a machine state change: paused [machine] debug: Saving config to /opt/fabmo/config/instance.json [config] debug: fsync()ed /opt/fabmo/config/instance.json [config] info: Setting driver units to INCH [g2] info: Got a machine state change: idle [machine] debug: Saving config to /opt/fabmo/config/instance.json [config] debug: fsync()ed /opt/fabmo/config/instance.json [config] info: Arming the machine for runtimeCode [machine] info: Got a machine state change: armed [machine] info: Fire button hit! [machine] info: Machine is deauthorized. [machine] debug: Firing a runtimeCode [machine] debug: Starting a timer for AP mode collapse (AP button was pressed) [machine] debug: _setupTransforms [sbp] debug: Transforms configured... [sbp] debug: Labels analyzed... [sbp] debug: GOTOs analyzed... [sbp] debug: emit_gcode = G90 [sbp] debug: Rainbows organized... [sbp] info: Starting OpenSBP program [sbp] info: Got a machine state change: running [machine] debug: Stack break: {"type":"cmd","cmd":"MH","args":[null]} [sbp] debug: Dispatched g-codes to tool. [sbp] debug: Returning from run... [sbp] debug: Stack break: {"type":"cmd","cmd":"MH","args":[null]} [sbp] debug: Empty dispatch [sbp] debug: Nothing to execute in the queue: continuing. [sbp] debug: executing + {"type":"cmd","cmd":"MH","args":[null]} [sbp] warn: More parameters passed into MH (1) than are supported by the command. (0) [sbp] debug: Calling handler for MH With arguments: [] [sbp] debug: MH [sbp] debug: z = 1 [sbp] debug: Emit_move: G1 {"X":0,"Y":0,"F":60} [sbp] debug: emit_move: N0"G1X0.00000Y0.00000F60.00000" [sbp] info: End of program reached. (pc = 1) [sbp] info: Dispatching final g-codes [sbp] debug: Expected a running state change and got one. [sbp] debug: Cancelling AP collapse (AP button was released) [machine] info: End of program reached. (pc = 1) [sbp] info: No g-codes remain to dispatch. [sbp] debug: Doing the nested end. [sbp] debug: Calling the nested end. [sbp] info: Machine is authorized for the next 30 seconds. [machine] info: Authorization timeout (30s) expired. [machine] info: Machine is deauthorized. [machine] debug: Client disconnected [websocket] debug: Client disconnected [websocket] info: Anonymous client at 192.168.42.21 connected. [websocket] info: Client #2 at 192.168.42.21 connected. [websocket] info: Anonymous client at 192.168.42.21 connected. [websocket] debug: Sending a feedhold [g2] debug: Drained. [g2]