2021-04-11 18:20:45.747 Main INFO: Bienvenue, Bienvenido, Willkommen, Hello, Namaskar, Welkom, Bonjour to OpenPnP version 2021-04-08_04-19-29.d3a4c39. 2021-04-11 18:20:45.747 Scripting TRACE: Scripting.on Startup 2021-04-11 18:20:47.085 AbstractBroadcastingCamera TRACE: Camera Top thread 27 started. 2021-04-11 18:20:48.370 AbstractBroadcastingCamera TRACE: Camera Bottom thread 29 started. 2021-04-11 18:20:50.929 ReferenceMachine DEBUG: setEnabled(true) 2021-04-11 18:20:53.988 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(G21, 5000)... 2021-04-11 18:20:53.988 GcodeDriver$ReaderThread TRACE: [serial://COM3] << Smoothie 2021-04-11 18:20:53.990 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:20:53.991 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(G90, 5000)... 2021-04-11 18:20:53.991 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> G21 2021-04-11 18:20:53.991 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:20:53.991 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M82, 5000)... 2021-04-11 18:20:53.992 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> G90 2021-04-11 18:20:53.992 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M809 ; Turn off VAC, 5000)... 2021-04-11 18:20:53.992 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:20:53.992 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M801 ; Vacuum nozzle 1 off, 5000)... 2021-04-11 18:20:53.992 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M82 2021-04-11 18:20:53.992 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M805 ; Vacuum nozzle 2 off, 5000)... 2021-04-11 18:20:53.992 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:20:53.992 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M17, 5000)... 2021-04-11 18:20:53.992 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M809 2021-04-11 18:20:53.993 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(;M814 ; Turn on DOWNLED, 5000)... 2021-04-11 18:20:53.993 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M801 2021-04-11 18:20:53.993 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:20:53.993 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(;M810 ; Turn on UPLED, 5000)... 2021-04-11 18:20:53.993 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M805 2021-04-11 18:20:53.994 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(;G4P750 ; Wait 750 milliseconds, 5000)... 2021-04-11 18:20:53.994 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M17 2021-04-11 18:20:53.994 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(;M811 ; Turn off UPLED, 5000)... 2021-04-11 18:20:53.994 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:20:53.995 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> 2021-04-11 18:20:53.995 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:20:53.995 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(;M815 ; Turn off DOWNLED, 5000)... 2021-04-11 18:20:53.995 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> 2021-04-11 18:20:53.996 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:20:53.996 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> 2021-04-11 18:20:53.996 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> 2021-04-11 18:20:53.996 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:20:53.997 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> 2021-04-11 18:20:53.997 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:20:53.998 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:20:53.998 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:20:53.999 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:20:57.002 GcodeDriver$ReaderThread TRACE: [serial://COM4] << FeedUino ready 2021-04-11 18:20:57.610 ReferenceMachine DEBUG: homing machine 2021-04-11 18:20:57.612 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(;M18 Z ; Turn off Z stepper, -1)... 2021-04-11 18:20:57.613 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> 2021-04-11 18:20:57.613 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:20:57.613 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(;G4 S3 ; Wait 3 seconds, -1)... 2021-04-11 18:20:57.613 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(G28 ;Now home the XY axis, -1)... 2021-04-11 18:20:57.614 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> 2021-04-11 18:20:57.614 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:20:57.614 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(G92 A0 ;Set N2 rotation to zero, -1)... 2021-04-11 18:20:57.614 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> G28 2021-04-11 18:20:57.614 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> G92A0 2021-04-11 18:20:57.614 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(G92 B0 ;Set N1 rotation to zero, -1)... 2021-04-11 18:20:57.615 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> G92B0 2021-04-11 18:20:57.618 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M400 ; Wait for moves to complete before returning, -1)... 2021-04-11 18:20:57.618 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M114 ; get position, -1)... 2021-04-11 18:20:57.619 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M400 2021-04-11 18:20:57.619 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M114 2021-04-11 18:21:06.453 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:06.454 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:06.456 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:06.457 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:06.460 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok C: X:5.0000 Y:5.0000 Z:0.0000 A:0.0000 B:0.0000 2021-04-11 18:21:06.461 GcodeDriver TRACE: Position report: ok C: X:5.0000 Y:5.0000 Z:0.0000 A:0.0000 B:0.0000 2021-04-11 18:21:06.463 GcodeDriver TRACE: Smoothie got lastReportedLocation (x:5.000000, y:5.000000, z:0.000000, rotationN1:0.000000, rotationN2:0.000000) 2021-04-11 18:21:06.466 GcodeAsyncDriver TRACE: Smoothie confirmation complete. 2021-04-11 18:21:06.470 AbstractMotionPlanner DEBUG: Reported location changes current location from (x:0.000000, y:0.000000, z:0.000000, rotationN1:0.000000, rotationN2:0.000000) to (x:5.000000, y:5.000000, z:0.000000, rotationN1:0.000000, rotationN2:0.000000) 2021-04-11 18:21:06.473 ReferenceHead DEBUG: H1.home() 2021-04-11 18:21:06.474 ReferenceNozzle DEBUG: N1.home() 2021-04-11 18:21:06.474 ReferenceNozzle DEBUG: N1.home() nozzle tip 504 calibration reset 2021-04-11 18:21:06.475 ReferenceNozzle DEBUG: N1.home() nozzle tip 503 calibration neeeded 2021-04-11 18:21:06.609 Scripting TRACE: Scripting.on NozzleCalibration.Starting 2021-04-11 18:21:06.612 ReferenceHead DEBUG: H1.moveToSafeZ(1.0) 2021-04-11 18:21:06.612 AbstractHeadMountable DEBUG: N1.moveToSafeZ(1.0) 2021-04-11 18:21:06.613 ReferenceNozzle TRACE: N1.transformToHeadLocation((5.000000, 5.000000, 0.000000, 0.000000 mm), ...) 2021-04-11 18:21:06.614 ReferenceNozzle TRACE: N1.transformToHeadLocation((5.000000, 5.000000, 0.000000, 0.000000 mm), ...) 2021-04-11 18:21:06.615 AbstractHeadMountable DEBUG: N2.moveToSafeZ(1.0) 2021-04-11 18:21:06.615 ReferenceNozzle TRACE: N2.transformToHeadLocation((5.000000, 5.000000, 0.000000, 0.000000 mm), ...) runout compensation: (0.024610, -0.006216, 0.000000, 0.000000 mm) 2021-04-11 18:21:06.616 ReferenceNozzle TRACE: N2.transformToHeadLocation((5.000000, 5.000000, 0.000000, 0.000000 mm), ...) runout compensation: (0.024610, -0.006216, 0.000000, 0.000000 mm) 2021-04-11 18:21:06.616 AbstractHeadMountable DEBUG: Top.moveToSafeZ(1.0) 2021-04-11 18:21:06.617 AbstractHeadMountable DEBUG: N1.moveTo((256.874000, 114.831000, 0.000000, -180.000000 mm), 1.0) 2021-04-11 18:21:06.617 ReferenceNozzle TRACE: N1.transformToHeadLocation((268.574000, 166.611000, 0.000000, -180.000000 mm), ...) 2021-04-11 18:21:06.636 AbstractHeadMountable DEBUG: N1.moveTo((256.874000, 114.831000, 0.000000, -180.000000 mm), 1.0) 2021-04-11 18:21:06.637 ReferenceNozzle TRACE: N1.transformToHeadLocation((268.574000, 166.611000, 0.000000, -180.000000 mm), ...) 2021-04-11 18:21:06.639 ReferenceNozzleTipCalibration DEBUG: [nozzleTipCalibration]starting measurement; angleStart: -180.0, angleStop: 180.0, angleIncrement: 60.0, angleSubdivisions: 5 2021-04-11 18:21:06.639 ReferenceNozzleTipCalibration DEBUG: [nozzleTipCalibration]i: 0, measureAngle: -180.0 2021-04-11 18:21:06.639 AbstractHeadMountable DEBUG: N1.moveTo((256.874000, 114.831000, 0.000000, -180.000000 mm), 1.0) 2021-04-11 18:21:06.640 ReferenceNozzle TRACE: N1.transformToHeadLocation((268.574000, 166.611000, 0.000000, -180.000000 mm), ...) 2021-04-11 18:21:06.661 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M204 S2714.65 G1 X268.5740 Y166.6110 A-180.0000 F59129.19 ; move to target, 5000)... 2021-04-11 18:21:06.662 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M204S2714.65G1X268.574Y166.611A-180F59129.19 2021-04-11 18:21:06.663 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:06.703 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M400 ; Wait for moves to complete before returning, 5000)... 2021-04-11 18:21:06.705 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M400 2021-04-11 18:21:06.707 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M114 ; get position, -1)... 2021-04-11 18:21:06.708 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M114 2021-04-11 18:21:07.430 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:07.431 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok C: X:268.5740 Y:166.6110 Z:0.0000 A:-180.0000 B:0.0000 2021-04-11 18:21:07.432 GcodeDriver TRACE: Position report: ok C: X:268.5740 Y:166.6110 Z:0.0000 A:-180.0000 B:0.0000 2021-04-11 18:21:07.432 GcodeDriver TRACE: Smoothie got lastReportedLocation (x:268.574000, y:166.611000, z:0.000000, rotationN1:-180.000000, rotationN2:0.000000) 2021-04-11 18:21:07.433 GcodeAsyncDriver TRACE: Smoothie confirmation complete. 2021-04-11 18:21:07.433 ReferenceActuator DEBUG: UpCamLights.actuate(true) 2021-04-11 18:21:07.434 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M810, 5000)... 2021-04-11 18:21:07.435 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M810 2021-04-11 18:21:07.435 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:07.435 Scripting TRACE: Scripting.on Camera.BeforeSettle 2021-04-11 18:21:07.437 Scripting TRACE: Scripting.on Camera.BeforeCapture 2021-04-11 18:21:07.455 Scripting TRACE: Scripting.on Camera.AfterCapture 2021-04-11 18:21:07.468 Scripting TRACE: Scripting.on Camera.BeforeCapture 2021-04-11 18:21:07.531 Scripting TRACE: Scripting.on Camera.AfterCapture 2021-04-11 18:21:07.541 AbstractCamera TRACE: autoSettleAndCapture t=104 auto settle score: 99.6078431372549 2021-04-11 18:21:07.542 AbstractCamera DEBUG: autoSettleAndCapture in 105 ms 2021-04-11 18:21:07.543 Scripting TRACE: Scripting.on Camera.AfterSettle 2021-04-11 18:21:07.643 ReferenceNozzleTipCalibration DEBUG: [nozzleTipCalibration]i: 1, measureAngle: -120.0 2021-04-11 18:21:07.643 AbstractHeadMountable DEBUG: N1.moveTo((256.874000, 114.831000, 0.000000, -120.000000 mm), 1.0) 2021-04-11 18:21:07.644 ReferenceNozzle TRACE: N1.transformToHeadLocation((268.574000, 166.611000, 0.000000, -120.000000 mm), ...) 2021-04-11 18:21:07.651 Scripting TRACE: Scripting.on Camera.BeforeSettle 2021-04-11 18:21:07.659 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M204 S2000.00 G1 A-120.0000 F20784.61 ; move to target, 5000)... 2021-04-11 18:21:07.660 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M204S2000G1A-120F20784.61 2021-04-11 18:21:07.661 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:07.670 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M400 ; Wait for moves to complete before returning, 5000)... 2021-04-11 18:21:07.671 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M400 2021-04-11 18:21:07.671 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M114 ; get position, -1)... 2021-04-11 18:21:07.672 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M114 2021-04-11 18:21:08.017 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:08.018 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok C: X:268.5740 Y:166.6110 Z:0.0000 A:-120.0000 B:0.0000 2021-04-11 18:21:08.019 GcodeDriver TRACE: Position report: ok C: X:268.5740 Y:166.6110 Z:0.0000 A:-120.0000 B:0.0000 2021-04-11 18:21:08.020 GcodeDriver TRACE: Smoothie got lastReportedLocation (x:268.574000, y:166.611000, z:0.000000, rotationN1:-120.000000, rotationN2:0.000000) 2021-04-11 18:21:08.020 GcodeAsyncDriver TRACE: Smoothie confirmation complete. 2021-04-11 18:21:08.021 Scripting TRACE: Scripting.on Camera.BeforeCapture 2021-04-11 18:21:08.043 Scripting TRACE: Scripting.on Camera.AfterCapture 2021-04-11 18:21:08.050 Scripting TRACE: Scripting.on Camera.BeforeCapture 2021-04-11 18:21:08.103 Scripting TRACE: Scripting.on Camera.AfterCapture 2021-04-11 18:21:08.114 AbstractCamera TRACE: autoSettleAndCapture t=93 auto settle score: 20.392156862745097 2021-04-11 18:21:08.115 AbstractCamera DEBUG: autoSettleAndCapture in 94 ms 2021-04-11 18:21:08.116 Scripting TRACE: Scripting.on Camera.AfterSettle 2021-04-11 18:21:08.202 ReferenceNozzleTipCalibration DEBUG: [nozzleTipCalibration]i: 2, measureAngle: -60.0 2021-04-11 18:21:08.203 AbstractHeadMountable DEBUG: N1.moveTo((256.874000, 114.831000, 0.000000, -60.000000 mm), 1.0) 2021-04-11 18:21:08.204 ReferenceNozzle TRACE: N1.transformToHeadLocation((268.574000, 166.611000, 0.000000, -60.000000 mm), ...) 2021-04-11 18:21:08.208 Scripting TRACE: Scripting.on Camera.BeforeSettle 2021-04-11 18:21:08.217 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M204 S2000.00 G1 A-60.0000 F20784.61 ; move to target, 5000)... 2021-04-11 18:21:08.218 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M204S2000G1A-60F20784.61 2021-04-11 18:21:08.218 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:08.221 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M400 ; Wait for moves to complete before returning, 5000)... 2021-04-11 18:21:08.222 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M400 2021-04-11 18:21:08.222 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M114 ; get position, -1)... 2021-04-11 18:21:08.223 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M114 2021-04-11 18:21:08.567 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:08.568 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok C: X:268.5740 Y:166.6110 Z:0.0000 A:-60.0000 B:0.0000 2021-04-11 18:21:08.569 GcodeDriver TRACE: Position report: ok C: X:268.5740 Y:166.6110 Z:0.0000 A:-60.0000 B:0.0000 2021-04-11 18:21:08.570 GcodeDriver TRACE: Smoothie got lastReportedLocation (x:268.574000, y:166.611000, z:0.000000, rotationN1:-60.000000, rotationN2:0.000000) 2021-04-11 18:21:08.570 GcodeAsyncDriver TRACE: Smoothie confirmation complete. 2021-04-11 18:21:08.571 Scripting TRACE: Scripting.on Camera.BeforeCapture 2021-04-11 18:21:08.590 Scripting TRACE: Scripting.on Camera.AfterCapture 2021-04-11 18:21:08.598 Scripting TRACE: Scripting.on Camera.BeforeCapture 2021-04-11 18:21:08.639 Scripting TRACE: Scripting.on Camera.AfterCapture 2021-04-11 18:21:08.649 AbstractCamera TRACE: autoSettleAndCapture t=78 auto settle score: 11.372549019607844 2021-04-11 18:21:08.650 AbstractCamera DEBUG: autoSettleAndCapture in 79 ms 2021-04-11 18:21:08.650 Scripting TRACE: Scripting.on Camera.AfterSettle 2021-04-11 18:21:08.761 AbstractHeadMountable DEBUG: N1.moveTo((256.874000, 114.831000, 0.000000, 180.000000 mm), 1.0) 2021-04-11 18:21:08.762 ReferenceNozzle TRACE: N1.transformToHeadLocation((268.574000, 166.611000, 0.000000, 180.000000 mm), ...) 2021-04-11 18:21:08.764 AbstractHeadMountable DEBUG: N1.moveToSafeZ(1.0) 2021-04-11 18:21:08.765 ReferenceNozzle TRACE: N1.transformToHeadLocation((268.574000, 166.611000, 0.000000, -180.000000 mm), ...) 2021-04-11 18:21:08.765 ReferenceNozzle TRACE: N1.transformToHeadLocation((268.574000, 166.611000, 0.000000, -180.000000 mm), ...) 2021-04-11 18:21:08.766 ReferenceNozzle TRACE: N1.transformToHeadLocation((268.574000, 166.611000, 0.000000, -180.000000 mm), ...) 2021-04-11 18:21:08.787 MessageBoxes DEBUG: Error: java.lang.Exception: Too many vision misdetects. Check pipeline and threshold. 2021-04-11 18:21:20.468 ReferenceMachine DEBUG: homing machine 2021-04-11 18:21:20.470 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(;M18 Z ; Turn off Z stepper, -1)... 2021-04-11 18:21:20.470 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> 2021-04-11 18:21:20.470 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:20.470 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(;G4 S3 ; Wait 3 seconds, -1)... 2021-04-11 18:21:20.471 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> 2021-04-11 18:21:20.471 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:20.472 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(G28 ;Now home the XY axis, -1)... 2021-04-11 18:21:20.472 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> G28 2021-04-11 18:21:20.472 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(G92 A0 ;Set N2 rotation to zero, -1)... 2021-04-11 18:21:20.473 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> G92A0 2021-04-11 18:21:20.473 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(G92 B0 ;Set N1 rotation to zero, -1)... 2021-04-11 18:21:20.473 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> G92B0 2021-04-11 18:21:20.482 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M204 S2000.00 G1 A-180.0000 F29393.88 ; move to target, 5000)... 2021-04-11 18:21:20.484 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M204S2000G1A-180F29393.88 2021-04-11 18:21:20.493 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M400 ; Wait for moves to complete before returning, -1)... 2021-04-11 18:21:20.494 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M400 2021-04-11 18:21:20.494 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M114 ; get position, -1)... 2021-04-11 18:21:20.495 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M114 2021-04-11 18:21:25.903 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:25.904 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:25.904 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:25.904 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:26.516 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:26.517 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok C: X:5.0000 Y:5.0000 Z:0.0000 A:-180.0000 B:0.0000 2021-04-11 18:21:26.518 GcodeDriver TRACE: Position report: ok C: X:5.0000 Y:5.0000 Z:0.0000 A:-180.0000 B:0.0000 2021-04-11 18:21:26.518 GcodeDriver TRACE: Smoothie got lastReportedLocation (x:5.000000, y:5.000000, z:0.000000, rotationN1:-180.000000, rotationN2:0.000000) 2021-04-11 18:21:26.518 GcodeAsyncDriver TRACE: Smoothie confirmation complete. 2021-04-11 18:21:26.519 AbstractMotionPlanner DEBUG: Reported location changes current location from (x:268.574000, y:166.611000, z:0.000000, rotationN1:-180.000000, rotationN2:0.000000) to (x:5.000000, y:5.000000, z:0.000000, rotationN1:-180.000000, rotationN2:0.000000) 2021-04-11 18:21:26.519 ReferenceHead DEBUG: H1.home() 2021-04-11 18:21:26.520 ReferenceNozzle DEBUG: N1.home() 2021-04-11 18:21:26.520 ReferenceNozzle DEBUG: N1.home() nozzle tip 504 calibration reset 2021-04-11 18:21:26.520 ReferenceNozzle DEBUG: N1.home() nozzle tip 503 calibration neeeded 2021-04-11 18:21:26.522 Scripting TRACE: Scripting.on NozzleCalibration.Starting 2021-04-11 18:21:26.523 ReferenceHead DEBUG: H1.moveToSafeZ(1.0) 2021-04-11 18:21:26.524 AbstractHeadMountable DEBUG: N1.moveToSafeZ(1.0) 2021-04-11 18:21:26.524 ReferenceNozzle TRACE: N1.transformToHeadLocation((5.000000, 5.000000, 0.000000, -180.000000 mm), ...) 2021-04-11 18:21:26.524 ReferenceNozzle TRACE: N1.transformToHeadLocation((5.000000, 5.000000, 0.000000, -180.000000 mm), ...) 2021-04-11 18:21:26.525 AbstractHeadMountable DEBUG: N2.moveToSafeZ(1.0) 2021-04-11 18:21:26.525 ReferenceNozzle TRACE: N2.transformToHeadLocation((5.000000, 5.000000, 0.000000, 0.000000 mm), ...) runout compensation: (0.024610, -0.006216, 0.000000, 0.000000 mm) 2021-04-11 18:21:26.526 ReferenceNozzle TRACE: N2.transformToHeadLocation((5.000000, 5.000000, 0.000000, 0.000000 mm), ...) runout compensation: (0.024610, -0.006216, 0.000000, 0.000000 mm) 2021-04-11 18:21:26.527 AbstractHeadMountable DEBUG: Top.moveToSafeZ(1.0) 2021-04-11 18:21:26.528 AbstractHeadMountable DEBUG: N1.moveTo((256.874000, 114.831000, 0.000000, -180.000000 mm), 1.0) 2021-04-11 18:21:26.528 ReferenceNozzle TRACE: N1.transformToHeadLocation((268.574000, 166.611000, 0.000000, -180.000000 mm), ...) 2021-04-11 18:21:26.530 AbstractHeadMountable DEBUG: N1.moveTo((256.874000, 114.831000, 0.000000, -180.000000 mm), 1.0) 2021-04-11 18:21:26.531 ReferenceNozzle TRACE: N1.transformToHeadLocation((268.574000, 166.611000, 0.000000, -180.000000 mm), ...) 2021-04-11 18:21:26.533 ReferenceNozzleTipCalibration DEBUG: [nozzleTipCalibration]starting measurement; angleStart: -180.0, angleStop: 180.0, angleIncrement: 60.0, angleSubdivisions: 5 2021-04-11 18:21:26.533 ReferenceNozzleTipCalibration DEBUG: [nozzleTipCalibration]i: 0, measureAngle: -180.0 2021-04-11 18:21:26.533 AbstractHeadMountable DEBUG: N1.moveTo((256.874000, 114.831000, 0.000000, -180.000000 mm), 1.0) 2021-04-11 18:21:26.534 ReferenceNozzle TRACE: N1.transformToHeadLocation((268.574000, 166.611000, 0.000000, -180.000000 mm), ...) 2021-04-11 18:21:26.536 Scripting TRACE: Scripting.on Camera.BeforeSettle 2021-04-11 18:21:26.540 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M204 S2346.02 G1 X268.5740 Y166.6110 F51099.87 ; move to target, 5000)... 2021-04-11 18:21:26.541 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M204S2346.02G1X268.574Y166.611F51099.87 2021-04-11 18:21:26.542 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:26.564 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M400 ; Wait for moves to complete before returning, 5000)... 2021-04-11 18:21:26.564 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M114 ; get position, -1)... 2021-04-11 18:21:26.565 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M400 2021-04-11 18:21:26.565 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M114 2021-04-11 18:21:27.290 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:27.292 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok C: X:268.5740 Y:166.6110 Z:0.0000 A:-180.0000 B:0.0000 2021-04-11 18:21:27.292 GcodeDriver TRACE: Position report: ok C: X:268.5740 Y:166.6110 Z:0.0000 A:-180.0000 B:0.0000 2021-04-11 18:21:27.292 GcodeDriver TRACE: Smoothie got lastReportedLocation (x:268.574000, y:166.611000, z:0.000000, rotationN1:-180.000000, rotationN2:0.000000) 2021-04-11 18:21:27.293 GcodeAsyncDriver TRACE: Smoothie confirmation complete. 2021-04-11 18:21:27.293 Scripting TRACE: Scripting.on Camera.BeforeCapture 2021-04-11 18:21:27.313 Scripting TRACE: Scripting.on Camera.AfterCapture 2021-04-11 18:21:27.319 Scripting TRACE: Scripting.on Camera.BeforeCapture 2021-04-11 18:21:27.340 Scripting TRACE: Scripting.on Camera.AfterCapture 2021-04-11 18:21:27.347 AbstractCamera TRACE: autoSettleAndCapture t=54 auto settle score: 62.745098039215684 2021-04-11 18:21:27.348 AbstractCamera DEBUG: autoSettleAndCapture in 54 ms 2021-04-11 18:21:27.348 Scripting TRACE: Scripting.on Camera.AfterSettle 2021-04-11 18:21:27.445 ReferenceNozzleTipCalibration DEBUG: [nozzleTipCalibration]i: 1, measureAngle: -120.0 2021-04-11 18:21:27.445 AbstractHeadMountable DEBUG: N1.moveTo((256.874000, 114.831000, 0.000000, -120.000000 mm), 1.0) 2021-04-11 18:21:27.446 ReferenceNozzle TRACE: N1.transformToHeadLocation((268.574000, 166.611000, 0.000000, -120.000000 mm), ...) 2021-04-11 18:21:27.448 Scripting TRACE: Scripting.on Camera.BeforeSettle 2021-04-11 18:21:27.455 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M204 S2000.00 G1 A-120.0000 F20784.61 ; move to target, 5000)... 2021-04-11 18:21:27.456 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M204S2000G1A-120F20784.61 2021-04-11 18:21:27.457 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:27.465 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M400 ; Wait for moves to complete before returning, 5000)... 2021-04-11 18:21:27.466 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M400 2021-04-11 18:21:27.467 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M114 ; get position, -1)... 2021-04-11 18:21:27.467 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M114 2021-04-11 18:21:27.812 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:27.813 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok C: X:268.5740 Y:166.6110 Z:0.0000 A:-120.0000 B:0.0000 2021-04-11 18:21:27.814 GcodeDriver TRACE: Position report: ok C: X:268.5740 Y:166.6110 Z:0.0000 A:-120.0000 B:0.0000 2021-04-11 18:21:27.815 GcodeDriver TRACE: Smoothie got lastReportedLocation (x:268.574000, y:166.611000, z:0.000000, rotationN1:-120.000000, rotationN2:0.000000) 2021-04-11 18:21:27.816 GcodeAsyncDriver TRACE: Smoothie confirmation complete. 2021-04-11 18:21:27.816 Scripting TRACE: Scripting.on Camera.BeforeCapture 2021-04-11 18:21:27.840 Scripting TRACE: Scripting.on Camera.AfterCapture 2021-04-11 18:21:27.848 Scripting TRACE: Scripting.on Camera.BeforeCapture 2021-04-11 18:21:27.879 Scripting TRACE: Scripting.on Camera.AfterCapture 2021-04-11 18:21:27.891 AbstractCamera TRACE: autoSettleAndCapture t=75 auto settle score: 12.941176470588237 2021-04-11 18:21:27.892 AbstractCamera DEBUG: autoSettleAndCapture in 76 ms 2021-04-11 18:21:27.895 Scripting TRACE: Scripting.on Camera.AfterSettle 2021-04-11 18:21:28.010 ReferenceNozzleTipCalibration DEBUG: [nozzleTipCalibration]i: 2, measureAngle: -60.0 2021-04-11 18:21:28.011 AbstractHeadMountable DEBUG: N1.moveTo((256.874000, 114.831000, 0.000000, -60.000000 mm), 1.0) 2021-04-11 18:21:28.012 ReferenceNozzle TRACE: N1.transformToHeadLocation((268.574000, 166.611000, 0.000000, -60.000000 mm), ...) 2021-04-11 18:21:28.014 Scripting TRACE: Scripting.on Camera.BeforeSettle 2021-04-11 18:21:28.019 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M204 S2000.00 G1 A-60.0000 F20784.61 ; move to target, 5000)... 2021-04-11 18:21:28.020 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M204S2000G1A-60F20784.61 2021-04-11 18:21:28.021 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:28.022 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M400 ; Wait for moves to complete before returning, 5000)... 2021-04-11 18:21:28.022 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M114 ; get position, -1)... 2021-04-11 18:21:28.022 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M400 2021-04-11 18:21:28.023 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M114 2021-04-11 18:21:28.369 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:28.370 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok C: X:268.5740 Y:166.6110 Z:0.0000 A:-60.0000 B:0.0000 2021-04-11 18:21:28.371 GcodeDriver TRACE: Position report: ok C: X:268.5740 Y:166.6110 Z:0.0000 A:-60.0000 B:0.0000 2021-04-11 18:21:28.372 GcodeDriver TRACE: Smoothie got lastReportedLocation (x:268.574000, y:166.611000, z:0.000000, rotationN1:-60.000000, rotationN2:0.000000) 2021-04-11 18:21:28.373 GcodeAsyncDriver TRACE: Smoothie confirmation complete. 2021-04-11 18:21:28.374 Scripting TRACE: Scripting.on Camera.BeforeCapture 2021-04-11 18:21:28.403 Scripting TRACE: Scripting.on Camera.AfterCapture 2021-04-11 18:21:28.411 Scripting TRACE: Scripting.on Camera.BeforeCapture 2021-04-11 18:21:28.441 Scripting TRACE: Scripting.on Camera.AfterCapture 2021-04-11 18:21:28.452 AbstractCamera TRACE: autoSettleAndCapture t=78 auto settle score: 12.549019607843137 2021-04-11 18:21:28.452 AbstractCamera DEBUG: autoSettleAndCapture in 78 ms 2021-04-11 18:21:28.453 Scripting TRACE: Scripting.on Camera.AfterSettle 2021-04-11 18:21:28.576 AbstractHeadMountable DEBUG: N1.moveTo((256.874000, 114.831000, 0.000000, 180.000000 mm), 1.0) 2021-04-11 18:21:28.576 ReferenceNozzle TRACE: N1.transformToHeadLocation((268.574000, 166.611000, 0.000000, 180.000000 mm), ...) 2021-04-11 18:21:28.577 AbstractHeadMountable DEBUG: N1.moveToSafeZ(1.0) 2021-04-11 18:21:28.578 ReferenceNozzle TRACE: N1.transformToHeadLocation((268.574000, 166.611000, 0.000000, -180.000000 mm), ...) 2021-04-11 18:21:28.578 ReferenceNozzle TRACE: N1.transformToHeadLocation((268.574000, 166.611000, 0.000000, -180.000000 mm), ...) 2021-04-11 18:21:28.579 ReferenceNozzle TRACE: N1.transformToHeadLocation((268.574000, 166.611000, 0.000000, -180.000000 mm), ...) 2021-04-11 18:21:28.614 MessageBoxes DEBUG: Error: java.lang.Exception: Too many vision misdetects. Check pipeline and threshold. 2021-04-11 18:21:32.313 ReferenceMachine DEBUG: homing machine 2021-04-11 18:21:32.321 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(;M18 Z ; Turn off Z stepper, -1)... 2021-04-11 18:21:32.323 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> 2021-04-11 18:21:32.323 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:32.324 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(;G4 S3 ; Wait 3 seconds, -1)... 2021-04-11 18:21:32.324 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(G28 ;Now home the XY axis, -1)... 2021-04-11 18:21:32.324 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(G92 A0 ;Set N2 rotation to zero, -1)... 2021-04-11 18:21:32.324 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:32.324 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> 2021-04-11 18:21:32.325 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> G28 2021-04-11 18:21:32.325 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> G92A0 2021-04-11 18:21:32.324 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(G92 B0 ;Set N1 rotation to zero, -1)... 2021-04-11 18:21:32.329 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> G92B0 2021-04-11 18:21:32.339 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M204 S2000.00 G1 A-180.0000 F29393.88 ; move to target, 5000)... 2021-04-11 18:21:32.340 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M204S2000G1A-180F29393.88 2021-04-11 18:21:32.342 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M400 ; Wait for moves to complete before returning, -1)... 2021-04-11 18:21:32.342 GcodeAsyncDriver DEBUG: serial://COM3 commandQueue.offer(M114 ; get position, -1)... 2021-04-11 18:21:32.342 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M400 2021-04-11 18:21:32.343 GcodeAsyncDriver$WriterThread TRACE: [serial://COM3] >> M114 2021-04-11 18:21:37.777 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:37.777 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:37.777 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:37.778 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:38.390 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok 2021-04-11 18:21:38.391 GcodeDriver$ReaderThread TRACE: [serial://COM3] << ok C: X:5.0000 Y:5.0000 Z:0.0000 A:-180.0000 B:0.0000 2021-04-11 18:21:38.391 GcodeDriver TRACE: Position report: ok C: X:5.0000 Y:5.0000 Z:0.0000 A:-180.0000 B:0.0000 2021-04-11 18:21:38.392 GcodeDriver TRACE: Smoothie got lastReportedLocation (x:5.000000, y:5.000000, z:0.000000, rotationN1:-180.000000, rotationN2:0.000000) 2021-04-11 18:21:38.392 GcodeAsyncDriver TRACE: Smoothie confirmation complete. 2021-04-11 18:21:38.393 AbstractMotionPlanner DEBUG: Reported location changes current location from (x:268.574000, y:166.611000, z:0.000000, rotationN1:-180.000000, rotationN2:0.000000) to (x:5.000000, y:5.000000, z:0.000000, rotationN1:-180.000000, rotationN2:0.000000) 2021-04-11 18:21:38.394 ReferenceHead DEBUG: H1.home() 2021-04-11 18:21:38.394 ReferenceNozzle DEBUG: N1.home() 2021-04-11 18:21:38.394 ReferenceNozzle DEBUG: N1.home() nozzle tip 504 calibration reset 2021-04-11 18:21:38.394 ReferenceNozzle DEBUG: N1.home() nozzle tip 503 calibration neeeded 2021-04-11 18:21:38.395 ReferenceNozzle DEBUG: N2.home() 2021-04-11 18:21:38.395 ReferenceNozzle DEBUG: N2.home() nozzle tip 504 calibration reset 2021-04-11 18:21:38.395 ReferenceNozzle DEBUG: N2.home() nozzle tip 503 calibration reset 2021-04-11 18:21:38.395 Scripting TRACE: Scripting.on Machine.AfterHoming 2021-04-11 18:21:38.396 Scripting TRACE: Scripting.on found Machine.AfterHoming.js 2021-04-11 18:21:39.169 SystemLogger INFO: BottomVision Exposure changed from: -10 to: -10 2021-04-11 18:21:39.169 ReferenceMachine INFO: setHomed(true) 2021-04-11 18:21:53.031 AbstractHeadMountable DEBUG: N1.moveToSafeZ(1.0) 2021-04-11 18:21:53.032 ReferenceNozzle TRACE: N1.transformToHeadLocation((5.000000, 5.000000, 0.000000, -180.000000 mm), ...) 2021-04-11 18:21:53.032 ReferenceNozzle TRACE: N1.transformToHeadLocation((5.000000, 5.000000, 0.000000, -180.000000 mm), ...) 2021-04-11 18:21:53.033 ReferenceActuator DEBUG: SlotFeederActuate.actuate(1.0) 2021-04-11 18:21:53.033 GcodeAsyncDriver DEBUG: serial://COM4 commandQueue.offer(M600 N1, 1000)... 2021-04-11 18:21:53.041 ReferenceHead DEBUG: H1.moveToSafeZ(1.0) 2021-04-11 18:21:53.041 GcodeAsyncDriver$WriterThread TRACE: [serial://COM4] >> M600N1 2021-04-11 18:21:53.041 AbstractHeadMountable DEBUG: N1.moveToSafeZ(1.0) 2021-04-11 18:21:53.042 ReferenceNozzle TRACE: N1.transformToHeadLocation((5.000000, 5.000000, 0.000000, -180.000000 mm), ...) 2021-04-11 18:21:53.042 GcodeDriver$ReaderThread TRACE: [serial://COM4] << M600N1 2021-04-11 18:21:53.042 ReferenceNozzle TRACE: N1.transformToHeadLocation((5.000000, 5.000000, 0.000000, -180.000000 mm), ...) 2021-04-11 18:21:53.043 AbstractHeadMountable DEBUG: N2.moveToSafeZ(1.0) 2021-04-11 18:21:53.044 ReferenceNozzle TRACE: N2.transformToHeadLocation((5.000000, 5.000000, 0.000000, 0.000000 mm), ...) runout compensation: (0.000000, 0.000000, 0.000000, 0.000000 mm) 2021-04-11 18:21:53.044 ReferenceNozzle TRACE: N2.transformToHeadLocation((5.000000, 5.000000, 0.000000, 0.000000 mm), ...) runout compensation: (0.000000, 0.000000, 0.000000, 0.000000 mm) 2021-04-11 18:21:53.044 AbstractHeadMountable DEBUG: Top.moveToSafeZ(1.0) 2021-04-11 18:21:53.045 GcodeDriver$ReaderThread TRACE: [serial://COM4] << ok Feeder advance done 2021-04-11 18:21:53.045 AbstractHeadMountable DEBUG: N1.moveTo((29.934000, 17.073000, 0.000000, 0.000000 mm), 1.0) 2021-04-11 18:21:53.046 ReferenceNozzle TRACE: N1.transformToHeadLocation((41.634000, 68.853000, 0.000000, 0.000000 mm), ...) 2021-04-11 18:21:53.048 AbstractHeadMountable DEBUG: N1.moveTo((29.934000, 17.073000, -18.800000, 0.000000 mm), 1.0) 2021-04-11 18:21:53.048 ReferenceNozzle TRACE: N1.transformToHeadLocation((41.634000, 68.853000, -18.800000, 0.000000 mm), ...) 2021-04-11 18:21:53.051 ReferenceNozzle DEBUG: N1.pick() 2021-04-11 18:21:53.051 Scripting TRACE: Scripting.on Nozzle.BeforePick 2021-04-11 18:21:53.055 MessageBoxes DEBUG: Error: java.lang.NullPointerException