2020-02-04T21:49:49.336Z,1580852989.336 [Supervisor](DEBUG): Initializing supervisor.
2020-02-04T21:49:49.339Z,1580852989.339 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2020-02-04T21:49:49.339Z,1580852989.339 [SyncHandler](INFO): Protected caller Thread ID is 1007
2020-02-04T21:49:49.340Z,1580852989.340 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2020-02-04T21:49:49.341Z,1580852989.341 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2020-02-04T21:49:49.341Z,1580852989.341 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1008
2020-02-04T21:49:49.344Z,1580852989.344 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2020-02-04T21:49:49.356Z,1580852989.356 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2020-02-04T21:49:49.357Z,1580852989.357 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2020-02-04T21:49:49.358Z,1580852989.358 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1009
2020-02-04T21:49:49.358Z,1580852989.358 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2020-02-04T21:49:49.359Z,1580852989.359 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2020-02-04T21:49:49.360Z,1580852989.360 [logger ThreadHandler](INFO): Protected caller Thread ID is 1010
2020-02-04T21:49:49.361Z,1580852989.361 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2020-02-04T21:49:49.362Z,1580852989.362 [Supervisor](INFO): Looking for Config files in directory: Config/
2020-02-04T21:49:49.363Z,1580852989.363 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2020-02-04T21:49:49.797Z,1580852989.797 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2020-02-04T21:49:49.797Z,1580852989.797 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2020-02-04T21:49:49.894Z,1580852989.894 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2020-02-04T21:49:49.894Z,1580852989.894 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2020-02-04T21:49:50.208Z,1580852990.208 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2020-02-04T21:49:50.208Z,1580852990.208 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2020-02-04T21:49:50.345Z,1580852990.345 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2020-02-04T21:49:50.346Z,1580852990.346 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2020-02-04T21:49:50.536Z,1580852990.536 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2020-02-04T21:49:50.537Z,1580852990.537 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2020-02-04T21:49:50.978Z,1580852990.978 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2020-02-04T21:49:50.979Z,1580852990.979 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2020-02-04T21:49:51.187Z,1580852991.187 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2020-02-04T21:49:51.188Z,1580852991.188 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2020-02-04T21:49:51.330Z,1580852991.330 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2020-02-04T21:49:51.330Z,1580852991.330 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2020-02-04T21:49:51.520Z,1580852991.520 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2020-02-04T21:49:51.520Z,1580852991.520 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2020-02-04T21:49:51.615Z,1580852991.615 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2020-02-04T21:49:51.616Z,1580852991.616 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2020-02-04T21:49:51.912Z,1580852991.912 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2020-02-04T21:49:51.913Z,1580852991.913 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2020-02-04T21:49:51.993Z,1580852991.993 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2020-02-04T21:49:52.094Z,1580852992.094 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2020-02-04T21:49:52.095Z,1580852992.095 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2020-02-04T21:49:52.729Z,1580852992.729 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2020-02-04T21:49:52.730Z,1580852992.730 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2020-02-04T21:49:53.136Z,1580852993.136 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2020-02-04T21:49:53.138Z,1580852993.138 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/
2020-02-04T21:49:53.139Z,1580852993.139 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg
2020-02-04T21:49:53.349Z,1580852993.349 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg
2020-02-04T21:49:53.449Z,1580852993.449 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg
2020-02-04T21:49:53.547Z,1580852993.547 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg
2020-02-04T21:49:53.773Z,1580852993.773 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2020-02-04T21:49:53.773Z,1580852993.773 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg
2020-02-04T21:49:53.858Z,1580852993.858 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg
2020-02-04T21:49:53.950Z,1580852993.950 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg
2020-02-04T21:49:54.047Z,1580852994.047 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg
2020-02-04T21:49:54.129Z,1580852994.129 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg
2020-02-04T21:49:54.236Z,1580852994.236 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/workSite.cfg
2020-02-04T21:49:54.349Z,1580852994.349 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg
2020-02-04T21:49:54.710Z,1580852994.710 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg
2020-02-04T21:49:54.898Z,1580852994.898 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2020-02-04T21:49:54.903Z,1580852994.903 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2020-02-04T21:49:55.360Z,1580852995.360 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_orientation
2020-02-04T21:49:55.365Z,1580852995.365 [AHRS_M2](INFO): created writer for : platform_orientation
2020-02-04T21:49:55.367Z,1580852995.367 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_magnetic_orientation
2020-02-04T21:49:55.372Z,1580852995.372 [AHRS_M2](INFO): created writer for : platform_magnetic_orientation
2020-02-04T21:49:55.373Z,1580852995.373 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_pitch_angle
2020-02-04T21:49:55.378Z,1580852995.378 [AHRS_M2](INFO): created writer for : platform_pitch_angle
2020-02-04T21:49:55.379Z,1580852995.379 [AHRS_M2](DEBUG): LcmSlateWriter::add(): platform_roll_angle
2020-02-04T21:49:55.384Z,1580852995.384 [AHRS_M2](INFO): created writer for : platform_roll_angle
2020-02-04T21:49:55.453Z,1580852995.453 [AHRS_M2] Loaded
2020-02-04T21:49:55.453Z,1580852995.453 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2020-02-04T21:49:55.532Z,1580852995.532 [DataOverHttps] Loaded
2020-02-04T21:49:55.532Z,1580852995.532 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2020-02-04T21:49:55.533Z,1580852995.533 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 407684E0
2020-02-04T21:49:55.533Z,1580852995.533 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 1092
2020-02-04T21:49:55.557Z,1580852995.557 [DDM] Loaded
2020-02-04T21:49:55.557Z,1580852995.557 [ComponentRegistry](DEBUG): SyncComponent "DDM" handled in the control thread.
2020-02-04T21:49:55.570Z,1580852995.570 [Depth_Keller] Loaded
2020-02-04T21:49:55.570Z,1580852995.570 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2020-02-04T21:49:55.574Z,1580852995.574 [DropWeight] Loaded
2020-02-04T21:49:55.575Z,1580852995.575 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2020-02-04T21:49:55.635Z,1580852995.635 [DUSBL_Hydroid] Loaded
2020-02-04T21:49:55.635Z,1580852995.635 [ComponentRegistry](DEBUG): SyncComponent "DUSBL_Hydroid" handled in the control thread.
2020-02-04T21:49:55.681Z,1580852995.681 [Micromodem] Loaded
2020-02-04T21:49:55.681Z,1580852995.681 [ComponentRegistry](DEBUG): SyncComponent "Micromodem" handled in the control thread.
2020-02-04T21:49:55.775Z,1580852995.775 [NAL9602] Loaded
2020-02-04T21:49:55.776Z,1580852995.776 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2020-02-04T21:49:55.814Z,1580852995.814 [Onboard] Loaded
2020-02-04T21:49:55.815Z,1580852995.815 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2020-02-04T21:49:55.820Z,1580852995.820 [PowerOnly] Loaded
2020-02-04T21:49:55.821Z,1580852995.821 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2020-02-04T21:49:55.827Z,1580852995.827 [Radio_Surface] Loaded
2020-02-04T21:49:55.827Z,1580852995.827 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2020-02-04T21:49:55.828Z,1580852995.828 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407984E0
2020-02-04T21:49:55.829Z,1580852995.829 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1093
2020-02-04T21:49:55.871Z,1580852995.871 [RDI_Pathfinder] Loaded
2020-02-04T21:49:55.871Z,1580852995.871 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2020-02-04T21:49:57.321Z,1580852997.321 [BPC1] Loaded
2020-02-04T21:49:57.321Z,1580852997.321 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2020-02-04T21:49:57.321Z,1580852997.321 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2020-02-04T21:49:57.322Z,1580852997.322 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2020-02-04T21:49:57.335Z,1580852997.335 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2020-02-04T21:49:57.336Z,1580852997.336 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2020-02-04T21:49:57.450Z,1580852997.450 [DeadReckonUsingMultipleVelocitySources] Loaded
2020-02-04T21:49:57.451Z,1580852997.451 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2020-02-04T21:49:57.471Z,1580852997.471 [NavChart] Loaded
2020-02-04T21:49:57.471Z,1580852997.471 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2020-02-04T21:49:57.475Z,1580852997.475 [UniversalFixResidualReporter] Loaded
2020-02-04T21:49:57.475Z,1580852997.475 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2020-02-04T21:49:57.475Z,1580852997.475 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2020-02-04T21:49:57.476Z,1580852997.476 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2020-02-04T21:49:57.583Z,1580852997.583 [BuoyancyServo] Loaded
2020-02-04T21:49:57.584Z,1580852997.584 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2020-02-04T21:49:57.598Z,1580852997.598 [ElevatorServo] Loaded
2020-02-04T21:49:57.599Z,1580852997.599 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2020-02-04T21:49:57.613Z,1580852997.613 [MassServo] Loaded
2020-02-04T21:49:57.613Z,1580852997.613 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2020-02-04T21:49:57.628Z,1580852997.628 [RudderServo] Loaded
2020-02-04T21:49:57.628Z,1580852997.628 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2020-02-04T21:49:57.642Z,1580852997.642 [ThrusterServo] Loaded
2020-02-04T21:49:57.642Z,1580852997.642 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2020-02-04T21:49:57.643Z,1580852997.643 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2020-02-04T21:49:57.643Z,1580852997.643 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2020-02-04T21:49:57.838Z,1580852997.838 [PAR_Licor] Loaded
2020-02-04T21:49:57.839Z,1580852997.839 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2020-02-04T21:49:57.881Z,1580852997.881 [WetLabsSeaOWL_UV_A] Loaded
2020-02-04T21:49:57.882Z,1580852997.882 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2020-02-04T21:49:57.883Z,1580852997.883 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 408EC4E0
2020-02-04T21:49:57.883Z,1580852997.883 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 1094
2020-02-04T21:49:57.884Z,1580852997.884 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2020-02-04T21:49:57.884Z,1580852997.884 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2020-02-04T21:49:58.222Z,1580852998.222 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2020-02-04T21:49:58.222Z,1580852998.222 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2020-02-04T21:49:58.263Z,1580852998.263 [DepthRateCalculator] Loaded
2020-02-04T21:49:58.264Z,1580852998.264 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2020-02-04T21:49:58.269Z,1580852998.269 [PitchRateCalculator] Loaded
2020-02-04T21:49:58.269Z,1580852998.269 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2020-02-04T21:49:58.281Z,1580852998.281 [SpeedCalculator] Loaded
2020-02-04T21:49:58.281Z,1580852998.281 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2020-02-04T21:49:58.302Z,1580852998.302 [TempGradientCalculator] Loaded
2020-02-04T21:49:58.302Z,1580852998.302 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2020-02-04T21:49:58.307Z,1580852998.307 [YawRateCalculator] Loaded
2020-02-04T21:49:58.308Z,1580852998.308 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2020-02-04T21:49:58.347Z,1580852998.347 [ElevatorOffsetCalculator] Loaded
2020-02-04T21:49:58.347Z,1580852998.347 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2020-02-04T21:49:58.348Z,1580852998.348 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2020-02-04T21:49:58.348Z,1580852998.348 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2020-02-04T21:49:58.488Z,1580852998.488 [SBIT](DEBUG): Construct Startup Built In Test.
2020-02-04T21:49:58.509Z,1580852998.509 [SBIT] Loaded
2020-02-04T21:49:58.509Z,1580852998.509 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2020-02-04T21:49:58.510Z,1580852998.510 [IBIT](DEBUG): Construct Initiated Built In Test.
2020-02-04T21:49:58.522Z,1580852998.522 [IBIT] Loaded
2020-02-04T21:49:58.522Z,1580852998.522 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2020-02-04T21:49:58.525Z,1580852998.525 [CBIT](DEBUG): Construct Continuous Built In Test.
2020-02-04T21:49:58.661Z,1580852998.661 [CBIT] Loaded
2020-02-04T21:49:58.661Z,1580852998.661 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2020-02-04T21:49:58.661Z,1580852998.661 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2020-02-04T21:49:58.662Z,1580852998.662 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2020-02-04T21:49:58.747Z,1580852998.747 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2020-02-04T21:49:58.747Z,1580852998.747 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2020-02-04T21:49:58.847Z,1580852998.847 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2020-02-04T21:49:58.848Z,1580852998.848 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2020-02-04T21:49:58.898Z,1580852998.898 [VerticalControl](DEBUG): Construct VerticalControl.
2020-02-04T21:49:58.979Z,1580852998.979 [VerticalControl] Loaded
2020-02-04T21:49:58.979Z,1580852998.979 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2020-02-04T21:49:58.980Z,1580852998.980 [HorizontalControl](DEBUG): Construct HorizontalControl.
2020-02-04T21:49:59.048Z,1580852999.048 [HorizontalControl] Loaded
2020-02-04T21:49:59.048Z,1580852999.048 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2020-02-04T21:49:59.049Z,1580852999.049 [SpeedControl](DEBUG): Construct SpeedControl.
2020-02-04T21:49:59.050Z,1580852999.050 [SpeedControl] Loaded
2020-02-04T21:49:59.050Z,1580852999.050 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2020-02-04T21:49:59.051Z,1580852999.051 [LoopControl](DEBUG): Construct LoopControl.
2020-02-04T21:49:59.052Z,1580852999.052 [LoopControl] Loaded
2020-02-04T21:49:59.052Z,1580852999.052 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2020-02-04T21:49:59.052Z,1580852999.052 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2020-02-04T21:49:59.053Z,1580852999.053 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2020-02-04T21:49:59.085Z,1580852999.085 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2020-02-04T21:49:59.089Z,1580852999.089 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2020-02-04T21:49:59.090Z,1580852999.090 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2020-02-04T21:49:59.096Z,1580852999.096 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2020-02-04T21:49:59.097Z,1580852999.097 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40ACC4E0
2020-02-04T21:49:59.098Z,1580852999.098 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1095
2020-02-04T21:49:59.102Z,1580852999.102 [Supervisor](INFO): Main Thread ID is 815
2020-02-04T21:49:59.102Z,1580852999.102 [Supervisor](DEBUG): Running supervisor.
2020-02-04T21:49:59.103Z,1580852999.103 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1096
2020-02-04T21:49:59.105Z,1580852999.105 [controlThread ThreadHandler](INFO): Handler Thread ID is 1097
2020-02-04T21:49:59.106Z,1580852999.106 [controlThread](DEBUG): Initializing ControlThread
2020-02-04T21:49:59.112Z,1580852999.112 [NavChart](DEBUG): Initialize NavChart Navigation.
2020-02-04T21:49:59.112Z,1580852999.112 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2020-02-04T21:49:59.117Z,1580852999.117 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2020-02-04T21:49:59.117Z,1580852999.117 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2020-02-04T21:49:59.117Z,1580852999.117 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2020-02-04T21:49:59.118Z,1580852999.118 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2020-02-04T21:49:59.118Z,1580852999.118 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2020-02-04T21:49:59.118Z,1580852999.118 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2020-02-04T21:49:59.119Z,1580852999.119 [SBIT](INFO): Initialize SBIT Component.
2020-02-04T21:49:59.119Z,1580852999.119 [SBIT](IMPORTANT): git: 2020-02-04
2020-02-04T21:49:59.120Z,1580852999.120 [SBIT](INFO): git hash: 9b20438532c20a3476375e83a15ad70cdaf0bc6e
2020-02-04T21:49:59.120Z,1580852999.120 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2020-02-04T21:49:59.121Z,1580852999.121 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Wed Nov 13 12:38:10 PST 2019
2020-02-04T21:49:59.122Z,1580852999.122 [SBIT](INFO): Beginning SBIT in 39.000000 seconds.
2020-02-04T21:49:59.123Z,1580852999.123 [IBIT](INFO): Initialize IBIT Component.
2020-02-04T21:49:59.124Z,1580852999.124 [CBIT](DEBUG): Initialize CBIT Component.
2020-02-04T21:49:59.125Z,1580852999.125 [logger ThreadHandler](INFO): Handler Thread ID is 1098
2020-02-04T21:49:59.136Z,1580852999.136 [CBIT](DEBUG): Initialized mux pins.
2020-02-04T21:49:59.137Z,1580852999.137 [CBIT](DEBUG): Initializing the watchdog timer.
2020-02-04T21:49:59.145Z,1580852999.145 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 1099
2020-02-04T21:49:59.146Z,1580852999.146 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2020-02-04T21:49:59.157Z,1580852999.157 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1100
2020-02-04T21:49:59.161Z,1580852999.161 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2020-02-04T21:49:59.161Z,1580852999.161 [CBIT](DEBUG): Initializing heartbeat.
2020-02-04T21:49:59.169Z,1580852999.169 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 1101
2020-02-04T21:49:59.170Z,1580852999.170 [WetLabsSeaOWL_UV_A](INFO): Powering down
2020-02-04T21:49:59.197Z,1580852999.197 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1102
2020-02-04T21:49:59.200Z,1580852999.200 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2020-02-04T21:49:59.201Z,1580852999.201 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2020-02-04T21:49:59.201Z,1580852999.201 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2020-02-04T21:49:59.201Z,1580852999.201 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2020-02-04T21:49:59.201Z,1580852999.201 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2020-02-04T21:49:59.201Z,1580852999.201 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2020-02-04T21:49:59.201Z,1580852999.201 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2020-02-04T21:49:59.202Z,1580852999.202 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2020-02-04T21:49:59.202Z,1580852999.202 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2020-02-04T21:49:59.202Z,1580852999.202 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2020-02-04T21:49:59.202Z,1580852999.202 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2020-02-04T21:49:59.202Z,1580852999.202 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2020-02-04T21:49:59.202Z,1580852999.202 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2020-02-04T21:49:59.202Z,1580852999.202 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2020-02-04T21:49:59.203Z,1580852999.203 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2020-02-04T21:49:59.203Z,1580852999.203 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2020-02-04T21:49:59.233Z,1580852999.233 [CBIT](DEBUG): Deactivating GF circuits.
2020-02-04T21:49:59.233Z,1580852999.233 [CBIT](DEBUG): Deactivating emergency mode.
2020-02-04T21:49:59.268Z,1580852999.268 [CBIT](DEBUG): Backplane powered.
2020-02-04T21:49:59.269Z,1580852999.269 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2020-02-04T21:49:59.270Z,1580852999.270 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2020-02-04T21:49:59.271Z,1580852999.271 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2020-02-04T21:49:59.272Z,1580852999.272 [LoopControl](DEBUG): Initialize LoopControlComponent.
2020-02-04T21:49:59.273Z,1580852999.273 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2020-02-04T21:49:59.283Z,1580852999.283 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2020-02-04T21:49:59.306Z,1580852999.306 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2020-02-04T21:49:59.306Z,1580852999.306 [MissionManager](INFO): Loading Mission: Missions/underIce/DefaultWithUndock.xml
2020-02-04T21:49:59.383Z,1580852999.383 [MissionManager](INFO): DefineArg DefaultWithUndock.ElapsedSinceDefaultStarted = 0.000000 min
2020-02-04T21:49:59.398Z,1580852999.398 [MissionManager](INFO): DefineArg DefaultWithUndock.DetachTimeout = 30.000000 min
2020-02-04T21:49:59.402Z,1580852999.402 [MissionManager](INFO): DefineArg DefaultWithUndock.MicromodemCommsInterval = 2.000000 min
2020-02-04T21:49:59.403Z,1580852999.403 [DefaultWithUndock:A.Wait](DEBUG): Construct Wait.
2020-02-04T21:49:59.424Z,1580852999.424 [DefaultWithUndock:B.Undock](DEBUG): Construct.
2020-02-04T21:49:59.462Z,1580852999.462 [DefaultWithUndock:C.GoToSurface](DEBUG): Construct GoToSurface.
2020-02-04T21:49:59.504Z,1580852999.504 [DefaultWithUndock:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2020-02-04T21:49:59.507Z,1580852999.507 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Construct Wait.
2020-02-04T21:49:59.512Z,1580852999.512 [DefaultWithUndock:F.Execute](DEBUG): Construct Execute.
2020-02-04T21:49:59.532Z,1580852999.532 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="DefaultWithUndock">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <DefineArg Name="DetachTimeout"><Description>
        Maximum time duration for the vehicle to reach the approach depth after detaching form the dock.
        The vehicle will switch over to midcourse guidance after the timeout is expired.
    </Description><Units:minute/><Value>30</Value></DefineArg>

    <DefineArg Name="MicromodemCommsInterval"><Description>
        How often to trigger Umodem communications
    </Description><Units:minute/><Value>2</Value></DefineArg>
        
    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>30</Value></Setting>
    </Guidance:Wait>

    <!-- Leave the dock if necessary --> 
    <Guidance:Undock>
        <Sequence/>
        <Timeout Duration="DetachTimeout">
            <Syslog Severity="Important">Timed out while trying to detach from dock at current depth of <Universal:depth/><Units:meter/>.</Syslog>
        </Timeout>
    </Guidance:Undock>

    <!-- This mission assumes open water so from here on it's the same old default that's always used -->
    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2020-02-04T21:49:59.553Z,1580852999.553 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,DDM,Depth_Keller,DropWeight,DUSBL_Hydroid,Micromodem,NAL9602,Onboard,PowerOnly,RDI_Pathfinder,BPC1,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2020-02-04T21:49:59.560Z,1580852999.560 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2020-02-04T21:49:59.561Z,1580852999.561 [Radio_Surface](INFO): Powering up
2020-02-04T21:49:59.605Z,1580852999.605 [DDM](INFO): Powering up
2020-02-04T21:49:59.605Z,1580852999.605 [DDM](DEBUG): Initializing DDM.
2020-02-04T21:49:59.635Z,1580852999.635 [DUSBL_Hydroid](INFO): Powering up
2020-02-04T21:49:59.635Z,1580852999.635 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2020-02-04T21:49:59.882Z,1580852999.882 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2020-02-04T21:49:59.889Z,1580852999.889 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2020-02-04T21:49:59.890Z,1580852999.890 [ElevatorServo](DEBUG): Initializing EZServoServo.
2020-02-04T21:49:59.901Z,1580852999.901 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2020-02-04T21:49:59.902Z,1580852999.902 [MassServo](DEBUG): Initializing EZServoServo.
2020-02-04T21:49:59.909Z,1580852999.909 [MassServo](DEBUG): Initializing MassServo.
2020-02-04T21:49:59.910Z,1580852999.910 [RudderServo](DEBUG): Initializing EZServoServo.
2020-02-04T21:49:59.917Z,1580852999.917 [RudderServo](DEBUG): Initializing RudderServo.
2020-02-04T21:49:59.918Z,1580852999.918 [ThrusterServo](DEBUG): Initializing EZServoServo.
2020-02-04T21:49:59.925Z,1580852999.925 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2020-02-04T21:49:59.985Z,1580852999.985 [Depth_Keller](ERROR): Pressure reading out of range: 1913.424561 decibar
2020-02-04T21:49:59.988Z,1580852999.988 [Micromodem](INFO): Powering up
2020-02-04T21:49:59.988Z,1580852999.988 [Micromodem](DEBUG): Initializing Micromodem.
2020-02-04T21:50:00.749Z,1580853000.749 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2020-02-04T21:50:00.749Z,1580853000.749 [RudderServo](FAULT): Rudder failed to initialize
2020-02-04T21:50:00.749Z,1580853000.749 [RudderServo] Communications Fault, FailCount= 1
2020-02-04T21:50:00.749Z,1580853000.749 [RudderServo](ERROR): Communications Fault
2020-02-04T21:50:00.860Z,1580853000.860 [CBIT](ERROR): Communications Fault in component: RudderServo
2020-02-04T21:50:01.038Z,1580853001.038 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-02-04T21:50:01.038Z,1580853001.038 [RudderServo](INFO): Powering down
2020-02-04T21:50:01.732Z,1580853001.732 [RudderServo](DEBUG): Initializing EZServoServo.
2020-02-04T21:50:01.865Z,1580853001.865 [RudderServo](DEBUG): Initializing RudderServo.
2020-02-04T21:50:01.869Z,1580853001.869 [CBIT](INFO): Clearing failed state for component RudderServo
2020-02-04T21:50:01.869Z,1580853001.869 [RudderServo] No Fault, FailCount= 1
2020-02-04T21:50:04.950Z,1580853004.950 [Micromodem](INFO): Nmea out: $CCCFG,ALL,0*33

2020-02-04T21:50:05.356Z,1580853005.356 [Micromodem](ERROR): Response from modem failed NMEA checksum: $CAREV,215006,INIT,20.32731*43
 expected 6D
2020-02-04T21:50:05.356Z,1580853005.356 [Micromodem](INFO): Nmea out: $CCCFG,ALL,0*33

2020-02-04T21:50:07.023Z,1580853007.023 [Micromodem](INFO): Nmea in: $CATMG,2020-02-04T21:50:06.419061Z,RTC,RTC*5D

2020-02-04T21:50:07.024Z,1580853007.024 [Micromodem](ERROR): CFG response from modem unexpected: $CATMG,2020-02-04T21:50:06.419061Z,RTC,RTC*5D

2020-02-04T21:50:07.431Z,1580853007.431 [Micromodem](INFO): Nmea in: $CACFG,ALL,0*31

2020-02-04T21:50:07.431Z,1580853007.431 [Micromodem](INFO): Nmea out: $CCCFG,SRC,1*31

2020-02-04T21:50:07.819Z,1580853007.819 [Micromodem](INFO): Nmea in: $CACFG,ALL,0*31

2020-02-04T21:50:07.819Z,1580853007.819 [Micromodem](ERROR): CFG response from modem unexpected: $CACFG,ALL,0*31

2020-02-04T21:50:08.239Z,1580853008.239 [Micromodem](INFO): Nmea in: $CACFG,SRC,1*33

2020-02-04T21:50:08.239Z,1580853008.239 [Micromodem](INFO): Nmea out: $CCCFG,nav.dt.txtrig_gpio4,1*64

2020-02-04T21:50:08.619Z,1580853008.619 [Micromodem](INFO): Nmea in: $CACFG,nav.dt.txtrig_gpio4,1*66

2020-02-04T21:50:08.619Z,1580853008.619 [Micromodem](INFO): Nmea out: $CCCFG,pwramp.txlevel,0*2F

2020-02-04T21:50:09.027Z,1580853009.027 [Micromodem](INFO): Nmea in: $CACFG,pwramp.txlevel,0*2D

2020-02-04T21:50:09.027Z,1580853009.027 [Micromodem](INFO): Nmea out: $CCCFG,DTO,30*1E

2020-02-04T21:50:09.423Z,1580853009.423 [Micromodem](INFO): Nmea in: $CACFG,DTO,30*1C

2020-02-04T21:50:09.423Z,1580853009.423 [Micromodem](INFO): Nmea out: $CCCFG,FC0,10000*46

2020-02-04T21:50:09.827Z,1580853009.827 [Micromodem](INFO): Nmea in: $CACFG,FC0,10000*44

2020-02-04T21:50:09.827Z,1580853009.827 [Micromodem](INFO): Nmea out: $CCCFG,BW0,4000*63

2020-02-04T21:50:10.230Z,1580853010.230 [DDM](INFO): Dynamic Docking Module:
2020-02-04T21:50:10.343Z,1580853010.343 [Micromodem](INFO): Nmea in: $CACFG,BW0,4000*61

2020-02-04T21:50:10.343Z,1580853010.343 [Micromodem](INFO): Nmea out: $CCCFG,BND,0*3A

2020-02-04T21:50:10.627Z,1580853010.627 [Micromodem](INFO): Nmea in: $CACFG,BND,0*38

2020-02-04T21:50:10.628Z,1580853010.628 [Micromodem](INFO): Nmea out: $CCCLK,2020,02,04,21,50,11*44

2020-02-04T21:50:11.055Z,1580853011.055 [Micromodem](INFO): Nmea in: $CACLK,2020,2,4,21,50,11*46

2020-02-04T21:50:11.839Z,1580853011.839 [Micromodem](INFO): Nmea in: $CATMS,0,2020-02-04T21:50:12Z*75

2020-02-04T21:50:11.850Z,1580853011.850 [Micromodem](INFO): Nmea in: $CATMG,2020-02-04T21:50:12.026067Z,USER_CMD,RTC*17

2020-02-04T21:50:13.085Z,1580853013.085 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder
2020-02-04T21:50:17.515Z,1580853017.515 [DUSBL_Hydroid](INFO): DUSBL Version:O
2020-02-04T21:50:25.979Z,1580853025.979 [NAL9602](INFO): Powering up NAL9602
2020-02-04T21:50:36.891Z,1580853036.891 [NAL9602](INFO): NAL9602 initialized
2020-02-04T21:50:38.577Z,1580853038.577 [SBIT](IMPORTANT): Beginning Startup BIT
2020-02-04T21:50:38.585Z,1580853038.585 [CBIT](IMPORTANT): Beginning ground fault scan
2020-02-04T21:50:49.624Z,1580853049.624 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.009147
CHAN A1 (24V): -0.028546
CHAN A2 (12V): -0.007214
CHAN A3 (5V): -0.002269
CHAN B0 (3.3V): -0.000037
CHAN B1 (3.15aV): -0.000090
CHAN B2 (3.15bV): -0.000082
CHAN B3 (GND): 0.002427
OPEN: 0.004609
Full Scale Calc: 4.765 mA, -1.589 mA
2020-02-04T21:51:32.235Z,1580853092.235 [SBIT](IMPORTANT): SBIT PASSED
2020-02-04T21:51:32.235Z,1580853092.235 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2020-02-04T21:51:32.240Z,1580853092.240 [SBIT](IMPORTANT): DUSBL_Hydroid.verbosity=3 enum;

2020-02-04T21:51:32.241Z,1580853092.241 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=105 cubic_centimeter;

2020-02-04T21:51:32.241Z,1580853092.241 [SBIT](IMPORTANT): VerticalControl.massDefault=0.5 centimeter;

2020-02-04T21:51:32.605Z,1580853092.605 [MissionManager](IMPORTANT): Started mission Startup
2020-02-04T21:51:32.605Z,1580853092.605 [Startup] Running Loop=1
2020-02-04T21:51:32.605Z,1580853092.605 [Startup](DEBUG): Aggregate::initialize Startup
2020-02-04T21:51:32.605Z,1580853092.605 [Startup:A.GoToSurface] Running Loop=1
2020-02-04T21:51:32.606Z,1580853092.606 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-02-04T21:51:32.606Z,1580853092.606 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-02-04T21:51:32.607Z,1580853092.607 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-02-04T21:51:32.607Z,1580853092.607 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-02-04T21:51:32.607Z,1580853092.607 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-02-04T21:51:32.608Z,1580853092.608 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-02-04T21:51:32.609Z,1580853092.609 [Startup:StartupSatComms] Running Loop=1
2020-02-04T21:51:32.609Z,1580853092.609 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2020-02-04T21:51:32.609Z,1580853092.609 [Startup:StartupSatComms:A] Running Loop=1
2020-02-04T21:51:33.023Z,1580853093.023 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2020-02-04T21:52:32.784Z,1580853152.784 [Startup:StartupSatComms:A](INFO): Timed out from 2020-02-04T21:51:32.6Z
2020-02-04T21:52:32.784Z,1580853152.784 [Startup:StartupSatComms:A] Stopped
2020-02-04T21:52:32.785Z,1580853152.785 [Startup:StartupSatComms:B] Running Loop=1
2020-02-04T21:52:33.204Z,1580853153.204 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-02-04T21:52:59.442Z,1580853179.442 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2020-02-04T21:52:59.442Z,1580853179.442 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-02-04T21:52:59.468Z,1580853179.468 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-02-04T21:52:59.884Z,1580853179.884 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-02-04T21:52:59.884Z,1580853179.884 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2020-02-04T21:53:32.993Z,1580853212.993 [Startup:StartupSatComms:B](INFO): Timed out from 2020-02-04T21:52:32.8Z
2020-02-04T21:53:32.993Z,1580853212.993 [Startup:StartupSatComms:B] Stopped
2020-02-04T21:53:32.993Z,1580853212.993 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2020-02-04T21:53:32.993Z,1580853212.993 [Startup:StartupSatComms] Stopped
2020-02-04T21:53:32.993Z,1580853212.993 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2020-02-04T21:53:32.994Z,1580853212.994 [Startup](INFO): Completed Startup
2020-02-04T21:53:32.994Z,1580853212.994 [MissionManager](INFO): Startup is completed.
2020-02-04T21:53:32.994Z,1580853212.994 [MissionManager](INFO): Uninitializing Mission Startup
2020-02-04T21:53:32.994Z,1580853212.994 [Startup] Stopped
2020-02-04T21:53:32.994Z,1580853212.994 [Startup](DEBUG): Aggregate::uninitialize Startup
2020-02-04T21:53:32.994Z,1580853212.994 [Startup:A.GoToSurface] Stopped
2020-02-04T21:53:32.994Z,1580853212.994 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-02-04T21:53:33.391Z,1580853213.391 [MissionManager](IMPORTANT): Started mission DefaultWithUndock
2020-02-04T21:53:33.391Z,1580853213.391 [DefaultWithUndock] Running Loop=1
2020-02-04T21:53:33.392Z,1580853213.392 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock
2020-02-04T21:53:33.392Z,1580853213.392 [DefaultWithUndock:C.GoToSurface] Running Loop=1
2020-02-04T21:53:33.392Z,1580853213.392 [DefaultWithUndock:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-02-04T21:53:33.392Z,1580853213.392 [DefaultWithUndock:C.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-02-04T21:53:33.392Z,1580853213.392 [DefaultWithUndock:C.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-02-04T21:53:33.393Z,1580853213.393 [DefaultWithUndock:C.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-02-04T21:53:33.393Z,1580853213.393 [DefaultWithUndock:C.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-02-04T21:53:33.393Z,1580853213.393 [DefaultWithUndock:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-02-04T21:53:33.394Z,1580853213.394 [DefaultWithUndock:A.Wait] Running Loop=1
2020-02-04T21:53:33.394Z,1580853213.394 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component.
2020-02-04T21:53:41.063Z,1580853221.063 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2020-02-04T21:53:41.563Z,1580853221.563 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004751
2020-02-04T21:54:03.697Z,1580853243.697 [DefaultWithUndock:A.Wait](INFO): Done Waiting.
2020-02-04T21:54:03.697Z,1580853243.697 [DefaultWithUndock:A.Wait] Stopped
2020-02-04T21:54:03.697Z,1580853243.697 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component.
2020-02-04T21:54:03.698Z,1580853243.698 [DefaultWithUndock:B.Undock] Running Loop=1
2020-02-04T21:54:03.698Z,1580853243.698 [DefaultWithUndock:B.Undock](DEBUG): Initialize.
2020-02-04T21:54:04.499Z,1580853244.499 [PowerOnly](INFO): Powering up
2020-02-04T21:54:07.398Z,1580853247.398 [DefaultWithUndock:B.Undock](INFO): Detaching from dock.
2020-02-04T21:54:07.929Z,1580853247.929 [DefaultWithUndock:B.Undock](INFO): Detected possible detachment. Starting timer.
2020-02-04T21:54:23.810Z,1580853263.810 [CommandLine](IMPORTANT): got command strobe off
2020-02-04T21:54:23.810Z,1580853263.810 [CommandLine](IMPORTANT): Deactivating strobe
2020-02-04T21:54:27.980Z,1580853267.980 [DefaultWithUndock:B.Undock](INFO): Detached at range: nan m. Transitioning DDM to standby.
2020-02-04T21:54:30.814Z,1580853270.814 [DefaultWithUndock:B.Undock](INFO): DDM at standby.
2020-02-04T21:54:31.234Z,1580853271.234 [DefaultWithUndock:B.Undock](IMPORTANT): Undocking sequence complete.
2020-02-04T21:54:31.234Z,1580853271.234 [DefaultWithUndock:B.Undock] Stopped
2020-02-04T21:54:31.644Z,1580853271.644 [DefaultWithUndock:CheckIn] Running Loop=1
2020-02-04T21:54:31.644Z,1580853271.644 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:CheckIn
2020-02-04T21:54:31.645Z,1580853271.645 [DefaultWithUndock:CheckIn:Read_GPS] Running Loop=1
2020-02-04T21:54:32.026Z,1580853272.026 [DefaultWithUndock:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-02-04T21:55:18.196Z,1580853318.196 [CommandLine](IMPORTANT): got command show variable stopdepth
2020-02-04T21:55:18.231Z,1580853318.231 [CommandLine](IMPORTANT): VerticalControl.stopDepthExcursion (meter)
2020-02-04T21:55:18.234Z,1580853318.234 [CommandLine](IMPORTANT): CBIT.stopDepth (meter)
2020-02-04T21:55:23.109Z,1580853323.109 [CommandLine](IMPORTANT): got command get CBIT.stopDepth
2020-02-04T21:55:23.110Z,1580853323.110 [CommandLine](IMPORTANT): CBIT.stopDepth 215.000000 m
2020-02-04T21:55:30.083Z,1580853330.083 [CommandLine](IMPORTANT): got command get CBIT.abortDepth
2020-02-04T21:55:30.084Z,1580853330.084 [CommandLine](IMPORTANT): CBIT.abortDepth 255.000000 m
2020-02-04T21:55:35.832Z,1580853335.832 [PowerOnly](INFO): Powering down
2020-02-04T21:55:40.227Z,1580853340.227 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2020-02-04T21:56:00.474Z,1580853360.474 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2020-02-04T21:56:00.474Z,1580853360.474 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-02-04T21:56:00.484Z,1580853360.484 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-02-04T21:56:00.899Z,1580853360.899 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-02-04T21:56:00.899Z,1580853360.899 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2020-02-04T21:57:28.444Z,1580853448.444 [CommandLine](IMPORTANT): got command show variable limitAft
2020-02-04T21:57:28.485Z,1580853448.485 [CommandLine](IMPORTANT): VerticalControl.massPositionLimitAft (millimeter)
2020-02-04T21:57:36.540Z,1580853456.540 [CommandLine](IMPORTANT): got command get VerticalControl.massPositionLimitAft
2020-02-04T21:57:36.540Z,1580853456.540 [CommandLine](IMPORTANT): VerticalControl.massPositionLimitAft -25.000000 mm
2020-02-04T21:57:41.126Z,1580853461.126 [CommandLine](IMPORTANT): got command get VerticalControl.massPositionLimitFwd
2020-02-04T21:57:41.126Z,1580853461.126 [CommandLine](IMPORTANT): VerticalControl.massPositionLimitFwd 33.000000 mm
2020-02-04T21:58:13.013Z,1580853493.013 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2020-02-04T21:58:13.016Z,1580853493.016 [BPC1](INFO): Received data from all battery sticks.
2020-02-04T21:59:01.498Z,1580853541.498 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2020-02-04T21:59:01.498Z,1580853541.498 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-02-04T21:59:01.528Z,1580853541.528 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-02-04T21:59:01.898Z,1580853541.898 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-02-04T21:59:01.899Z,1580853541.899 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2020-02-04T21:59:31.794Z,1580853571.794 [DefaultWithUndock:CheckIn:Read_GPS](INFO): Timed out from 2020-02-04T21:54:31.6Z
2020-02-04T21:59:31.794Z,1580853571.794 [DefaultWithUndock:CheckIn:Read_GPS] Stopped
2020-02-04T21:59:31.794Z,1580853571.794 [DefaultWithUndock:CheckIn:Read_Iridium] Running Loop=1
2020-02-04T21:59:32.185Z,1580853572.185 [DefaultWithUndock:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2020-02-04T21:59:33.044Z,1580853573.044 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200204T212104/Courier0010.lzma
2020-02-04T21:59:35.038Z,1580853575.038 [DataOverHttps](INFO): Moved sent file to Logs/20200204T212104/Courier0010.lzma.bak
2020-02-04T21:59:35.038Z,1580853575.038 [DataOverHttps](INFO): SBD MOMSN=12218618
2020-02-04T21:59:55.504Z,1580853595.504 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20200204T214016/Courier0000.lzma
2020-02-04T21:59:57.510Z,1580853597.510 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214016/Courier0000.lzma.bak
2020-02-04T21:59:57.510Z,1580853597.510 [DataOverHttps](INFO): SBD MOMSN=12218620
2020-02-04T22:00:14.560Z,1580853614.560 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20200204T214016/Courier0004.lzma
2020-02-04T22:00:16.566Z,1580853616.566 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214016/Courier0004.lzma.bak
2020-02-04T22:00:16.566Z,1580853616.566 [DataOverHttps](INFO): SBD MOMSN=12218623
2020-02-04T22:00:33.615Z,1580853633.615 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20200204T214949/Courier0000.lzma
2020-02-04T22:00:35.189Z,1580853635.189 [CommandLine](IMPORTANT): got command failComponent
2020-02-04T22:00:35.189Z,1580853635.189 [CommandLine](IMPORTANT): Failed components:
2020-02-04T22:00:35.189Z,1580853635.189 [CommandLine](IMPORTANT): No failed Components.
2020-02-04T22:00:35.618Z,1580853635.618 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214949/Courier0000.lzma.bak
2020-02-04T22:00:35.618Z,1580853635.618 [DataOverHttps](INFO): SBD MOMSN=12218625
2020-02-04T22:00:38.047Z,1580853638.047 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-02-04T22:00:38.047Z,1580853638.047 [NAL9602] Data Fault, FailCount= 1
2020-02-04T22:00:38.047Z,1580853638.047 [NAL9602](ERROR): Data Fault
2020-02-04T22:00:38.106Z,1580853638.106 [CBIT](ERROR): Data Fault in component: NAL9602
2020-02-04T22:00:38.451Z,1580853638.451 [NAL9602](INFO): Powering down
2020-02-04T22:00:39.346Z,1580853639.346 [CBIT](INFO): Clearing failed state for component NAL9602
2020-02-04T22:00:39.346Z,1580853639.346 [NAL9602] No Fault, FailCount= 1
2020-02-04T22:00:52.580Z,1580853652.580 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20200204T214949/Courier0004.lzma
2020-02-04T22:00:54.586Z,1580853654.586 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214949/Courier0004.lzma.bak
2020-02-04T22:00:54.586Z,1580853654.586 [DataOverHttps](INFO): SBD MOMSN=12218628
2020-02-04T22:01:08.747Z,1580853668.747 [NAL9602](INFO): Powering up NAL9602
2020-02-04T22:01:11.589Z,1580853671.589 [DataOverHttps](INFO): Sending 2182 bytes from file Logs/20200204T205603/Express0005.lzma
2020-02-04T22:01:13.590Z,1580853673.590 [DataOverHttps](INFO): Moved sent file to Logs/20200204T205603/Express0005.lzma.bak
2020-02-04T22:01:13.590Z,1580853673.590 [DataOverHttps](INFO): SBD MOMSN=12218630
2020-02-04T22:01:19.663Z,1580853679.663 [NAL9602](INFO): NAL9602 initialized
2020-02-04T22:01:30.667Z,1580853690.667 [DataOverHttps](INFO): Sending 703 bytes from file Logs/20200204T212104/Express0001.lzma
2020-02-04T22:01:32.670Z,1580853692.670 [DataOverHttps](INFO): Moved sent file to Logs/20200204T212104/Express0001.lzma.bak
2020-02-04T22:01:32.670Z,1580853692.670 [DataOverHttps](INFO): SBD MOMSN=12218851
2020-02-04T22:01:52.875Z,1580853712.875 [DataOverHttps](INFO): Sending 947 bytes from file Logs/20200204T212104/Express0005.lzma
2020-02-04T22:01:54.870Z,1580853714.870 [DataOverHttps](INFO): Moved sent file to Logs/20200204T212104/Express0005.lzma.bak
2020-02-04T22:01:54.870Z,1580853714.870 [DataOverHttps](INFO): SBD MOMSN=12218867
2020-02-04T22:02:02.546Z,1580853722.546 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2020-02-04T22:02:02.546Z,1580853722.546 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-02-04T22:02:02.556Z,1580853722.556 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-02-04T22:02:02.972Z,1580853722.972 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-02-04T22:02:02.972Z,1580853722.972 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2020-02-04T22:02:14.243Z,1580853734.243 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-04T22:02:14.244Z,1580853734.244 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2020-02-04T22:02:15.001Z,1580853735.001 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200204T212104/Express0008.lzma
2020-02-04T22:02:17.006Z,1580853737.006 [DataOverHttps](INFO): Moved sent file to Logs/20200204T212104/Express0008.lzma.bak
2020-02-04T22:02:17.006Z,1580853737.006 [DataOverHttps](INFO): SBD MOMSN=12218918
2020-02-04T22:02:34.046Z,1580853754.046 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20200204T212104/Express0011.lzma
2020-02-04T22:02:36.051Z,1580853756.051 [DataOverHttps](INFO): Moved sent file to Logs/20200204T212104/Express0011.lzma.bak
2020-02-04T22:02:36.051Z,1580853756.051 [DataOverHttps](INFO): SBD MOMSN=12218920
2020-02-04T22:02:52.990Z,1580853772.990 [DataOverHttps](INFO): Sending 714 bytes from file Logs/20200204T214016/Express0001.lzma
2020-02-04T22:02:54.994Z,1580853774.994 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214016/Express0001.lzma.bak
2020-02-04T22:02:54.994Z,1580853774.994 [DataOverHttps](INFO): SBD MOMSN=12218927
2020-02-04T22:03:14.916Z,1580853794.916 [DataOverHttps](INFO): Sending 324 bytes from file Logs/20200204T214016/Express0005.lzma
2020-02-04T22:03:16.922Z,1580853796.922 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214016/Express0005.lzma.bak
2020-02-04T22:03:16.922Z,1580853796.922 [DataOverHttps](INFO): SBD MOMSN=12218947
2020-02-04T22:03:34.105Z,1580853814.105 [DataOverHttps](INFO): Sending 673 bytes from file Logs/20200204T214949/Express0001.lzma
2020-02-04T22:03:36.110Z,1580853816.110 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214949/Express0001.lzma.bak
2020-02-04T22:03:36.110Z,1580853816.110 [DataOverHttps](INFO): SBD MOMSN=12219002
2020-02-04T22:03:55.250Z,1580853835.250 [RDI_Pathfinder](ERROR): Failed to parse:
:BE,-32768,-32768,-32768,V
2020-02-04T22:03:56.361Z,1580853836.361 [DataOverHttps](INFO): Sending 486 bytes from file Logs/20200204T214949/Express0005.lzma
2020-02-04T22:03:58.366Z,1580853838.366 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214949/Express0005.lzma.bak
2020-02-04T22:03:58.366Z,1580853838.366 [DataOverHttps](INFO): SBD MOMSN=12219021
2020-02-04T22:03:59.719Z,1580853839.719 [DefaultWithUndock:CheckIn:Read_Iridium] Stopped
2020-02-04T22:03:59.719Z,1580853839.719 [DefaultWithUndock:CheckIn:C.Wait] Running Loop=1
2020-02-04T22:03:59.719Z,1580853839.719 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-02-04T22:04:15.886Z,1580853855.886 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-02-04T22:04:15.886Z,1580853855.886 [RDI_Pathfinder](ERROR): Failed to parse:
:BD,     ,        +0.00,        +0.00,   0.00,842.97
2020-02-04T22:05:03.542Z,1580853903.542 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2020-02-04T22:05:03.542Z,1580853903.542 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-02-04T22:05:03.568Z,1580853903.568 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-02-04T22:05:03.964Z,1580853903.964 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-02-04T22:05:03.964Z,1580853903.964 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2020-02-04T22:05:36.254Z,1580853936.254 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-02-04T22:05:36.255Z,1580853936.255 [RDI_Pathfinder](ERROR): Failed to parse:
:BS,-32768,32768,V
2020-02-04T22:06:17.896Z,1580853977.896 [RDI_Pathfinder](ERROR): only read 0 of 4 data items
2020-02-04T22:06:17.896Z,1580853977.896 [RDI_Pathfinder](ERROR): Failed to parse:
:BS-32768,-32768,V
2020-02-04T22:07:56.867Z,1580854076.867 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-04T22:07:56.868Z,1580854076.868 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2020-02-04T22:08:04.545Z,1580854084.545 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2020-02-04T22:08:04.545Z,1580854084.545 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-02-04T22:08:04.555Z,1580854084.555 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-02-04T22:08:04.980Z,1580854084.980 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-02-04T22:08:04.985Z,1580854084.985 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2020-02-04T22:08:17.182Z,1580854097.182 [DataOverHttps](IMPORTANT): SBD MTMSN=20200204T220815
2020-02-04T22:08:17.886Z,1580854097.886 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-04T22:08:17.886Z,1580854097.886 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2020-02-04T22:08:24.717Z,1580854104.717 [DataOverHttps](INFO): Received command:sched asap "load Science/profile_station.xml;set profile_station.MissionTimeout 2 hour;set profile_station.NeedCommsTime 20 minute;set profile_station.Lat 41.55716 degree;set profile_station.Lon -70.7082 degree" 4zhhm 1 2
2020-02-04T22:08:24.734Z,1580854104.734 [CommandLine](IMPORTANT): got command schedule asap "load Science/profile_station.xml;set profile_station.MissionTimeout 2 hour;set profile_station.NeedCommsTime 20 minute;set profile_station.Lat 41.55716 degree;set profile_station.Lon -70.7082 degree" 4zhhm 1 2.000000
2020-02-04T22:08:24.735Z,1580854104.735 [CommandLine](IMPORTANT): Scheduling command #1 of 2 with id=4zhhm
2020-02-04T22:08:24.736Z,1580854104.736 [CommandLine](IMPORTANT): Scheduled #1 (#1 of 2 with id='4zhhm'): "load Science/profile_station.xml;set profile_station.MissionTimeout 2 hour;set profile_station.NeedCommsTime 20 minute;set profile_station.Lat 41.55716 degree;set profile_station.Lon -70.7082 degree" ASAP
2020-02-04T22:08:26.730Z,1580854106.730 [DataOverHttps](IMPORTANT): SBD MTMSN=20200204T220825
2020-02-04T22:08:34.453Z,1580854114.453 [DataOverHttps](INFO): Received command:sched asap "set profile_station.YoYoMaxDepth 7 meter;set profile_station.YoYoMinAltitude 6 meter;set profile_station.YoYoPitch 15 degree;set profile_station.MaxDepth 10 meter;set profile_station.MinOffshore 500 meter;run " 4zhhm 2 2
2020-02-04T22:08:34.545Z,1580854114.545 [CommandLine](IMPORTANT): got command schedule asap "set profile_station.YoYoMaxDepth 7 meter;set profile_station.YoYoMinAltitude 6 meter;set profile_station.YoYoPitch 15 degree;set profile_station.MaxDepth 10 meter;set profile_station.MinOffshore 500 meter;run " 4zhhm 2 2.000000
2020-02-04T22:08:34.546Z,1580854114.546 [CommandLine](IMPORTANT): Scheduling command #2 of 2 with id=4zhhm
2020-02-04T22:08:34.547Z,1580854114.547 [CommandLine](IMPORTANT): Scheduled #2 (#2 of 2 with id='4zhhm'): "set profile_station.YoYoMaxDepth 7 meter;set profile_station.YoYoMinAltitude 6 meter;set profile_station.YoYoPitch 15 degree;set profile_station.MaxDepth 10 meter;set profile_station.MinOffshore 500 meter;run " ASAP
2020-02-04T22:08:34.679Z,1580854114.679 [CommandLine](IMPORTANT): got command load ./Missions/Science/profile_station.xml
2020-02-04T22:08:34.679Z,1580854114.679 [MissionManager](INFO): Loading Mission: ./Missions/Science/profile_station.xml
2020-02-04T22:08:34.767Z,1580854114.767 [MissionManager](INFO): DefineArg profile_station.MissionTimeout = 4.000000 h
2020-02-04T22:08:34.770Z,1580854114.770 [MissionManager](INFO): DefineArg profile_station.NeedCommsTime = 60.000000 min
2020-02-04T22:08:34.773Z,1580854114.773 [MissionManager](INFO): DefineArg profile_station.Lat = 36.806966 arcdeg
2020-02-04T22:08:34.791Z,1580854114.791 [MissionManager](INFO): DefineArg profile_station.Lon = -121.824326 arcdeg
2020-02-04T22:08:34.818Z,1580854114.818 [MissionManager](INFO): DefineArg profile_station.Radius = 300.000000 m
2020-02-04T22:08:34.841Z,1580854114.841 [MissionManager](INFO): DefineArg profile_station.YoYoMinDepth = 2.000000 m
2020-02-04T22:08:34.865Z,1580854114.865 [MissionManager](INFO): DefineArg profile_station.YoYoMaxDepth = 200.000000 m
2020-02-04T22:08:34.868Z,1580854114.868 [MissionManager](INFO): DefineArg profile_station.YoYoMinAltitude = 7.000000 m
2020-02-04T22:08:34.887Z,1580854114.887 [MissionManager](INFO): DefineArg profile_station.YoYoPitch = 20.000000 arcdeg
2020-02-04T22:08:34.894Z,1580854114.894 [MissionManager](INFO): DefineArg profile_station.Speed = 1.000000 m/s
2020-02-04T22:08:34.905Z,1580854114.905 [MissionManager](INFO): DefineArg profile_station.CircleMaxError = 100.000000 m
2020-02-04T22:08:34.908Z,1580854114.908 [MissionManager](INFO): DefineArg profile_station.CircleTurnToPort = 0 bool
2020-02-04T22:08:34.920Z,1580854114.920 [MissionManager](INFO): DefineArg profile_station.KwpHeading = 0.010000 rad/m
2020-02-04T22:08:34.927Z,1580854114.927 [MissionManager](INFO): DefineArg profile_station.MinAltitude = 5.000000 m
2020-02-04T22:08:34.931Z,1580854114.931 [MissionManager](INFO): DefineArg profile_station.MaxDepth = 205.000000 m
2020-02-04T22:08:34.950Z,1580854114.950 [MissionManager](INFO): DefineArg profile_station.MinOffshore = 2.000000 km
2020-02-04T22:08:34.950Z,1580854114.950 [MissionManager](INFO): Inserting Stack: Missions/Insert/Science.xml
2020-02-04T22:08:35.448Z,1580854115.448 [MissionManager](INFO): DefineArg profile_station:Science.SampleISUS = 0 bool
2020-02-04T22:08:35.453Z,1580854115.453 [MissionManager](INFO): DefineArg profile_station:Science.SampleISUSmaxPitch = 60.000000 arcdeg
2020-02-04T22:08:35.455Z,1580854115.455 [MissionManager](INFO): DefineArg profile_station:Science.SampleISUSminPitch = -60.000000 arcdeg
2020-02-04T22:08:35.458Z,1580854115.458 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectChlActive = 0 bool
2020-02-04T22:08:35.461Z,1580854115.461 [MissionManager](INFO): DefineArg profile_station:Science.TimeWindowPeakReport = nan min
2020-02-04T22:08:35.464Z,1580854115.464 [MissionManager](INFO): DefineArg profile_station:Science.HighestChlPeakReportActive = 0 bool
2020-02-04T22:08:35.466Z,1580854115.466 [MissionManager](INFO): DefineArg profile_station:Science.PatchTracking = 0 bool
2020-02-04T22:08:35.469Z,1580854115.469 [MissionManager](INFO): DefineArg profile_station:Science.FilterWidthHorizontal = 3.000000 count
2020-02-04T22:08:35.472Z,1580854115.472 [MissionManager](INFO): DefineArg profile_station:Science.NumProfilesSlidingwindow = 100.000000 count
2020-02-04T22:08:35.475Z,1580854115.475 [MissionManager](INFO): DefineArg profile_station:Science.OffPeakFractionHorizontal = 80.000000 %
2020-02-04T22:08:35.479Z,1580854115.479 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectNO3Active = 0 bool
2020-02-04T22:08:35.501Z,1580854115.501 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectOilActive = 0 bool
2020-02-04T22:08:35.504Z,1580854115.504 [MissionManager](INFO): DefineArg profile_station:Science.PeakDetectFDOMActive = 0 bool
2020-02-04T22:08:35.511Z,1580854115.511 [MissionManager](INFO): DefineArg profile_station:Science.UpwardDerivativeOfTemperatureActive = 0 bool
2020-02-04T22:08:35.514Z,1580854115.514 [MissionManager](INFO): DefineArg profile_station:Science.EnabledAanderaaO2 = 0.000000 bool
2020-02-04T22:08:35.534Z,1580854115.534 [MissionManager](INFO): DefineArg profile_station:Science.EnabledNeilBrown = 0.000000 bool
2020-02-04T22:08:35.538Z,1580854115.538 [MissionManager](INFO): DefineArg profile_station:Science.EnabledSeabird = 0.000000 bool
2020-02-04T22:08:35.554Z,1580854115.554 [MissionManager](INFO): DefineArg profile_station:Science.EnabledTurbulence_NPS = 0.000000 bool
2020-02-04T22:08:35.566Z,1580854115.566 [MissionManager](INFO): DefineArg profile_station:Science.EnabledWetLabsBB2FL = 0.000000 bool
2020-02-04T22:08:35.579Z,1580854115.579 [MissionManager](INFO): DefineArg profile_station:Science.EnabledWetLabsSeaOWL_UV_A = 1.000000 bool
2020-02-04T22:08:35.610Z,1580854115.610 [MissionManager](INFO): DefineArg profile_station:Science.EnabledWetLabsUBAT = 0.000000 bool
2020-02-04T22:08:35.614Z,1580854115.614 [MissionManager](INFO): DefineArg profile_station:Science.EnabledISUS = 0.000000 bool
2020-02-04T22:08:35.634Z,1580854115.634 [MissionManager](INFO): DefineArg profile_station:Science.LowPassWindowLength = 20.000000 count
2020-02-04T22:08:35.662Z,1580854115.662 [MissionManager](INFO): DefineArg profile_station:Science.MedianFilterLen = 5.000000 count
2020-02-04T22:08:35.678Z,1580854115.678 [MissionManager](INFO): DefineArg profile_station:Science.PeakChlShallowBound = nan m
2020-02-04T22:08:35.701Z,1580854115.701 [MissionManager](INFO): DefineArg profile_station:Science.PeakChlDeepBound = nan m
2020-02-04T22:08:35.704Z,1580854115.704 [MissionManager](INFO): DefineArg profile_station:Science.PeakShallowBound = nan m
2020-02-04T22:08:35.717Z,1580854115.717 [MissionManager](INFO): DefineArg profile_station:Science.PeakDeepBound = nan m
2020-02-04T22:08:35.720Z,1580854115.720 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChl = 0.000000 ug/l
2020-02-04T22:08:35.731Z,1580854115.731 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlDepth = 0.000000 m
2020-02-04T22:08:35.735Z,1580854115.735 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlTemperature = 0.000000 degC
2020-02-04T22:08:35.746Z,1580854115.746 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlLatitude = nan arcdeg
2020-02-04T22:08:35.759Z,1580854115.759 [MissionManager](INFO): DefineOutput profile_station:Science.PeakChlLongitude = nan arcdeg
2020-02-04T22:08:35.770Z,1580854115.770 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3 = 0.000000 umol/l
2020-02-04T22:08:35.782Z,1580854115.782 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3Depth = 0.000000 m
2020-02-04T22:08:35.793Z,1580854115.793 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3Latitude = nan arcdeg
2020-02-04T22:08:35.796Z,1580854115.796 [MissionManager](INFO): DefineOutput profile_station:Science.PeakNO3Longitude = nan arcdeg
2020-02-04T22:08:35.815Z,1580854115.815 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChl = 0.000000 m
2020-02-04T22:08:35.829Z,1580854115.829 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlDepth = 0.000000 m
2020-02-04T22:08:35.846Z,1580854115.846 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlLatitude = nan arcdeg
2020-02-04T22:08:35.874Z,1580854115.874 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlLongitude = nan arcdeg
2020-02-04T22:08:35.893Z,1580854115.893 [MissionManager](INFO): DefineOutput profile_station:Science.PatchChlDistance = nan m
2020-02-04T22:08:35.906Z,1580854115.906 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOil = 0.000000 kg/m3
2020-02-04T22:08:35.911Z,1580854115.911 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOilDepth = 0.000000 m
2020-02-04T22:08:35.914Z,1580854115.914 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOilLatitude = nan arcdeg
2020-02-04T22:08:35.921Z,1580854115.921 [MissionManager](INFO): DefineOutput profile_station:Science.PeakOilLongitude = nan arcdeg
2020-02-04T22:08:35.924Z,1580854115.924 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOM = 0.000000 ppb
2020-02-04T22:08:35.932Z,1580854115.932 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOMDepth = 0.000000 m
2020-02-04T22:08:35.953Z,1580854115.953 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOMLatitude = nan arcdeg
2020-02-04T22:08:35.956Z,1580854115.956 [MissionManager](INFO): DefineOutput profile_station:Science.PeakFDOMLongitude = nan arcdeg
2020-02-04T22:08:35.972Z,1580854115.972 [MissionManager](INFO): DefineOutput profile_station:Science.PatchFDOMDistance = nan m
2020-02-04T22:08:36.075Z,1580854116.075 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2020-02-04T22:08:36.107Z,1580854116.107 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2020-02-04T22:08:36.152Z,1580854116.152 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2020-02-04T22:08:36.182Z,1580854116.182 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2020-02-04T22:08:36.218Z,1580854116.218 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2020-02-04T22:08:36.236Z,1580854116.236 [MissionManager](INFO): RedefineArg profile_station:Science.SampleISUS = value:1 bool
2020-02-04T22:08:36.250Z,1580854116.250 [MissionManager](INFO): RedefineArg profile_station:Science.PeakDetectChlActive = value:1 bool
2020-02-04T22:08:36.251Z,1580854116.251 [MissionManager](INFO): Inserting Stack: Missions/Insert/NeedComms.xml
2020-02-04T22:08:36.336Z,1580854116.336 [MissionManager](INFO): DefineArg profile_station:NeedComms.DiveInterval = 3.000000 h
2020-02-04T22:08:36.359Z,1580854116.359 [MissionManager](INFO): DefineArg profile_station:NeedComms.WaitForPitchUp = 10.000000 min
2020-02-04T22:08:36.362Z,1580854116.362 [MissionManager](INFO): DefineArg profile_station:NeedComms.SurfacePitch = 20.000000 arcdeg
2020-02-04T22:08:36.365Z,1580854116.365 [MissionManager](INFO): DefineArg profile_station:NeedComms.SurfaceDepthRate = nan m/s
2020-02-04T22:08:36.367Z,1580854116.367 [MissionManager](INFO): DefineArg profile_station:NeedComms.SurfaceSpeed = 1.000000 m/s
2020-02-04T22:08:36.435Z,1580854116.435 [MissionManager](INFO): DefineArg profile_station:NeedComms.GPSTimeout = 7.000000 min
2020-02-04T22:08:36.442Z,1580854116.442 [MissionManager](INFO): DefineArg profile_station:NeedComms.CommsTimeout = 30.000000 min
2020-02-04T22:08:36.464Z,1580854116.464 [profile_station:NeedComms:B.GoToSurface](DEBUG): Construct GoToSurface.
2020-02-04T22:08:36.533Z,1580854116.533 [MissionManager](INFO): Inserting Stack: Missions/Insert/StandardEnvelopes.xml
2020-02-04T22:08:36.593Z,1580854116.593 [MissionManager](INFO): DefineArg profile_station:StandardEnvelopes.MinAltitude = 5.000000 m
2020-02-04T22:08:36.596Z,1580854116.596 [MissionManager](INFO): DefineArg profile_station:StandardEnvelopes.MaxDepth = 200.000000 m
2020-02-04T22:08:36.603Z,1580854116.603 [MissionManager](INFO): DefineArg profile_station:StandardEnvelopes.MinOffshore = 2000.000000 m
2020-02-04T22:08:36.604Z,1580854116.604 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2020-02-04T22:08:36.629Z,1580854116.629 [profile_station:StandardEnvelopes:B.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2020-02-04T22:08:36.655Z,1580854116.655 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Construct OffshoreEnvelope.
2020-02-04T22:08:36.696Z,1580854116.696 [profile_station:I.Pitch](DEBUG): Construct.
2020-02-04T22:08:36.706Z,1580854116.706 [profile_station:J.Buoyancy](DEBUG): Construct Buoyancy.
2020-02-04T22:08:36.711Z,1580854116.711 [profile_station:K.SetSpeed](DEBUG): Construct.
2020-02-04T22:08:36.730Z,1580854116.730 [profile_station:L.DepthEnvelope](DEBUG): Construct DepthEnvelope.
2020-02-04T22:08:36.756Z,1580854116.756 [profile_station:M.AltitudeEnvelope](DEBUG): Construct AltitudeEnvelope.
2020-02-04T22:08:36.781Z,1580854116.781 [profile_station:N.YoYo](DEBUG): Construct YoYo.
2020-02-04T22:08:36.872Z,1580854116.872 [profile_station:CircleWrapper:B.Circle](DEBUG): Construct.
2020-02-04T22:08:36.959Z,1580854116.959 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Derivation="Tethys/Derivation"
       xmlns:Estimation="Tethys/Estimation"
       xmlns:Guidance="Tethys/Guidance"
       xmlns:Sensor="Tethys/Sensor"
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Derivation http://okeanids.mbari.org/tethys/Xml/Derivation.xsd
                           Tethys/Estimation http://okeanids.mbari.org/tethys/Xml/Estimation.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Sensor http://okeanids.mbari.org/tethys/Xml/Sensor.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="profile_station">

    <Description>
        This mission yoyos in a circle around a specified location.
    </Description>

<!-- Mission-wide settings -->

    <DefineArg Name="MissionTimeout"><Description>
        Maximum duration of mission
    </Description><Units:hour/><Value>4</Value></DefineArg>

    <DefineArg Name="NeedCommsTime"><Description>
        Elapsed time after previous surface communications when vehicle will
        begin to ascend for additional surface communications
    </Description><Units:minute/><Value>60</Value></DefineArg>

<!-- You probably need to change these. -->

    <DefineArg Name="Lat"><Description>
        The latitude of the center of the circle.
    </Description><Units:degree/><Value>36.806966</Value></DefineArg>

    <DefineArg Name="Lon"><Description>
        The longitude of the center of the circle.
    </Description><Units:degree/><Value>-121.824326</Value></DefineArg>

    <DefineArg Name="Radius"><Description>
        Radius to circle at
    </Description><Units:meter/><Value>300</Value></DefineArg>

<!-- You probably do not need to change these. -->

    <DefineArg Name="YoYoMinDepth"><Description>
        Minimum depth while performing the YoYo behavior.
    </Description><Units:meter/><Value>2</Value></DefineArg>

    <DefineArg Name="YoYoMaxDepth"><Description>
        Maximum depth while performing the YoYo behavior.
    </Description><Units:meter/><Value>200</Value></DefineArg>

    <DefineArg Name="YoYoMinAltitude"><Description>
        Minimum altitude while performing the YoYo behavior (for
        bottom-terminated YoYos).
    </Description><Units:meter/><Value>7</Value></DefineArg>

    <DefineArg Name="YoYoPitch"><Description>
        Pitch (plus and minus) for yo-yo behavior.
    </Description><Units:degree/><Value>20</Value></DefineArg>

    <DefineArg Name="Speed"><Description>
        Vehicle speed.
    </Description><Units:meter_per_second/><Value>1</Value></DefineArg>

<!-- You are even less likely to need to change these. -->

    <DefineArg Name="CircleMaxError"><Description>
        If this distance away from the circle, drive straight towards (or away
        from the center). Otherwise, try to reduce distance from the ideal
        circle.
    </Description><Units:meter/><Value>100</Value></DefineArg>

    <DefineArg Name="CircleTurnToPort"><Description>
        If true, vehicle turns to the left around the center point. If false,
        vehicle turns to the right.
    </Description><False/></DefineArg>

    <DefineArg Name="KwpHeading"><Description>
        Used to relax waypoint cross-track error constant that is adjusted for
        docking. (You can override this setting by passing an argument.)
    </Description><Units:radian_per_meter/><Value>0.010</Value></DefineArg>

    <DefineArg Name="MinAltitude"><Description>
        Minimum height above the sea floor for the entire mission.
    </Description><Units:meter/><Value>5</Value></DefineArg>

    <DefineArg Name="MaxDepth"><Description>
        Maximum depth for the entire mission.
    </Description><Units:meter/><Value>205</Value></DefineArg>

    <DefineArg Name="MinOffshore"><Description>
        Minimum offshore distance for the entire mission.
    </Description><Units:kilometer/><Value>2</Value></DefineArg>

<!-- Missions should almost always start with a timeout -->

    <Timeout Duration="MissionTimeout"/>

    <Insert Filename="Insert/Science.xml">
        <Description>
            Most missions will run the science sensors. If you don't place this
            aggregate above NeedComms, science instruments get turned off on the
            last upcast and while floating on the surface.
        </Description>
        <RedefineArg Name="SampleISUS"><True/></RedefineArg>
        <RedefineArg Name="PeakDetectChlActive"><True/></RedefineArg>
    </Insert>

<!-- Most missions should use the NeedComms aggregate. -->

    <Insert Filename="Insert/NeedComms.xml" Id="NeedComms"/>

    <Assign><Sequence/><Arg Name="NeedComms:DiveInterval"/><Arg Name="NeedCommsTime"/></Assign>

<!-- Missions should almost always start with standard safety envelopes; most missions should not expose the parameters of these envelopes. -->

    <Insert Filename="Insert/StandardEnvelopes.xml"/>

    <Assign><Sequence/><Arg Name="StandardEnvelopes:MinAltitude"/><Arg Name="MinAltitude"/></Assign>

    <Assign><Sequence/><Arg Name="StandardEnvelopes:MaxDepth"/><Arg Name="MaxDepth"/></Assign>

    <Assign><Sequence/><Arg Name="StandardEnvelopes:MinOffshore"/><Arg Name="MinOffshore"/></Assign>

<!-- Check for additional instructions first. -->

    <Call Id="StartingMission" RefId="NeedComms"/>

<!-- Many missions will keep mass position and buoyancy volume fixed at defaults. -->

    <Guidance:Pitch>
        <Parallel/>
        <Setting><Guidance:Pitch.massPosition/><Control:VerticalControl.massDefault/></Setting>
    </Guidance:Pitch>

    <Guidance:Buoyancy>
        <Parallel/>
        <Setting><Guidance:Buoyancy.position/><Control:VerticalControl.buoyancyNeutral/></Setting>
    </Guidance:Buoyancy>

    <Guidance:SetSpeed>
        <Parallel/>
        <Setting><Guidance:SetSpeed.speed/><Arg Name="Speed"/></Setting>
    </Guidance:SetSpeed>

    <Guidance:DepthEnvelope>
        <Description>
            Another depth envelope for the YoYo behavior. This envelope should
            fall within the limits of the standard safety envelopes in
            Insert/StandardEnvelopes.xml in order to avoid commanding high pitch
            angles for depth-terminated YoYos.
        </Description>
        <Parallel/>
        <Setting><Guidance:DepthEnvelope.minDepth/><Arg Name="YoYoMinDepth"/></Setting>
        <Setting><Guidance:DepthEnvelope.maxDepth/><Arg Name="YoYoMaxDepth"/></Setting>
        <Setting><Guidance:DepthEnvelope.pitch/><Arg Name="YoYoPitch"/></Setting>
    </Guidance:DepthEnvelope>

    <Guidance:AltitudeEnvelope>
        <Description>
            Another altitude envelope for the YoYo behavior. This envelope
            should fall within the limits of the standard safety envelopes in
            Insert/StandardEnvelopes.xml in order to avoid commanding high pitch
            angles for bottom-terminated YoYos.
        </Description>
        <Parallel/>
        <Setting><Guidance:AltitudeEnvelope.minAltitude/><Arg Name="YoYoMinAltitude"/></Setting>
        <Setting><Guidance:AltitudeEnvelope.pitch/><Arg Name="YoYoPitch"/></Setting>
    </Guidance:AltitudeEnvelope>

    <Guidance:YoYo>
        <Parallel/>
        <Setting><Guidance:YoYo.pitch/><Arg Name="YoYoPitch"/></Setting>
    </Guidance:YoYo>

    <Aggregate Id="CircleWrapper">

        <Sequence Repeat="4096"/>

        <Assign><Parallel/><Control:HorizontalControl.kwpHeading/><Arg Name="KwpHeading"/></Assign>

        <Guidance:Circle>
            <Sequence/>
            <Setting><Guidance:Circle.latitude/><Arg Name="Lat"/></Setting>
            <Setting><Guidance:Circle.longitude/><Arg Name="Lon"/></Setting>
            <Setting><Guidance:Circle.radius/><Arg Name="Radius"/></Setting>
            <Setting><Guidance:Circle.maxError/><Arg Name="CircleMaxError"/></Setting>
            <Setting><Guidance:Circle.turnToPort/><Arg Name="CircleTurnToPort"/></Setting>
        </Guidance:Circle>

    </Aggregate>

</Mission>


2020-02-04T22:08:36.960Z,1580854116.960 [CommandLine](IMPORTANT): Loaded ./Missions/Science/profile_station.xml
2020-02-04T22:08:44.279Z,1580854124.279 [CommandLine](IMPORTANT): got command set profile_station.MissionTimeout 2.000000 hour
2020-02-04T22:08:44.279Z,1580854124.279 [CommandLine](IMPORTANT): got command set profile_station.NeedCommsTime 20.000000 minute
2020-02-04T22:08:44.280Z,1580854124.280 [CommandLine](IMPORTANT): got command set profile_station.Lat 41.557159 degree
2020-02-04T22:08:44.281Z,1580854124.281 [CommandLine](IMPORTANT): got command set profile_station.Lon -70.708199 degree
2020-02-04T22:08:52.226Z,1580854132.226 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-02-04T22:08:52.226Z,1580854132.226 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,20020415220585,35.0, -0.1,   0.0,1448.9,,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-04T22:08:53.438Z,1580854133.438 [CommandLine](IMPORTANT): got command set profile_station.YoYoMaxDepth 7.000000 meter
2020-02-04T22:08:53.439Z,1580854133.439 [CommandLine](IMPORTANT): got command set profile_station.YoYoMinAltitude 6.000000 meter
2020-02-04T22:08:53.439Z,1580854133.439 [CommandLine](IMPORTANT): got command set profile_station.YoYoPitch 15.000000 degree
2020-02-04T22:08:53.440Z,1580854133.440 [CommandLine](IMPORTANT): got command set profile_station.MaxDepth 10.000000 meter
2020-02-04T22:08:53.441Z,1580854133.441 [CommandLine](IMPORTANT): got command set profile_station.MinOffshore 500.000000 meter
2020-02-04T22:08:53.442Z,1580854133.442 [CommandLine](IMPORTANT): got command run 
2020-02-04T22:08:53.477Z,1580854133.477 [CommandLine](IMPORTANT): Running 
2020-02-04T22:08:53.806Z,1580854133.806 [DefaultWithUndock] Stopped
2020-02-04T22:08:53.807Z,1580854133.807 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock
2020-02-04T22:08:53.807Z,1580854133.807 [DefaultWithUndock:C.GoToSurface] Stopped
2020-02-04T22:08:53.807Z,1580854133.807 [DefaultWithUndock:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-02-04T22:08:53.807Z,1580854133.807 [DefaultWithUndock:CheckIn] Stopped
2020-02-04T22:08:53.807Z,1580854133.807 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:CheckIn
2020-02-04T22:08:53.807Z,1580854133.807 [DefaultWithUndock:CheckIn:C.Wait] Stopped
2020-02-04T22:08:53.807Z,1580854133.807 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-02-04T22:08:53.807Z,1580854133.807 [MissionManager](IMPORTANT): Started mission profile_station
2020-02-04T22:08:53.808Z,1580854133.808 [profile_station] Running Loop=1
2020-02-04T22:08:53.809Z,1580854133.809 [profile_station](DEBUG): Aggregate::initialize profile_station
2020-02-04T22:08:53.809Z,1580854133.809 [profile_station:Science] Running Loop=1
2020-02-04T22:08:53.809Z,1580854133.809 [profile_station:Science](DEBUG): Aggregate::initialize profile_station:Science
2020-02-04T22:08:53.809Z,1580854133.809 [profile_station:Science:A] Running Loop=1
2020-02-04T22:08:53.810Z,1580854133.810 [profile_station:Science:B] Running Loop=1
2020-02-04T22:08:53.810Z,1580854133.810 [profile_station:Science:C] Running Loop=1
2020-02-04T22:08:53.810Z,1580854133.810 [profile_station:Science:D] Running Loop=1
2020-02-04T22:08:53.810Z,1580854133.810 [profile_station:Science:E] Running Loop=1
2020-02-04T22:08:53.810Z,1580854133.810 [profile_station:Science:F] Running Loop=1
2020-02-04T22:08:53.810Z,1580854133.810 [profile_station:Science:G] Running Loop=1
2020-02-04T22:08:53.811Z,1580854133.811 [profile_station:Science:H] Running Loop=1
2020-02-04T22:08:53.811Z,1580854133.811 [profile_station:Science:Read_Oil] Running Loop=1
2020-02-04T22:08:53.811Z,1580854133.811 [profile_station:Science:PeakDetectChl] Running Loop=1
2020-02-04T22:08:53.811Z,1580854133.811 [profile_station:Science:PeakDetectChl](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectChl
2020-02-04T22:08:53.812Z,1580854133.812 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2020-02-04T22:08:53.828Z,1580854133.828 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2020-02-04T22:08:53.837Z,1580854133.837 [profile_station:Science:HighestChlPeakReport] Running Loop=1
2020-02-04T22:08:53.837Z,1580854133.837 [profile_station:Science:HighestChlPeakReport](DEBUG): Aggregate::initialize profile_station:Science:HighestChlPeakReport
2020-02-04T22:08:53.838Z,1580854133.838 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2020-02-04T22:08:53.838Z,1580854133.838 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2020-02-04T22:08:53.839Z,1580854133.839 [profile_station:Science:PeakDetectNO3] Running Loop=1
2020-02-04T22:08:53.839Z,1580854133.839 [profile_station:Science:PeakDetectNO3](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectNO3
2020-02-04T22:08:53.840Z,1580854133.840 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2020-02-04T22:08:53.840Z,1580854133.840 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2020-02-04T22:08:53.847Z,1580854133.847 [profile_station:Science:PeakDetectOil] Running Loop=1
2020-02-04T22:08:53.847Z,1580854133.847 [profile_station:Science:PeakDetectOil](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectOil
2020-02-04T22:08:53.858Z,1580854133.858 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2020-02-04T22:08:53.858Z,1580854133.858 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2020-02-04T22:08:53.863Z,1580854133.863 [profile_station:Science:PeakDetectFDOM] Running Loop=1
2020-02-04T22:08:53.863Z,1580854133.863 [profile_station:Science:PeakDetectFDOM](DEBUG): Aggregate::initialize profile_station:Science:PeakDetectFDOM
2020-02-04T22:08:53.863Z,1580854133.863 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1
2020-02-04T22:08:53.864Z,1580854133.864 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize.
2020-02-04T22:08:53.874Z,1580854133.874 [profile_station:StandardEnvelopes] Running Loop=1
2020-02-04T22:08:53.874Z,1580854133.874 [profile_station:StandardEnvelopes](DEBUG): Aggregate::initialize profile_station:StandardEnvelopes
2020-02-04T22:08:53.874Z,1580854133.874 [profile_station:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2020-02-04T22:08:53.874Z,1580854133.874 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2020-02-04T22:08:53.874Z,1580854133.874 [profile_station:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2020-02-04T22:08:53.875Z,1580854133.875 [profile_station:StandardEnvelopes:B.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2020-02-04T22:08:53.875Z,1580854133.875 [profile_station:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2020-02-04T22:08:53.875Z,1580854133.875 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Initialize OffshoreEnvelopeComponent.
2020-02-04T22:08:53.875Z,1580854133.875 [profile_station:I.Pitch] Running Loop=1
2020-02-04T22:08:53.875Z,1580854133.875 [profile_station:I.Pitch](DEBUG): Initialize.
2020-02-04T22:08:53.875Z,1580854133.875 [profile_station:J.Buoyancy] Running Loop=1
2020-02-04T22:08:53.875Z,1580854133.875 [profile_station:J.Buoyancy](DEBUG): Initialize Buoyancy Component.
2020-02-04T22:08:53.875Z,1580854133.875 [profile_station:K.SetSpeed] Running Loop=1
2020-02-04T22:08:53.875Z,1580854133.875 [profile_station:K.SetSpeed](DEBUG): Initialize.
2020-02-04T22:08:53.876Z,1580854133.876 [profile_station:L.DepthEnvelope] Running Loop=1
2020-02-04T22:08:53.876Z,1580854133.876 [profile_station:L.DepthEnvelope](DEBUG): Initialize DepthEnvelopeComponent.
2020-02-04T22:08:53.876Z,1580854133.876 [profile_station:M.AltitudeEnvelope] Running Loop=1
2020-02-04T22:08:53.876Z,1580854133.876 [profile_station:M.AltitudeEnvelope](DEBUG): Initialize AltitudeEnvelopeComponent.
2020-02-04T22:08:53.876Z,1580854133.876 [profile_station:N.YoYo] Running Loop=1
2020-02-04T22:08:53.876Z,1580854133.876 [profile_station:N.YoYo](DEBUG): Initialize YoYoComponent.
2020-02-04T22:08:53.881Z,1580854133.881 [profile_station:C] Running Loop=1
2020-02-04T22:08:53.881Z,1580854133.881 [profile_station:N.YoYo] Running Loop=1
2020-02-04T22:08:53.882Z,1580854133.882 [profile_station:M.AltitudeEnvelope] Running Loop=1
2020-02-04T22:08:53.882Z,1580854133.882 [profile_station:L.DepthEnvelope] Running Loop=1
2020-02-04T22:08:53.883Z,1580854133.883 [profile_station:K.SetSpeed] Running Loop=1
2020-02-04T22:08:53.884Z,1580854133.884 [profile_station:J.Buoyancy] Running Loop=1
2020-02-04T22:08:53.884Z,1580854133.884 [profile_station:I.Pitch] Running Loop=1
2020-02-04T22:08:53.897Z,1580854133.897 [profile_station:StandardEnvelopes] Running Loop=1
2020-02-04T22:08:53.897Z,1580854133.897 [profile_station:StandardEnvelopes:C.OffshoreEnvelope] Running Loop=1
2020-02-04T22:08:53.897Z,1580854133.897 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:08:53.897Z,1580854133.897 [profile_station:StandardEnvelopes:B.DepthEnvelope] Running Loop=1
2020-02-04T22:08:53.898Z,1580854133.898 [profile_station:StandardEnvelopes:A.AltitudeEnvelope] Running Loop=1
2020-02-04T22:08:53.901Z,1580854133.901 [profile_station:C] Stopped
2020-02-04T22:08:53.901Z,1580854133.901 [profile_station:E] Running Loop=1
2020-02-04T22:08:53.901Z,1580854133.901 [profile_station:NeedComms] Running Loop=1
2020-02-04T22:08:53.901Z,1580854133.901 [profile_station:NeedComms](DEBUG): Aggregate::initialize profile_station:NeedComms
2020-02-04T22:08:53.901Z,1580854133.901 [profile_station:NeedComms:B.GoToSurface] Running Loop=1
2020-02-04T22:08:53.901Z,1580854133.901 [profile_station:NeedComms:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-02-04T22:08:53.901Z,1580854133.901 [profile_station:NeedComms:B.GoToSurface](INFO): Received depth rate setting nan m/s.
2020-02-04T22:08:53.902Z,1580854133.902 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch setting 19.999999 degrees.
2020-02-04T22:08:53.902Z,1580854133.902 [profile_station:NeedComms:B.GoToSurface](INFO): Received speed setting 1.000000 m/s.
2020-02-04T22:08:53.902Z,1580854133.902 [profile_station:NeedComms:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-02-04T22:08:53.903Z,1580854133.903 [profile_station:NeedComms:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-02-04T22:08:53.903Z,1580854133.903 [profile_station:NeedComms:A] Running Loop=1
2020-02-04T22:08:53.904Z,1580854133.904 [profile_station:NeedComms:A](ERROR): data element is not active.
2020-02-04T22:08:53.904Z,1580854133.904 [profile_station:NeedComms:A](INFO): last time_fix was: nan second since 1970/01/01T00:00:00Z 
2020-02-04T22:08:53.904Z,1580854133.904 [profile_station:NeedComms:A] Stopped
2020-02-04T22:08:53.905Z,1580854133.905 [profile_station:Science] Running Loop=1
2020-02-04T22:08:53.906Z,1580854133.906 [profile_station:Science:PeakDetectFDOM] Stopped
2020-02-04T22:08:53.906Z,1580854133.906 [profile_station:Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectFDOM
2020-02-04T22:08:53.906Z,1580854133.906 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped
2020-02-04T22:08:53.906Z,1580854133.906 [profile_station:Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2020-02-04T22:08:53.906Z,1580854133.906 [profile_station:Science:PeakDetectOil] Stopped
2020-02-04T22:08:53.906Z,1580854133.906 [profile_station:Science:PeakDetectOil](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectOil
2020-02-04T22:08:53.906Z,1580854133.906 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2020-02-04T22:08:53.906Z,1580854133.906 [profile_station:Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2020-02-04T22:08:53.906Z,1580854133.906 [profile_station:Science:PeakDetectNO3] Stopped
2020-02-04T22:08:53.907Z,1580854133.907 [profile_station:Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectNO3
2020-02-04T22:08:53.907Z,1580854133.907 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2020-02-04T22:08:53.907Z,1580854133.907 [profile_station:Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2020-02-04T22:08:53.907Z,1580854133.907 [profile_station:Science:HighestChlPeakReport] Stopped
2020-02-04T22:08:53.907Z,1580854133.907 [profile_station:Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize profile_station:Science:HighestChlPeakReport
2020-02-04T22:08:53.907Z,1580854133.907 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2020-02-04T22:08:53.907Z,1580854133.907 [profile_station:Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2020-02-04T22:08:53.907Z,1580854133.907 [profile_station:Science:PeakDetectChl] Running Loop=1
2020-02-04T22:08:53.907Z,1580854133.907 [profile_station:Science:Read_Oil] Running Loop=1
2020-02-04T22:08:53.908Z,1580854133.908 [profile_station:Science:Read_Oil](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2020-02-04T22:08:53.908Z,1580854133.908 [profile_station:Science:H] Stopped
2020-02-04T22:08:53.908Z,1580854133.908 [profile_station:Science:G] Running Loop=1
2020-02-04T22:08:53.910Z,1580854133.910 [profile_station:Science:G](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2020-02-04T22:08:53.910Z,1580854133.910 [profile_station:Science:F] Stopped
2020-02-04T22:08:53.910Z,1580854133.910 [profile_station:Science:E] Stopped
2020-02-04T22:08:53.910Z,1580854133.910 [profile_station:Science:D] Stopped
2020-02-04T22:08:53.910Z,1580854133.910 [profile_station:Science:C] Stopped
2020-02-04T22:08:53.910Z,1580854133.910 [profile_station:Science:B] Stopped
2020-02-04T22:08:53.910Z,1580854133.910 [profile_station:Science:A] Stopped
2020-02-04T22:08:54.153Z,1580854134.153 [WetLabsSeaOWL_UV_A](INFO): Powering up
2020-02-04T22:08:54.250Z,1580854134.250 [profile_station:E] Stopped
2020-02-04T22:08:54.250Z,1580854134.250 [profile_station:F] Running Loop=1
2020-02-04T22:08:54.250Z,1580854134.250 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:08:54.251Z,1580854134.251 [profile_station:NeedComms:C] Running Loop=1
2020-02-04T22:08:54.637Z,1580854134.637 [profile_station:F] Stopped
2020-02-04T22:08:54.637Z,1580854134.637 [profile_station:G] Running Loop=1
2020-02-04T22:08:54.637Z,1580854134.637 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:08:54.638Z,1580854134.638 [profile_station:NeedComms:C](DEBUG): Initialize ReadDataComponent to sense time_fix
2020-02-04T22:08:55.051Z,1580854135.051 [profile_station:G] Stopped
2020-02-04T22:08:55.051Z,1580854135.051 [profile_station:StartingMission] Running Loop=1
2020-02-04T22:08:55.051Z,1580854135.051 [profile_station:StartingMission](DEBUG): Aggregate::initialize profile_station:StartingMission
2020-02-04T22:08:55.051Z,1580854135.051 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:08:55.438Z,1580854135.438 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:08:55.868Z,1580854135.868 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:08:56.260Z,1580854136.260 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:08:56.640Z,1580854136.640 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:08:57.074Z,1580854137.074 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:08:57.457Z,1580854137.457 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:08:57.891Z,1580854137.891 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:08:58.281Z,1580854138.281 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:08:58.651Z,1580854138.651 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:08:59.073Z,1580854139.073 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:08:59.469Z,1580854139.469 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:08:59.877Z,1580854139.877 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:09:00.314Z,1580854140.314 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:09:00.712Z,1580854140.712 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:09:00.965Z,1580854140.965 [CommandLine](IMPORTANT): got command stop
2020-02-04T22:09:00.965Z,1580854140.965 [CommandLine](IMPORTANT): Scheduling is paused
2020-02-04T22:09:00.965Z,1580854140.965 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop
2020-02-04T22:09:01.104Z,1580854141.104 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](ERROR): Location Measurement is not Active.
2020-02-04T22:09:01.107Z,1580854141.107 [MissionManager](INFO): MissionManager is completed.
2020-02-04T22:09:01.107Z,1580854141.107 [MissionManager](INFO): Uninitializing Mission profile_station
2020-02-04T22:09:01.107Z,1580854141.107 [profile_station] Stopped
2020-02-04T22:09:01.107Z,1580854141.107 [profile_station](DEBUG): Aggregate::uninitialize profile_station
2020-02-04T22:09:01.107Z,1580854141.107 [profile_station:Science] Stopped
2020-02-04T22:09:01.107Z,1580854141.107 [profile_station:Science](DEBUG): Aggregate::uninitialize profile_station:Science
2020-02-04T22:09:01.107Z,1580854141.107 [profile_station:Science:G] Stopped
2020-02-04T22:09:01.107Z,1580854141.107 [profile_station:Science:Read_Oil] Stopped
2020-02-04T22:09:01.107Z,1580854141.107 [profile_station:Science:PeakDetectChl] Stopped
2020-02-04T22:09:01.108Z,1580854141.108 [profile_station:Science:PeakDetectChl](DEBUG): Aggregate::uninitialize profile_station:Science:PeakDetectChl
2020-02-04T22:09:01.108Z,1580854141.108 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2020-02-04T22:09:01.108Z,1580854141.108 [profile_station:Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2020-02-04T22:09:01.108Z,1580854141.108 [profile_station:NeedComms] Stopped
2020-02-04T22:09:01.108Z,1580854141.108 [profile_station:NeedComms](DEBUG): Aggregate::uninitialize profile_station:NeedComms
2020-02-04T22:09:01.108Z,1580854141.108 [profile_station:NeedComms:B.GoToSurface] Stopped
2020-02-04T22:09:01.108Z,1580854141.108 [profile_station:NeedComms:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-02-04T22:09:01.108Z,1580854141.108 [profile_station:NeedComms:C] Stopped
2020-02-04T22:09:01.108Z,1580854141.108 [profile_station:StandardEnvelopes] Stopped
2020-02-04T22:09:01.108Z,1580854141.108 [profile_station:StandardEnvelopes](DEBUG): Aggregate::uninitialize profile_station:StandardEnvelopes
2020-02-04T22:09:01.108Z,1580854141.108 [profile_station:StandardEnvelopes:A.AltitudeEnvelope] Stopped
2020-02-04T22:09:01.109Z,1580854141.109 [profile_station:StandardEnvelopes:A.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2020-02-04T22:09:01.109Z,1580854141.109 [profile_station:StandardEnvelopes:B.DepthEnvelope] Stopped
2020-02-04T22:09:01.109Z,1580854141.109 [profile_station:StandardEnvelopes:B.DepthEnvelope](DEBUG): Uninitialize.
2020-02-04T22:09:01.109Z,1580854141.109 [profile_station:StandardEnvelopes:C.OffshoreEnvelope] Stopped
2020-02-04T22:09:01.109Z,1580854141.109 [profile_station:StandardEnvelopes:C.OffshoreEnvelope](DEBUG): Uninitialize OffshoreEnvelopeComponent.
2020-02-04T22:09:01.109Z,1580854141.109 [profile_station:StartingMission] Stopped
2020-02-04T22:09:01.109Z,1580854141.109 [profile_station:StartingMission](DEBUG): Aggregate::uninitialize profile_station:StartingMission
2020-02-04T22:09:01.109Z,1580854141.109 [profile_station:I.Pitch] Stopped
2020-02-04T22:09:01.109Z,1580854141.109 [profile_station:J.Buoyancy] Stopped
2020-02-04T22:09:01.109Z,1580854141.109 [profile_station:J.Buoyancy](DEBUG): Uninitialize Buoyancy Component.
2020-02-04T22:09:01.109Z,1580854141.109 [profile_station:K.SetSpeed] Stopped
2020-02-04T22:09:01.109Z,1580854141.109 [profile_station:K.SetSpeed](DEBUG): Uninitialize.
2020-02-04T22:09:01.109Z,1580854141.109 [profile_station:L.DepthEnvelope] Stopped
2020-02-04T22:09:01.109Z,1580854141.109 [profile_station:L.DepthEnvelope](DEBUG): Uninitialize.
2020-02-04T22:09:01.109Z,1580854141.109 [profile_station:M.AltitudeEnvelope] Stopped
2020-02-04T22:09:01.110Z,1580854141.110 [profile_station:M.AltitudeEnvelope](DEBUG): Uninitialize AltitudeEnvelopeComponent.
2020-02-04T22:09:01.110Z,1580854141.110 [profile_station:N.YoYo] Stopped
2020-02-04T22:09:01.110Z,1580854141.110 [profile_station:N.YoYo](DEBUG): Uninitialize YoYoComponent.
2020-02-04T22:09:01.225Z,1580854141.225 [WetLabsSeaOWL_UV_A](INFO): Powering down
2020-02-04T22:09:01.517Z,1580854141.517 [MissionManager](IMPORTANT): Started mission DefaultWithUndock
2020-02-04T22:09:01.517Z,1580854141.517 [DefaultWithUndock] Running Loop=1
2020-02-04T22:09:01.517Z,1580854141.517 [DefaultWithUndock](DEBUG): Aggregate::initialize DefaultWithUndock
2020-02-04T22:09:01.517Z,1580854141.517 [DefaultWithUndock:C.GoToSurface] Running Loop=1
2020-02-04T22:09:01.517Z,1580854141.517 [DefaultWithUndock:C.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2020-02-04T22:09:01.517Z,1580854141.517 [DefaultWithUndock:C.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2020-02-04T22:09:01.518Z,1580854141.518 [DefaultWithUndock:C.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2020-02-04T22:09:01.518Z,1580854141.518 [DefaultWithUndock:C.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2020-02-04T22:09:01.518Z,1580854141.518 [DefaultWithUndock:C.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2020-02-04T22:09:01.518Z,1580854141.518 [DefaultWithUndock:C.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2020-02-04T22:09:01.519Z,1580854141.519 [DefaultWithUndock:A.Wait] Running Loop=1
2020-02-04T22:09:01.519Z,1580854141.519 [DefaultWithUndock:A.Wait](DEBUG): Initialize Wait Component.
2020-02-04T22:09:05.859Z,1580854145.859 [CommandLine](IMPORTANT): got command show variable distance
2020-02-04T22:09:05.862Z,1580854145.862 [CommandLine](IMPORTANT): distance_from_shore (unknown)
2020-02-04T22:09:05.863Z,1580854145.863 [CommandLine](IMPORTANT): fix_distance_made_good (unknown)
2020-02-04T22:09:05.863Z,1580854145.863 [CommandLine](IMPORTANT): fix_residual_distance (unknown)
2020-02-04T22:09:05.863Z,1580854145.863 [CommandLine](IMPORTANT): fix_residual_percent_distance_traveled (unknown)
2020-02-04T22:09:05.865Z,1580854145.865 [CommandLine](IMPORTANT): platform_distance_wrt_ground (unknown)
2020-02-04T22:09:05.865Z,1580854145.865 [CommandLine](IMPORTANT): platform_distance_wrt_sea_water (meter)
2020-02-04T22:09:06.036Z,1580854146.036 [CommandLine](IMPORTANT): MassServo.deviationDistance (millimeter)
2020-02-04T22:09:06.070Z,1580854146.070 [CommandLine](IMPORTANT): GobyModem.maxDistance (kilometer)
2020-02-04T22:09:06.082Z,1580854146.082 [CommandLine](IMPORTANT): Rowe_600.acousticBlankingDistance (meter)
2020-02-04T22:09:06.175Z,1580854146.175 [CommandLine](IMPORTANT): DeadReckonUsingMultipleVelocitySources.fix_distance_made_good (meter)
2020-02-04T22:09:06.176Z,1580854146.176 [CommandLine](IMPORTANT): DeadReckonUsingMultipleVelocitySources.fix_residual_distance (meter)
2020-02-04T22:09:06.180Z,1580854146.180 [CommandLine](IMPORTANT): DeadReckonUsingMultipleVelocitySources.fix_residual_percent_distance_traveled (percent)
2020-02-04T22:09:06.182Z,1580854146.182 [CommandLine](IMPORTANT): NavChart.distance_from_shore (meter)
2020-02-04T22:09:06.183Z,1580854146.183 [CommandLine](IMPORTANT): SpeedCalculator.platform_distance_wrt_sea_water (meter)
2020-02-04T22:09:06.235Z,1580854146.235 [CommandLine](IMPORTANT): NavChartDb.closestDistance (meter)
2020-02-04T22:09:06.235Z,1580854146.235 [CommandLine](IMPORTANT): NavChartDb.nextDistance (meter)
2020-02-04T22:09:14.492Z,1580854154.492 [CommandLine](IMPORTANT): got command get distance_from_shore
2020-02-04T22:09:14.492Z,1580854154.492 [CommandLine](FAULT): Element has no value
2020-02-04T22:09:31.781Z,1580854171.781 [DefaultWithUndock:A.Wait](INFO): Done Waiting.
2020-02-04T22:09:31.781Z,1580854171.781 [DefaultWithUndock:A.Wait] Stopped
2020-02-04T22:09:31.781Z,1580854171.781 [DefaultWithUndock:A.Wait](DEBUG): Uninitialize Wait Component.
2020-02-04T22:09:31.782Z,1580854171.782 [DefaultWithUndock:B.Undock] Running Loop=1
2020-02-04T22:09:31.782Z,1580854171.782 [DefaultWithUndock:B.Undock](DEBUG): Initialize.
2020-02-04T22:09:32.595Z,1580854172.595 [PowerOnly](INFO): Powering up
2020-02-04T22:09:35.491Z,1580854175.491 [DefaultWithUndock:B.Undock](INFO): Detaching from dock.
2020-02-04T22:09:35.874Z,1580854175.874 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-04T22:09:35.875Z,1580854175.875 [RDI_Pathfinder](ERROR): Failed to parse:
:BS,-32768,-32768,-32768-32768,-32768,-32768,V
2020-02-04T22:09:35.884Z,1580854175.884 [DefaultWithUndock:B.Undock](INFO): Detached at range: nan m. Transitioning DDM to standby.
2020-02-04T22:09:38.719Z,1580854178.719 [DefaultWithUndock:B.Undock](INFO): DDM at standby.
2020-02-04T22:09:39.107Z,1580854179.107 [RDI_Pathfinder](ERROR): Failed to parse:
:SA,   +0.00,   +0.00,  0.00
2020-02-04T22:09:39.115Z,1580854179.115 [DefaultWithUndock:B.Undock](IMPORTANT): Undocking sequence complete.
2020-02-04T22:09:39.115Z,1580854179.115 [DefaultWithUndock:B.Undock] Stopped
2020-02-04T22:09:39.464Z,1580854179.464 [DefaultWithUndock:CheckIn] Running Loop=1
2020-02-04T22:09:39.464Z,1580854179.464 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:CheckIn
2020-02-04T22:09:39.464Z,1580854179.464 [DefaultWithUndock:CheckIn:Read_GPS] Running Loop=1
2020-02-04T22:11:03.893Z,1580854263.893 [PowerOnly](INFO): Powering down
2020-02-04T22:11:05.518Z,1580854265.518 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2020-02-04T22:11:05.518Z,1580854265.518 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-02-04T22:11:05.528Z,1580854265.528 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-02-04T22:11:05.943Z,1580854265.943 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-02-04T22:11:05.943Z,1580854265.943 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2020-02-04T22:11:20.839Z,1580854280.839 [NAL9602](FAULT): GPS failed to acquire within timeout.
2020-02-04T22:11:20.839Z,1580854280.839 [NAL9602] Data Fault, FailCount= 2
2020-02-04T22:11:20.839Z,1580854280.839 [NAL9602](ERROR): Data Fault
2020-02-04T22:11:20.921Z,1580854280.921 [CBIT](ERROR): Data Fault in component: NAL9602
2020-02-04T22:11:21.239Z,1580854281.239 [NAL9602](INFO): Powering down
2020-02-04T22:11:22.090Z,1580854282.090 [CBIT](INFO): Clearing failed state for component NAL9602
2020-02-04T22:11:22.090Z,1580854282.090 [NAL9602] No Fault, FailCount= 2
2020-02-04T22:11:51.539Z,1580854311.539 [NAL9602](INFO): Powering up NAL9602
2020-02-04T22:12:02.451Z,1580854322.451 [NAL9602](INFO): NAL9602 initialized
2020-02-04T22:14:03.277Z,1580854443.277 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-02-04T22:14:03.277Z,1580854443.277 [RDI_Pathfinder](ERROR): Failed to parse:
:BS,-3278,-32768,V
2020-02-04T22:14:06.498Z,1580854446.498 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2020-02-04T22:14:06.498Z,1580854446.498 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2020-02-04T22:14:06.524Z,1580854446.524 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2020-02-04T22:14:06.957Z,1580854446.957 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2020-02-04T22:14:06.957Z,1580854446.957 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2020-02-04T22:14:35.408Z,1580854475.408 [CommandLine](IMPORTANT): got command get latitude
2020-02-04T22:14:35.408Z,1580854475.408 [CommandLine](FAULT): Element has no value
2020-02-04T22:14:39.647Z,1580854479.647 [DefaultWithUndock:CheckIn:Read_GPS](INFO): Timed out from 2020-02-04T22:09:39.5Z
2020-02-04T22:14:39.647Z,1580854479.647 [DefaultWithUndock:CheckIn:Read_GPS] Stopped
2020-02-04T22:14:39.647Z,1580854479.647 [DefaultWithUndock:CheckIn:Read_Iridium] Running Loop=1
2020-02-04T22:14:57.036Z,1580854497.036 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200204T214949/Courier0007.lzma
2020-02-04T22:14:59.042Z,1580854499.042 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214949/Courier0007.lzma.bak
2020-02-04T22:14:59.042Z,1580854499.042 [DataOverHttps](INFO): SBD MOMSN=12219109
2020-02-04T22:15:16.078Z,1580854516.078 [DataOverHttps](INFO): Sending 1241 bytes from file Logs/20200204T214949/Express0008.lzma
2020-02-04T22:15:18.098Z,1580854518.098 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214949/Express0008.lzma.bak
2020-02-04T22:15:18.098Z,1580854518.098 [DataOverHttps](INFO): SBD MOMSN=12219111
2020-02-04T22:15:22.890Z,1580854522.890 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude
2020-02-04T22:15:22.890Z,1580854522.890 [RDI_Pathfinder](ERROR): Failed to parse:
:BD,        +0.   +0.00,        +0.00,   0.00,1509.90
2020-02-04T22:15:35.139Z,1580854535.139 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200204T214949/Express0011.lzma
2020-02-04T22:15:37.142Z,1580854537.142 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214949/Express0011.lzma.bak
2020-02-04T22:15:37.142Z,1580854537.142 [DataOverHttps](INFO): SBD MOMSN=12219165
2020-02-04T22:15:38.260Z,1580854538.260 [DefaultWithUndock:CheckIn:Read_Iridium] Stopped
2020-02-04T22:15:38.264Z,1580854538.264 [DefaultWithUndock:CheckIn:C.Wait] Running Loop=1
2020-02-04T22:15:38.265Z,1580854538.265 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-02-04T22:17:07.485Z,1580854627.485 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221706.00,A,4131.48217,N,07040.26196,W,0.739,0.00,040220,,,A*73
2020-02-04T22:17:07.489Z,1580854627.489 [NAL9602](INFO): GPS fix at 20200204T221706: (41.524703, -70.671033)
2020-02-04T22:17:30.387Z,1580854650.387 [CommandLine](IMPORTANT): got command ibit
2020-02-04T22:17:30.595Z,1580854650.595 [IBIT](IMPORTANT): Beginning Initiated BIT
2020-02-04T22:17:30.596Z,1580854650.596 [IBIT](IMPORTANT): Beginning control surface checks.
2020-02-04T22:17:30.607Z,1580854650.607 [CBIT](IMPORTANT): Beginning ground fault scan
2020-02-04T22:17:32.137Z,1580854652.137 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221730.00,A,4131.47725,N,07040.27261,W,0.486,0.00,040220,,,A*70
2020-02-04T22:17:32.139Z,1580854652.139 [NAL9602](INFO): GPS fix at 20200204T221730: (41.524621, -70.671210)
2020-02-04T22:17:34.233Z,1580854654.233 [CommandLine](IMPORTANT): got command show variable distance
2020-02-04T22:17:34.235Z,1580854654.235 [CommandLine](IMPORTANT): distance_from_shore (unknown)
2020-02-04T22:17:34.235Z,1580854654.235 [CommandLine](IMPORTANT): fix_distance_made_good (unknown)
2020-02-04T22:17:34.236Z,1580854654.236 [CommandLine](IMPORTANT): fix_residual_distance (unknown)
2020-02-04T22:17:34.237Z,1580854654.237 [CommandLine](IMPORTANT): fix_residual_percent_distance_traveled (unknown)
2020-02-04T22:17:34.239Z,1580854654.239 [CommandLine](IMPORTANT): platform_distance_wrt_ground (unknown)
2020-02-04T22:17:34.239Z,1580854654.239 [CommandLine](IMPORTANT): platform_distance_wrt_sea_water (meter)
2020-02-04T22:17:34.403Z,1580854654.403 [CommandLine](IMPORTANT): MassServo.deviationDistance (millimeter)
2020-02-04T22:17:34.460Z,1580854654.460 [CommandLine](IMPORTANT): GobyModem.maxDistance (kilometer)
2020-02-04T22:17:34.472Z,1580854654.472 [CommandLine](IMPORTANT): Rowe_600.acousticBlankingDistance (meter)
2020-02-04T22:17:34.641Z,1580854654.641 [CommandLine](IMPORTANT): DeadReckonUsingMultipleVelocitySources.fix_distance_made_good (meter)
2020-02-04T22:17:34.642Z,1580854654.642 [CommandLine](IMPORTANT): DeadReckonUsingMultipleVelocitySources.fix_residual_distance (meter)
2020-02-04T22:17:34.642Z,1580854654.642 [CommandLine](IMPORTANT): DeadReckonUsingMultipleVelocitySources.fix_residual_percent_distance_traveled (percent)
2020-02-04T22:17:34.643Z,1580854654.643 [CommandLine](IMPORTANT): NavChart.distance_from_shore (meter)
2020-02-04T22:17:34.649Z,1580854654.649 [CommandLine](IMPORTANT): SpeedCalculator.platform_distance_wrt_sea_water (meter)
2020-02-04T22:17:34.662Z,1580854654.662 [CommandLine](IMPORTANT): NavChartDb.closestDistance (meter)
2020-02-04T22:17:34.663Z,1580854654.663 [CommandLine](IMPORTANT): NavChartDb.nextDistance (meter)
2020-02-04T22:17:35.382Z,1580854655.382 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221734.00,A,4131.47673,N,07040.27930,W,3.402,0.00,040220,,,A*76
2020-02-04T22:17:35.388Z,1580854655.388 [NAL9602](INFO): GPS fix at 20200204T221734: (41.524612, -70.671322)
2020-02-04T22:17:38.652Z,1580854658.652 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221737.00,A,4131.47959,N,07040.28388,W,6.220,321.23,040220,,,A*76
2020-02-04T22:17:38.654Z,1580854658.654 [NAL9602](INFO): GPS fix at 20200204T221737: (41.524660, -70.671398)
2020-02-04T22:17:41.470Z,1580854661.470 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221740.00,A,4131.48151,N,07040.28795,W,4.724,302.69,040220,,,A*7D
2020-02-04T22:17:41.472Z,1580854661.472 [NAL9602](INFO): GPS fix at 20200204T221740: (41.524692, -70.671466)
2020-02-04T22:17:41.550Z,1580854661.550 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.009317
CHAN A1 (24V): -0.028611
CHAN A2 (12V): -0.007388
CHAN A3 (5V): -0.002331
CHAN B0 (3.3V): 0.000490
CHAN B1 (3.15aV): 0.000083
CHAN B2 (3.15bV): 0.000025
CHAN B3 (GND): 0.001801
OPEN: 0.005250
Full Scale Calc: 4.765 mA, -1.589 mA
2020-02-04T22:17:42.879Z,1580854662.879 [CommandLine](IMPORTANT): got command get distance_from_shore
2020-02-04T22:17:42.879Z,1580854662.879 [CommandLine](FAULT): Element has no value
2020-02-04T22:17:44.301Z,1580854664.301 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221743.00,A,4131.48249,N,07040.29159,W,3.305,302.69,040220,,,A*73
2020-02-04T22:17:44.303Z,1580854664.303 [NAL9602](INFO): GPS fix at 20200204T221743: (41.524708, -70.671526)
2020-02-04T22:17:47.575Z,1580854667.575 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221746.00,A,4131.48253,N,07040.29533,W,3.285,302.69,040220,,,A*7C
2020-02-04T22:17:47.594Z,1580854667.594 [NAL9602](INFO): GPS fix at 20200204T221746: (41.524709, -70.671589)
2020-02-04T22:17:50.365Z,1580854670.365 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221749.00,A,4131.48461,N,07040.29677,W,1.827,302.69,040220,,,A*77
2020-02-04T22:17:50.367Z,1580854670.367 [NAL9602](INFO): GPS fix at 20200204T221749: (41.524743, -70.671613)
2020-02-04T22:17:53.587Z,1580854673.587 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221752.00,A,4131.47913,N,07040.29671,W,3.577,302.69,040220,,,A*76
2020-02-04T22:17:53.589Z,1580854673.589 [NAL9602](INFO): GPS fix at 20200204T221752: (41.524652, -70.671612)
2020-02-04T22:17:56.421Z,1580854676.421 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221755.00,A,4131.47430,N,07040.29604,W,1.924,302.69,040220,,,A*77
2020-02-04T22:17:56.423Z,1580854676.423 [NAL9602](INFO): GPS fix at 20200204T221755: (41.524572, -70.671601)
2020-02-04T22:17:59.649Z,1580854679.649 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221758.00,A,4131.46729,N,07040.29697,W,2.624,302.69,040220,,,A*76
2020-02-04T22:17:59.651Z,1580854679.651 [NAL9602](INFO): GPS fix at 20200204T221758: (41.524455, -70.671616)
2020-02-04T22:17:59.821Z,1580854679.821 [CommandLine](IMPORTANT): got command get NavChart.distance_from_shore
2020-02-04T22:17:59.821Z,1580854679.821 [CommandLine](IMPORTANT): NavChart.distance_from_shore nan m
2020-02-04T22:18:02.474Z,1580854682.474 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221801.00,A,4131.46594,N,07040.29794,W,1.866,302.69,040220,,,A*78
2020-02-04T22:18:02.477Z,1580854682.477 [NAL9602](INFO): GPS fix at 20200204T221801: (41.524432, -70.671632)
2020-02-04T22:18:05.317Z,1580854685.317 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221804.00,A,4131.46471,N,07040.29925,W,0.622,302.69,040220,,,A*7C
2020-02-04T22:18:05.319Z,1580854685.319 [NAL9602](INFO): GPS fix at 20200204T221804: (41.524412, -70.671654)
2020-02-04T22:18:08.553Z,1580854688.553 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221807.00,A,4131.46464,N,07040.29851,W,0.330,302.69,040220,,,A*7F
2020-02-04T22:18:08.555Z,1580854688.555 [NAL9602](INFO): GPS fix at 20200204T221807: (41.524411, -70.671642)
2020-02-04T22:18:11.372Z,1580854691.372 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221810.00,A,4131.46440,N,07040.29749,W,0.214,302.69,040220,,,A*7E
2020-02-04T22:18:11.374Z,1580854691.374 [NAL9602](INFO): GPS fix at 20200204T221810: (41.524407, -70.671625)
2020-02-04T22:18:14.602Z,1580854694.602 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221813.00,A,4131.46385,N,07040.29842,W,0.389,302.69,040220,,,A*72
2020-02-04T22:18:14.604Z,1580854694.604 [NAL9602](INFO): GPS fix at 20200204T221813: (41.524397, -70.671640)
2020-02-04T22:18:14.828Z,1580854694.828 [CommandLine](IMPORTANT): got command show variable distance_from
2020-02-04T22:18:14.831Z,1580854694.831 [CommandLine](IMPORTANT): distance_from_shore (unknown)
2020-02-04T22:18:14.960Z,1580854694.960 [CommandLine](IMPORTANT): NavChart.distance_from_shore (meter)
2020-02-04T22:18:15.033Z,1580854695.033 [RDI_Pathfinder](ERROR): only read 1 of 4 data items
2020-02-04T22:18:15.033Z,1580854695.033 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  08,-32768,V
2020-02-04T22:18:17.428Z,1580854697.428 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221816.00,A,4131.46311,N,07040.29910,W,0.350,302.69,040220,,,A*78
2020-02-04T22:18:17.430Z,1580854697.430 [NAL9602](INFO): GPS fix at 20200204T221816: (41.524385, -70.671652)
2020-02-04T22:18:20.663Z,1580854700.663 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221819.00,A,4131.46264,N,07040.30040,W,0.253,302.69,040220,,,A*72
2020-02-04T22:18:20.665Z,1580854700.665 [NAL9602](INFO): GPS fix at 20200204T221819: (41.524377, -70.671673)
2020-02-04T22:18:23.488Z,1580854703.488 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221822.00,A,4131.46263,N,07040.30148,W,0.641,302.69,040220,,,A*73
2020-02-04T22:18:23.490Z,1580854703.490 [NAL9602](INFO): GPS fix at 20200204T221822: (41.524377, -70.671691)
2020-02-04T22:18:29.542Z,1580854709.542 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221828.00,A,4131.46072,N,07040.31435,W,0.233,257.16,040220,,,A*7D
2020-02-04T22:18:29.545Z,1580854709.545 [NAL9602](INFO): GPS fix at 20200204T221828: (41.524345, -70.671906)
2020-02-04T22:18:32.374Z,1580854712.374 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221831.00,A,4131.45958,N,07040.31272,W,0.019,257.16,040220,,,A*78
2020-02-04T22:18:32.376Z,1580854712.376 [NAL9602](INFO): GPS fix at 20200204T221831: (41.524326, -70.671879)
2020-02-04T22:18:35.610Z,1580854715.610 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221834.00,A,4131.45918,N,07040.31251,W,0.019,257.16,040220,,,A*78
2020-02-04T22:18:35.612Z,1580854715.612 [NAL9602](INFO): GPS fix at 20200204T221834: (41.524320, -70.671875)
2020-02-04T22:18:38.433Z,1580854718.433 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221837.00,A,4131.45919,N,07040.31241,W,0.019,257.16,040220,,,A*7B
2020-02-04T22:18:38.435Z,1580854718.435 [NAL9602](INFO): GPS fix at 20200204T221837: (41.524320, -70.671874)
2020-02-04T22:18:41.664Z,1580854721.664 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221840.00,A,4131.45917,N,07040.31255,W,0.039,257.16,040220,,,A*72
2020-02-04T22:18:41.666Z,1580854721.666 [NAL9602](INFO): GPS fix at 20200204T221840: (41.524319, -70.671876)
2020-02-04T22:18:44.497Z,1580854724.497 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221843.00,A,4131.45914,N,07040.31263,W,0.019,257.16,040220,,,A*75
2020-02-04T22:18:44.502Z,1580854724.502 [NAL9602](INFO): GPS fix at 20200204T221843: (41.524319, -70.671877)
2020-02-04T22:18:47.722Z,1580854727.722 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221846.00,A,4131.45892,N,07040.31252,W,0.019,257.16,040220,,,A*7D
2020-02-04T22:18:47.725Z,1580854727.725 [NAL9602](INFO): GPS fix at 20200204T221846: (41.524315, -70.671875)
2020-02-04T22:18:50.551Z,1580854730.551 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221849.00,A,4131.45877,N,07040.31227,W,0.019,257.16,040220,,,A*7B
2020-02-04T22:18:50.566Z,1580854730.566 [NAL9602](INFO): GPS fix at 20200204T221849: (41.524313, -70.671871)
2020-02-04T22:18:53.387Z,1580854733.387 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221852.00,A,4131.45877,N,07040.31212,W,0.019,257.16,040220,,,A*77
2020-02-04T22:18:53.389Z,1580854733.389 [NAL9602](INFO): GPS fix at 20200204T221852: (41.524313, -70.671869)
2020-02-04T22:18:56.621Z,1580854736.621 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221855.00,A,4131.45875,N,07040.31191,W,0.039,257.16,040220,,,A*78
2020-02-04T22:18:56.623Z,1580854736.623 [NAL9602](INFO): GPS fix at 20200204T221855: (41.524313, -70.671865)
2020-02-04T22:18:59.445Z,1580854739.445 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221858.00,A,4131.45876,N,07040.31176,W,0.039,257.16,040220,,,A*7F
2020-02-04T22:18:59.447Z,1580854739.447 [NAL9602](INFO): GPS fix at 20200204T221858: (41.524313, -70.671863)
2020-02-04T22:19:02.677Z,1580854742.677 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221901.00,A,4131.45871,N,07040.31158,W,0.019,257.16,040220,,,A*7B
2020-02-04T22:19:02.679Z,1580854742.679 [NAL9602](INFO): GPS fix at 20200204T221901: (41.524312, -70.671860)
2020-02-04T22:19:05.506Z,1580854745.506 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221904.00,A,4131.45864,N,07040.31140,W,0.039,257.16,040220,,,A*71
2020-02-04T22:19:05.508Z,1580854745.508 [NAL9602](INFO): GPS fix at 20200204T221904: (41.524311, -70.671857)
2020-02-04T22:19:08.731Z,1580854748.731 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221907.00,A,4131.45859,N,07040.31119,W,0.019,257.16,040220,,,A*72
2020-02-04T22:19:08.734Z,1580854748.734 [NAL9602](INFO): GPS fix at 20200204T221907: (41.524310, -70.671853)
2020-02-04T22:19:11.559Z,1580854751.559 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221910.00,A,4131.45862,N,07040.31101,W,0.078,257.16,040220,,,A*72
2020-02-04T22:19:11.573Z,1580854751.573 [NAL9602](INFO): GPS fix at 20200204T221910: (41.524310, -70.671850)
2020-02-04T22:19:14.388Z,1580854754.388 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221913.00,A,4131.45869,N,07040.31085,W,0.039,257.16,040220,,,A*72
2020-02-04T22:19:14.391Z,1580854754.391 [NAL9602](INFO): GPS fix at 20200204T221913: (41.524312, -70.671847)
2020-02-04T22:19:17.621Z,1580854757.621 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221916.00,A,4131.45879,N,07040.31066,W,0.039,257.16,040220,,,A*7B
2020-02-04T22:19:17.623Z,1580854757.623 [NAL9602](INFO): GPS fix at 20200204T221916: (41.524313, -70.671844)
2020-02-04T22:19:20.452Z,1580854760.452 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221919.00,A,4131.45892,N,07040.31050,W,0.058,257.16,040220,,,A*73
2020-02-04T22:19:20.457Z,1580854760.457 [NAL9602](INFO): GPS fix at 20200204T221919: (41.524315, -70.671842)
2020-02-04T22:19:21.709Z,1580854761.709 [IBIT](FAULT): Error acquiring IBIT communications status. Timeout expired.
2020-02-04T22:19:22.116Z,1580854762.116 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 15.263000
2020-02-04T22:19:22.116Z,1580854762.116 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2020-02-04T22:19:22.121Z,1580854762.121 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2020-02-04T22:19:22.538Z,1580854762.538 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2020-02-04T22:19:22.538Z,1580854762.538 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2020-02-04T22:19:22.539Z,1580854762.539 [IBIT](IMPORTANT): Pressure:10.422977 PSI
2020-02-04T22:19:22.539Z,1580854762.539 [IBIT](IMPORTANT): Humidity:7.013795 %
2020-02-04T22:19:22.926Z,1580854762.926 [IBIT](IMPORTANT): Vehicle Pitch:0.741764 degrees
2020-02-04T22:19:22.926Z,1580854762.926 [IBIT](IMPORTANT): Vehicle  Roll:3.091689 degrees
2020-02-04T22:19:22.927Z,1580854762.927 [IBIT](IMPORTANT): Vehicle  Heading:50.812897 degrees
2020-02-04T22:19:23.333Z,1580854763.333 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2020-02-04T22:19:23.333Z,1580854763.333 [IBIT](IMPORTANT): buoyancyNeutral: 105.000000 cc
2020-02-04T22:19:23.334Z,1580854763.334 [IBIT](IMPORTANT): massDefault: 0.500000 cm
2020-02-04T22:19:23.334Z,1580854763.334 [IBIT](IMPORTANT): stopDepth: 215.000000 m
2020-02-04T22:19:23.334Z,1580854763.334 [IBIT](IMPORTANT): abortDepth: 255.000000 m
2020-02-04T22:19:23.334Z,1580854763.334 [IBIT](IMPORTANT): IBIT FAILED
2020-02-04T22:19:23.681Z,1580854763.681 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,221922.00,A,4131.45901,N,07040.31038,W,0.019,257.16,040220,,,A*7B
2020-02-04T22:19:23.683Z,1580854763.683 [NAL9602](INFO): GPS fix at 20200204T221922: (41.524317, -70.671840)
2020-02-04T22:19:50.374Z,1580854790.374 [RDI_Pathfinder](ERROR): Failed to parse:
00,   0.00,   0.00,   0.00,   0.00
2020-02-04T22:19:55.231Z,1580854795.231 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-02-04T22:19:55.232Z,1580854795.232 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,20020415330885,35.0, 0.0,1448.9,  0
2020-02-04T22:19:56.011Z,1580854796.011 [NAL9602](INFO): Not Powering down - fast GPS
2020-02-04T22:20:38.854Z,1580854838.854 [DefaultWithUndock:CheckIn:C.Wait](INFO): Done Waiting.
2020-02-04T22:20:38.855Z,1580854838.855 [DefaultWithUndock:CheckIn:C.Wait] Stopped
2020-02-04T22:20:38.855Z,1580854838.855 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-02-04T22:20:38.855Z,1580854838.855 [DefaultWithUndock:CheckIn:D] Running Loop=1
2020-02-04T22:20:39.270Z,1580854839.270 [DefaultWithUndock:CheckIn:D] Stopped
2020-02-04T22:20:39.270Z,1580854839.270 [DefaultWithUndock:CheckIn:E] Running Loop=1
2020-02-04T22:20:39.673Z,1580854839.673 [DefaultWithUndock:CheckIn:E](IMPORTANT): Default mission has been running for 11.629225 min 
2020-02-04T22:20:39.673Z,1580854839.673 [DefaultWithUndock:CheckIn:E] Stopped
2020-02-04T22:20:39.673Z,1580854839.673 [DefaultWithUndock:CheckIn](INFO): Completed DefaultWithUndock:CheckIn
2020-02-04T22:20:39.673Z,1580854839.673 [DefaultWithUndock:CheckIn] Stopped
2020-02-04T22:20:39.673Z,1580854839.673 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:CheckIn
2020-02-04T22:20:39.673Z,1580854839.673 [DefaultWithUndock:CheckIn](INFO): Running loop #2
2020-02-04T22:20:39.674Z,1580854839.674 [DefaultWithUndock:CheckIn] Running Loop=2
2020-02-04T22:20:39.674Z,1580854839.674 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:CheckIn
2020-02-04T22:20:39.674Z,1580854839.674 [DefaultWithUndock:CheckIn:Read_GPS] Running Loop=1
2020-02-04T22:20:41.661Z,1580854841.661 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,222040.00,A,4131.46030,N,07040.31071,W,0.058,257.16,040220,,,D*70
2020-02-04T22:20:41.663Z,1580854841.663 [NAL9602](INFO): GPS fix at 20200204T222040: (41.524338, -70.671845)
2020-02-04T22:20:41.706Z,1580854841.706 [DefaultWithUndock:CheckIn:Read_GPS] Stopped
2020-02-04T22:20:41.706Z,1580854841.706 [DefaultWithUndock:CheckIn:Read_Iridium] Running Loop=1
2020-02-04T22:20:49.600Z,1580854849.600 [DataOverHttps](INFO): Sending 222 bytes from file Logs/20200204T214949/Courier0013.lzma
2020-02-04T22:20:51.606Z,1580854851.606 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214949/Courier0013.lzma.bak
2020-02-04T22:20:51.606Z,1580854851.606 [DataOverHttps](INFO): SBD MOMSN=12219167
2020-02-04T22:21:04.284Z,1580854864.284 [NAL9602](INFO): SBD MO Status=2, MOMSN=10321, MT Status=2, MTMSN=0
2020-02-04T22:21:04.284Z,1580854864.284 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2020-02-04T22:21:09.074Z,1580854869.074 [DataOverHttps](INFO): Sending 1262 bytes from file Logs/20200204T214949/Express0014.lzma
2020-02-04T22:21:11.078Z,1580854871.078 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214949/Express0014.lzma.bak
2020-02-04T22:21:11.078Z,1580854871.078 [DataOverHttps](INFO): SBD MOMSN=12219170
2020-02-04T22:21:12.401Z,1580854872.401 [DefaultWithUndock:CheckIn:Read_Iridium] Stopped
2020-02-04T22:21:12.401Z,1580854872.401 [DefaultWithUndock:CheckIn:C.Wait] Running Loop=1
2020-02-04T22:21:12.401Z,1580854872.401 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-02-04T22:21:17.230Z,1580854877.230 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-04T22:21:17.231Z,1580854877.231 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2020-02-04T22:21:21.656Z,1580854881.656 [NAL9602](INFO): SBD MO Status=2, MOMSN=10321, MT Status=2, MTMSN=0
2020-02-04T22:21:21.656Z,1580854881.656 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2020-02-04T22:21:47.509Z,1580854907.509 [NAL9602](INFO): SBD MO Status=0, MOMSN=10321, MT Status=0, MTMSN=0
2020-02-04T22:21:47.509Z,1580854907.509 [NAL9602](INFO): No messages in MT queue
2020-02-04T22:21:51.563Z,1580854911.563 [RDI_Pathfinder](ERROR): only read 0 of 4 data items
2020-02-04T22:21:51.564Z,1580854911.564 [RDI_Pathfinder](ERROR): Failed to parse:
:RA   0.00,   0.00,   0.00,   0.00
2020-02-04T22:21:57.232Z,1580854917.232 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-02-04T22:21:57.232Z,1580854917.232 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,20020415351085,35.0, -0.1,   0.0,1448.RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-04T22:22:18.219Z,1580854938.219 [NAL9602](INFO): Not Powering down - fast GPS
2020-02-04T22:23:17.227Z,1580854997.227 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-02-04T22:23:17.228Z,1580854997.228 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,20020415363085,35.0  0.0,1448.9,  0
2020-02-04T22:23:26.034Z,1580855006.034 [CommandLine](IMPORTANT): got command report mod platform_buoyancy_position
2020-02-04T22:23:26.162Z,1580855006.162 [Reporter](INFO): platform_buoyancy_position 947.324951 cc
2020-02-04T22:23:32.574Z,1580855012.574 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-02-04T22:23:32.574Z,1580855012.574 [RDI_Pathfinder](ERROR): Failed to parse:
:TS,20020415364585,35.0, 0.0,1448.9,  0
2020-02-04T22:24:14.713Z,1580855054.713 [CommandLine](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 200.000000 cubic_centimeter
2020-02-04T22:24:14.714Z,1580855054.714 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.buoyancyAction" handled in the control thread.
2020-02-04T22:24:15.051Z,1580855055.051 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,DDM,Depth_Keller,DropWeight,DUSBL_Hydroid,Micromodem,NAL9602,Onboard,PowerOnly,RDI_Pathfinder,BPC1,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2020-02-04T22:24:19.955Z,1580855059.955 [Reporter](INFO): platform_buoyancy_position 947.056396 cc
2020-02-04T22:24:20.336Z,1580855060.336 [Reporter](INFO): platform_buoyancy_position 947.190674 cc
2020-02-04T22:24:20.690Z,1580855060.690 [Reporter](INFO): platform_buoyancy_position 945.310425 cc
2020-02-04T22:24:21.111Z,1580855061.111 [Reporter](INFO): platform_buoyancy_position 936.312378 cc
2020-02-04T22:24:21.515Z,1580855061.515 [Reporter](INFO): platform_buoyancy_position 934.566528 cc
2020-02-04T22:24:21.999Z,1580855061.999 [Reporter](INFO): platform_buoyancy_position 930.268921 cc
2020-02-04T22:24:22.311Z,1580855062.311 [Reporter](INFO): platform_buoyancy_position 927.985840 cc
2020-02-04T22:24:22.730Z,1580855062.730 [Reporter](INFO): platform_buoyancy_position 923.688232 cc
2020-02-04T22:24:23.070Z,1580855063.070 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-04T22:24:23.070Z,1580855063.070 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,  49.01,  69.64,  58.6

2020-02-04T22:24:23.170Z,1580855063.170 [Reporter](INFO): platform_buoyancy_position 917.376099 cc
2020-02-04T22:24:23.515Z,1580855063.515 [Reporter](INFO): platform_buoyancy_position 913.078491 cc
2020-02-04T22:24:23.966Z,1580855063.966 [Reporter](INFO): platform_buoyancy_position 906.497803 cc
2020-02-04T22:24:24.330Z,1580855064.330 [Reporter](INFO): platform_buoyancy_position 902.200195 cc
2020-02-04T22:24:24.730Z,1580855064.730 [Reporter](INFO): platform_buoyancy_position 897.231079 cc
2020-02-04T22:24:25.138Z,1580855065.138 [Reporter](INFO): platform_buoyancy_position 891.590454 cc
2020-02-04T22:24:25.542Z,1580855065.542 [Reporter](INFO): platform_buoyancy_position 887.292847 cc
2020-02-04T22:24:25.966Z,1580855065.966 [Reporter](INFO): platform_buoyancy_position 881.115112 cc
2020-02-04T22:24:26.358Z,1580855066.358 [Reporter](INFO): platform_buoyancy_position 876.414551 cc
2020-02-04T22:24:26.751Z,1580855066.751 [Reporter](INFO): platform_buoyancy_position 871.311157 cc
2020-02-04T22:24:27.167Z,1580855067.167 [Reporter](INFO): platform_buoyancy_position 865.670532 cc
2020-02-04T22:24:27.570Z,1580855067.570 [Reporter](INFO): platform_buoyancy_position 861.372925 cc
2020-02-04T22:24:27.986Z,1580855067.986 [Reporter](INFO): platform_buoyancy_position 855.060913 cc
2020-02-04T22:24:28.359Z,1580855068.359 [Reporter](INFO): platform_buoyancy_position 850.897583 cc
2020-02-04T22:24:28.770Z,1580855068.770 [Reporter](INFO): platform_buoyancy_position 844.316895 cc
2020-02-04T22:24:29.191Z,1580855069.191 [Reporter](INFO): platform_buoyancy_position 839.885010 cc
2020-02-04T22:24:29.586Z,1580855069.586 [Reporter](INFO): platform_buoyancy_position 833.572876 cc
2020-02-04T22:24:30.018Z,1580855070.018 [Reporter](INFO): platform_buoyancy_position 829.140991 cc
2020-02-04T22:24:30.428Z,1580855070.428 [Reporter](INFO): platform_buoyancy_position 822.828857 cc
2020-02-04T22:24:30.806Z,1580855070.806 [Reporter](INFO): platform_buoyancy_position 818.531250 cc
2020-02-04T22:24:31.226Z,1580855071.226 [Reporter](INFO): platform_buoyancy_position 812.084900 cc
2020-02-04T22:24:31.598Z,1580855071.598 [Reporter](INFO): platform_buoyancy_position 807.652954 cc
2020-02-04T22:24:32.018Z,1580855072.018 [Reporter](INFO): platform_buoyancy_position 801.340881 cc
2020-02-04T22:24:32.419Z,1580855072.419 [Reporter](INFO): platform_buoyancy_position 796.908997 cc
2020-02-04T22:24:32.845Z,1580855072.845 [Reporter](INFO): platform_buoyancy_position 792.477051 cc
2020-02-04T22:24:33.223Z,1580855073.223 [Reporter](INFO): platform_buoyancy_position 786.164978 cc
2020-02-04T22:24:33.637Z,1580855073.637 [Reporter](INFO): platform_buoyancy_position 782.001648 cc
2020-02-04T22:24:34.057Z,1580855074.057 [Reporter](INFO): platform_buoyancy_position 775.555298 cc
2020-02-04T22:24:34.426Z,1580855074.426 [Reporter](INFO): platform_buoyancy_position 771.123352 cc
2020-02-04T22:24:34.831Z,1580855074.831 [Reporter](INFO): platform_buoyancy_position 764.811279 cc
2020-02-04T22:24:35.247Z,1580855075.247 [Reporter](INFO): platform_buoyancy_position 760.513672 cc
2020-02-04T22:24:35.663Z,1580855075.663 [Reporter](INFO): platform_buoyancy_position 754.201599 cc
2020-02-04T22:24:36.070Z,1580855076.070 [Reporter](INFO): platform_buoyancy_position 749.769653 cc
2020-02-04T22:24:36.450Z,1580855076.450 [Reporter](INFO): platform_buoyancy_position 745.203491 cc
2020-02-04T22:24:36.871Z,1580855076.871 [Reporter](INFO): platform_buoyancy_position 738.891357 cc
2020-02-04T22:24:37.283Z,1580855077.283 [Reporter](INFO): platform_buoyancy_position 732.713562 cc
2020-02-04T22:24:37.674Z,1580855077.674 [Reporter](INFO): platform_buoyancy_position 728.147339 cc
2020-02-04T22:24:38.071Z,1580855078.071 [Reporter](INFO): platform_buoyancy_position 723.446838 cc
2020-02-04T22:24:38.479Z,1580855078.479 [Reporter](INFO): platform_buoyancy_position 717.403381 cc
2020-02-04T22:24:38.910Z,1580855078.910 [Reporter](INFO): platform_buoyancy_position 710.956970 cc
2020-02-04T22:24:39.274Z,1580855079.274 [Reporter](INFO): platform_buoyancy_position 706.793640 cc
2020-02-04T22:24:39.695Z,1580855079.695 [Reporter](INFO): platform_buoyancy_position 701.421692 cc
2020-02-04T22:24:40.098Z,1580855080.098 [Reporter](INFO): platform_buoyancy_position 695.915344 cc
2020-02-04T22:24:40.510Z,1580855080.510 [Reporter](INFO): platform_buoyancy_position 691.349182 cc
2020-02-04T22:24:40.930Z,1580855080.930 [Reporter](INFO): platform_buoyancy_position 685.171387 cc
2020-02-04T22:24:41.253Z,1580855081.253 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-04T22:24:41.254Z,1580855081.254 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,  50.67,  70.30,  63.62
2020-02-04T22:24:41.316Z,1580855081.316 [Reporter](INFO): platform_buoyancy_position 680.739441 cc
2020-02-04T22:24:41.717Z,1580855081.717 [Reporter](INFO): platform_buoyancy_position 674.695984 cc
2020-02-04T22:24:42.134Z,1580855082.134 [Reporter](INFO): platform_buoyancy_position 670.129761 cc
2020-02-04T22:24:42.514Z,1580855082.514 [Reporter](INFO): platform_buoyancy_position 663.817688 cc
2020-02-04T22:24:42.954Z,1580855082.954 [Reporter](INFO): platform_buoyancy_position 659.385742 cc
2020-02-04T22:24:43.338Z,1580855083.338 [Reporter](INFO): platform_buoyancy_position 653.342285 cc
2020-02-04T22:24:43.734Z,1580855083.734 [Reporter](INFO): platform_buoyancy_position 648.641785 cc
2020-02-04T22:24:44.162Z,1580855084.162 [Reporter](INFO): platform_buoyancy_position 642.329651 cc
2020-02-04T22:24:44.541Z,1580855084.542 [Reporter](INFO): platform_buoyancy_position 638.032043 cc
2020-02-04T22:24:44.962Z,1580855084.962 [Reporter](INFO): platform_buoyancy_position 633.062988 cc
2020-02-04T22:24:45.362Z,1580855085.362 [Reporter](INFO): platform_buoyancy_position 627.288086 cc
2020-02-04T22:24:45.746Z,1580855085.746 [Reporter](INFO): platform_buoyancy_position 622.856140 cc
2020-02-04T22:24:46.147Z,1580855086.147 [Reporter](INFO): platform_buoyancy_position 616.409790 cc
2020-02-04T22:24:46.566Z,1580855086.566 [Reporter](INFO): platform_buoyancy_position 612.112183 cc
2020-02-04T22:24:46.978Z,1580855086.978 [Reporter](INFO): platform_buoyancy_position 605.800049 cc
2020-02-04T22:24:47.351Z,1580855087.351 [Reporter](INFO): platform_buoyancy_position 601.502441 cc
2020-02-04T22:24:47.763Z,1580855087.763 [Reporter](INFO): platform_buoyancy_position 595.056030 cc
2020-02-04T22:24:48.182Z,1580855088.182 [Reporter](INFO): platform_buoyancy_position 590.624146 cc
2020-02-04T22:24:48.578Z,1580855088.578 [Reporter](INFO): platform_buoyancy_position 584.312073 cc
2020-02-04T22:24:49.014Z,1580855089.014 [Reporter](INFO): platform_buoyancy_position 579.880127 cc
2020-02-04T22:24:49.410Z,1580855089.410 [Reporter](INFO): platform_buoyancy_position 573.568054 cc
2020-02-04T22:24:49.802Z,1580855089.802 [Reporter](INFO): platform_buoyancy_position 569.136169 cc
2020-02-04T22:24:50.230Z,1580855090.230 [Reporter](INFO): platform_buoyancy_position 562.824036 cc
2020-02-04T22:24:50.635Z,1580855090.635 [Reporter](INFO): platform_buoyancy_position 558.392151 cc
2020-02-04T22:24:51.018Z,1580855091.018 [Reporter](INFO): platform_buoyancy_position 552.751526 cc
2020-02-04T22:24:51.427Z,1580855091.427 [Reporter](INFO): platform_buoyancy_position 547.648132 cc
2020-02-04T22:24:51.851Z,1580855091.851 [Reporter](INFO): platform_buoyancy_position 541.201782 cc
2020-02-04T22:24:52.226Z,1580855092.226 [Reporter](INFO): platform_buoyancy_position 536.904175 cc
2020-02-04T22:24:52.616Z,1580855092.616 [Reporter](INFO): platform_buoyancy_position 532.606567 cc
2020-02-04T22:24:53.023Z,1580855093.023 [Reporter](INFO): platform_buoyancy_position 526.160156 cc
2020-02-04T22:24:53.434Z,1580855093.434 [Reporter](INFO): platform_buoyancy_position 521.728271 cc
2020-02-04T22:24:53.830Z,1580855093.830 [Reporter](INFO): platform_buoyancy_position 515.416138 cc
2020-02-04T22:24:54.252Z,1580855094.252 [Reporter](INFO): platform_buoyancy_position 511.118500 cc
2020-02-04T22:24:54.631Z,1580855094.631 [Reporter](INFO): platform_buoyancy_position 504.672180 cc
2020-02-04T22:24:55.047Z,1580855095.047 [Reporter](INFO): platform_buoyancy_position 500.508881 cc
2020-02-04T22:24:55.466Z,1580855095.466 [Reporter](INFO): platform_buoyancy_position 494.331055 cc
2020-02-04T22:24:55.850Z,1580855095.850 [Reporter](INFO): platform_buoyancy_position 489.630554 cc
2020-02-04T22:24:56.255Z,1580855096.255 [Reporter](INFO): platform_buoyancy_position 483.318420 cc
2020-02-04T22:24:56.662Z,1580855096.662 [Reporter](INFO): platform_buoyancy_position 478.886536 cc
2020-02-04T22:24:57.086Z,1580855097.086 [Reporter](INFO): platform_buoyancy_position 474.454651 cc
2020-02-04T22:24:57.455Z,1580855097.455 [Reporter](INFO): platform_buoyancy_position 468.276855 cc
2020-02-04T22:24:57.879Z,1580855097.879 [Reporter](INFO): platform_buoyancy_position 463.844971 cc
2020-02-04T22:24:58.286Z,1580855098.286 [Reporter](INFO): platform_buoyancy_position 457.532837 cc
2020-02-04T22:24:58.688Z,1580855098.688 [Reporter](INFO): platform_buoyancy_position 452.966675 cc
2020-02-04T22:24:59.078Z,1580855099.078 [Reporter](INFO): platform_buoyancy_position 446.788818 cc
2020-02-04T22:24:59.482Z,1580855099.482 [Reporter](INFO): platform_buoyancy_position 442.356934 cc
2020-02-04T22:24:59.926Z,1580855099.926 [Reporter](INFO): platform_buoyancy_position 435.910522 cc
2020-02-04T22:25:00.306Z,1580855100.306 [Reporter](INFO): platform_buoyancy_position 431.612976 cc
2020-02-04T22:25:00.710Z,1580855100.710 [Reporter](INFO): platform_buoyancy_position 425.569458 cc
2020-02-04T22:25:01.098Z,1580855101.098 [Reporter](INFO): platform_buoyancy_position 420.868958 cc
2020-02-04T22:25:01.514Z,1580855101.514 [Reporter](INFO): platform_buoyancy_position 414.691162 cc
2020-02-04T22:25:01.934Z,1580855101.934 [Reporter](INFO): platform_buoyancy_position 410.124939 cc
2020-02-04T22:25:02.299Z,1580855102.299 [Reporter](INFO): platform_buoyancy_position 404.081421 cc
2020-02-04T22:25:02.711Z,1580855102.711 [Reporter](INFO): platform_buoyancy_position 399.515259 cc
2020-02-04T22:25:03.130Z,1580855103.130 [Reporter](INFO): platform_buoyancy_position 394.546143 cc
2020-02-04T22:25:03.522Z,1580855103.522 [Reporter](INFO): platform_buoyancy_position 388.771240 cc
2020-02-04T22:25:03.966Z,1580855103.966 [Reporter](INFO): platform_buoyancy_position 382.324829 cc
2020-02-04T22:25:04.331Z,1580855104.331 [Reporter](INFO): platform_buoyancy_position 377.892944 cc
2020-02-04T22:25:04.746Z,1580855104.746 [Reporter](INFO): platform_buoyancy_position 373.729614 cc
2020-02-04T22:25:05.154Z,1580855105.154 [Reporter](INFO): platform_buoyancy_position 367.283264 cc
2020-02-04T22:25:05.535Z,1580855105.535 [Reporter](INFO): platform_buoyancy_position 362.851318 cc
2020-02-04T22:25:05.951Z,1580855105.951 [Reporter](INFO): platform_buoyancy_position 356.404968 cc
2020-02-04T22:25:06.363Z,1580855106.363 [Reporter](INFO): platform_buoyancy_position 352.107361 cc
2020-02-04T22:25:06.759Z,1580855106.759 [Reporter](INFO): platform_buoyancy_position 347.809753 cc
2020-02-04T22:25:07.183Z,1580855107.183 [Reporter](INFO): platform_buoyancy_position 341.497620 cc
2020-02-04T22:25:07.555Z,1580855107.555 [Reporter](INFO): platform_buoyancy_position 337.065735 cc
2020-02-04T22:25:07.982Z,1580855107.982 [Reporter](INFO): platform_buoyancy_position 330.753662 cc
2020-02-04T22:25:08.376Z,1580855108.376 [Reporter](INFO): platform_buoyancy_position 325.918823 cc
2020-02-04T22:25:08.770Z,1580855108.770 [Reporter](INFO): platform_buoyancy_position 319.875366 cc
2020-02-04T22:25:09.186Z,1580855109.186 [Reporter](INFO): platform_buoyancy_position 315.577759 cc
2020-02-04T22:25:09.590Z,1580855109.590 [Reporter](INFO): platform_buoyancy_position 309.265625 cc
2020-02-04T22:25:10.010Z,1580855110.010 [Reporter](INFO): platform_buoyancy_position 304.833740 cc
2020-02-04T22:25:10.383Z,1580855110.383 [Reporter](INFO): platform_buoyancy_position 298.521637 cc
2020-02-04T22:25:10.802Z,1580855110.802 [Reporter](INFO): platform_buoyancy_position 294.089722 cc
2020-02-04T22:25:11.211Z,1580855111.211 [Reporter](INFO): platform_buoyancy_position 287.777649 cc
2020-02-04T22:25:11.628Z,1580855111.628 [Reporter](INFO): platform_buoyancy_position 283.345734 cc
2020-02-04T22:25:12.018Z,1580855112.018 [Reporter](INFO): platform_buoyancy_position 277.167938 cc
2020-02-04T22:25:12.411Z,1580855112.411 [Reporter](INFO): platform_buoyancy_position 272.736023 cc
2020-02-04T22:25:12.828Z,1580855112.828 [Reporter](INFO): platform_buoyancy_position 266.289642 cc
2020-02-04T22:25:13.222Z,1580855113.222 [Reporter](INFO): platform_buoyancy_position 261.857727 cc
2020-02-04T22:25:13.630Z,1580855113.630 [Reporter](INFO): platform_buoyancy_position 255.679947 cc
2020-02-04T22:25:14.046Z,1580855114.046 [Reporter](INFO): platform_buoyancy_position 251.113724 cc
2020-02-04T22:25:14.422Z,1580855114.422 [Reporter](INFO): platform_buoyancy_position 246.816147 cc
2020-02-04T22:25:14.831Z,1580855114.831 [Reporter](INFO): platform_buoyancy_position 240.638336 cc
2020-02-04T22:25:15.242Z,1580855115.242 [Reporter](INFO): platform_buoyancy_position 236.072144 cc
2020-02-04T22:25:15.642Z,1580855115.642 [Reporter](INFO): platform_buoyancy_position 229.760040 cc
2020-02-04T22:25:16.058Z,1580855116.058 [Reporter](INFO): platform_buoyancy_position 225.059540 cc
2020-02-04T22:25:16.459Z,1580855116.459 [Reporter](INFO): platform_buoyancy_position 219.016022 cc
2020-02-04T22:25:16.874Z,1580855116.874 [Reporter](INFO): platform_buoyancy_position 214.718445 cc
2020-02-04T22:25:20.994Z,1580855120.994 [Reporter](INFO): platform_buoyancy_position 203.840118 cc
2020-02-04T22:25:50.079Z,1580855150.079 [CommandLine](IMPORTANT): got command get Onboard.Temperature
2020-02-04T22:25:50.079Z,1580855150.079 [CommandLine](IMPORTANT): Onboard.Temperature 24.178980 degC
2020-02-04T22:25:50.080Z,1580855150.080 [CommandLine](IMPORTANT): got command get Onboard.Humidity
2020-02-04T22:25:50.080Z,1580855150.080 [CommandLine](IMPORTANT): Onboard.Humidity 6.214138 %
2020-02-04T22:26:04.005Z,1580855164.005 [CommandLine](IMPORTANT): got command get Onboard.Pressure
2020-02-04T22:26:04.005Z,1580855164.005 [CommandLine](IMPORTANT): Onboard.Pressure 71323.867188 Pa
2020-02-04T22:26:08.357Z,1580855168.357 [CommandLine](IMPORTANT): got command get Onboard.Pressure pound_per_square_inch
2020-02-04T22:26:08.357Z,1580855168.357 [CommandLine](IMPORTANT): Onboard.Pressure 10.333353 psi
2020-02-04T22:26:12.982Z,1580855172.982 [DefaultWithUndock:CheckIn:C.Wait](INFO): Done Waiting.
2020-02-04T22:26:12.982Z,1580855172.982 [DefaultWithUndock:CheckIn:C.Wait] Stopped
2020-02-04T22:26:12.982Z,1580855172.982 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-02-04T22:26:12.982Z,1580855172.982 [DefaultWithUndock:CheckIn:D] Running Loop=1
2020-02-04T22:26:13.385Z,1580855173.385 [DefaultWithUndock:CheckIn:D] Stopped
2020-02-04T22:26:13.385Z,1580855173.385 [DefaultWithUndock:CheckIn:E] Running Loop=1
2020-02-04T22:26:13.769Z,1580855173.769 [DefaultWithUndock:CheckIn:E](IMPORTANT): Default mission has been running for 17.197522 min 
2020-02-04T22:26:13.769Z,1580855173.769 [DefaultWithUndock:CheckIn:E] Stopped
2020-02-04T22:26:13.769Z,1580855173.769 [DefaultWithUndock:CheckIn](INFO): Completed DefaultWithUndock:CheckIn
2020-02-04T22:26:13.770Z,1580855173.770 [DefaultWithUndock:CheckIn] Stopped
2020-02-04T22:26:13.770Z,1580855173.770 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:CheckIn
2020-02-04T22:26:13.770Z,1580855173.770 [DefaultWithUndock:CheckIn](INFO): Running loop #3
2020-02-04T22:26:13.770Z,1580855173.770 [DefaultWithUndock:CheckIn] Running Loop=3
2020-02-04T22:26:13.770Z,1580855173.770 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:CheckIn
2020-02-04T22:26:13.770Z,1580855173.770 [DefaultWithUndock:CheckIn:Read_GPS] Running Loop=1
2020-02-04T22:26:15.776Z,1580855175.776 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,222615.00,A,4131.46019,N,07040.31543,W,0.078,293.05,040220,,,D*71
2020-02-04T22:26:15.778Z,1580855175.778 [NAL9602](INFO): GPS fix at 20200204T222615: (41.524336, -70.671924)
2020-02-04T22:26:15.809Z,1580855175.809 [DefaultWithUndock:CheckIn:Read_GPS] Stopped
2020-02-04T22:26:15.809Z,1580855175.809 [DefaultWithUndock:CheckIn:Read_Iridium] Running Loop=1
2020-02-04T22:26:16.767Z,1580855176.767 [CommandLine](IMPORTANT): got command maintain clear
2020-02-04T22:26:17.046Z,1580855177.046 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,DDM,Depth_Keller,DropWeight,DUSBL_Hydroid,Micromodem,NAL9602,Onboard,PowerOnly,RDI_Pathfinder,BPC1,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2020-02-04T22:26:21.574Z,1580855181.574 [Reporter](INFO): platform_buoyancy_position 201.825623 cc
2020-02-04T22:26:21.974Z,1580855181.974 [Reporter](INFO): platform_buoyancy_position 201.959930 cc
2020-02-04T22:26:22.722Z,1580855182.722 [Reporter](INFO): platform_buoyancy_position 203.840118 cc
2020-02-04T22:26:23.128Z,1580855183.128 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20200204T214949/Courier0016.lzma
2020-02-04T22:26:23.148Z,1580855183.148 [Reporter](INFO): platform_buoyancy_position 208.674927 cc
2020-02-04T22:26:23.507Z,1580855183.507 [Reporter](INFO): platform_buoyancy_position 212.569641 cc
2020-02-04T22:26:23.970Z,1580855183.970 [Reporter](INFO): platform_buoyancy_position 218.881744 cc
2020-02-04T22:26:24.314Z,1580855184.314 [Reporter](INFO): platform_buoyancy_position 223.313629 cc
2020-02-04T22:26:24.746Z,1580855184.746 [Reporter](INFO): platform_buoyancy_position 229.760040 cc
2020-02-04T22:26:25.134Z,1580855185.134 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214949/Courier0016.lzma.bak
2020-02-04T22:26:25.134Z,1580855185.134 [DataOverHttps](INFO): SBD MOMSN=12219283
2020-02-04T22:26:25.185Z,1580855185.185 [Reporter](INFO): platform_buoyancy_position 236.072144 cc
2020-02-04T22:26:25.539Z,1580855185.539 [Reporter](INFO): platform_buoyancy_position 240.504028 cc
2020-02-04T22:26:25.951Z,1580855185.951 [Reporter](INFO): platform_buoyancy_position 246.816147 cc
2020-02-04T22:26:26.354Z,1580855186.354 [Reporter](INFO): platform_buoyancy_position 251.248047 cc
2020-02-04T22:26:26.743Z,1580855186.743 [Reporter](INFO): platform_buoyancy_position 255.814224 cc
2020-02-04T22:26:27.166Z,1580855187.166 [Reporter](INFO): platform_buoyancy_position 261.857727 cc
2020-02-04T22:26:27.570Z,1580855187.570 [Reporter](INFO): platform_buoyancy_position 267.632629 cc
2020-02-04T22:26:27.978Z,1580855187.978 [Reporter](INFO): platform_buoyancy_position 272.870331 cc
2020-02-04T22:26:28.386Z,1580855188.386 [Reporter](INFO): platform_buoyancy_position 279.048126 cc
2020-02-04T22:26:28.779Z,1580855188.779 [Reporter](INFO): platform_buoyancy_position 283.345734 cc
2020-02-04T22:26:29.195Z,1580855189.195 [Reporter](INFO): platform_buoyancy_position 287.777649 cc
2020-02-04T22:26:29.603Z,1580855189.603 [Reporter](INFO): platform_buoyancy_position 294.089722 cc
2020-02-04T22:26:30.015Z,1580855190.015 [Reporter](INFO): platform_buoyancy_position 298.521637 cc
2020-02-04T22:26:30.428Z,1580855190.428 [Reporter](INFO): platform_buoyancy_position 304.968048 cc
2020-02-04T22:26:30.806Z,1580855190.806 [Reporter](INFO): platform_buoyancy_position 309.265625 cc
2020-02-04T22:26:31.242Z,1580855191.242 [Reporter](INFO): platform_buoyancy_position 315.712036 cc
2020-02-04T22:26:31.531Z,1580855191.531 [NAL9602](INFO): SBD MO Status=0, MOMSN=10322, MT Status=0, MTMSN=0
2020-02-04T22:26:31.531Z,1580855191.531 [NAL9602](INFO): No messages in MT queue
2020-02-04T22:26:31.658Z,1580855191.658 [Reporter](INFO): platform_buoyancy_position 320.009644 cc
2020-02-04T22:26:32.071Z,1580855192.071 [Reporter](INFO): platform_buoyancy_position 326.321716 cc
2020-02-04T22:26:32.420Z,1580855192.420 [Reporter](INFO): platform_buoyancy_position 330.753662 cc
2020-02-04T22:26:32.799Z,1580855192.799 [Reporter](INFO): platform_buoyancy_position 335.051270 cc
2020-02-04T22:26:33.219Z,1580855193.219 [Reporter](INFO): platform_buoyancy_position 341.363342 cc
2020-02-04T22:26:33.634Z,1580855193.634 [Reporter](INFO): platform_buoyancy_position 345.795227 cc
2020-02-04T22:26:34.026Z,1580855194.026 [Reporter](INFO): platform_buoyancy_position 352.107361 cc
2020-02-04T22:26:34.416Z,1580855194.416 [Reporter](INFO): platform_buoyancy_position 356.539246 cc
2020-02-04T22:26:34.596Z,1580855194.596 [CommandLine](IMPORTANT): got command report clear
2020-02-04T22:26:39.227Z,1580855199.227 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-04T22:26:39.227Z,1580855199.227 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2020-02-04T22:26:42.786Z,1580855202.786 [DataOverHttps](INFO): Sending 372 bytes from file Logs/20200204T214949/Express0017.lzma
2020-02-04T22:26:44.778Z,1580855204.778 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214949/Express0017.lzma.bak
2020-02-04T22:26:44.778Z,1580855204.778 [DataOverHttps](INFO): SBD MOMSN=12219287
2020-02-04T22:26:46.107Z,1580855206.107 [DefaultWithUndock:CheckIn:Read_Iridium] Stopped
2020-02-04T22:26:46.107Z,1580855206.107 [DefaultWithUndock:CheckIn:C.Wait] Running Loop=1
2020-02-04T22:26:46.107Z,1580855206.107 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-02-04T22:27:02.224Z,1580855222.224 [NAL9602](INFO): Not Powering down - fast GPS
2020-02-04T22:29:55.214Z,1580855395.214 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-02-04T22:29:55.214Z,1580855395.214 [RDI_Pathfinder](ERROR): Failed to parse:
:BS,-32768,-32768,
2020-02-04T22:30:01.268Z,1580855401.268 [RDI_Pathfinder](ERROR): only read 3 of 4 data items
2020-02-04T22:30:01.268Z,1580855401.268 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00
2020-02-04T22:31:18.853Z,1580855478.853 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2020-02-04T22:31:18.853Z,1580855478.853 [RDI_Pathfinder](ERROR): Failed to parse:
:BS,32768,-32768,V
2020-02-04T22:31:21.240Z,1580855481.240 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for BIT error
2020-02-04T22:31:21.240Z,1580855481.240 [RDI_Pathfinder](ERROR): Failed to parse:
:TS5443485,35.0, -0.1,   0.0,1448.9,  0
2020-02-04T22:31:46.768Z,1580855506.768 [DefaultWithUndock:CheckIn:C.Wait](INFO): Done Waiting.
2020-02-04T22:31:46.768Z,1580855506.768 [DefaultWithUndock:CheckIn:C.Wait] Stopped
2020-02-04T22:31:46.768Z,1580855506.768 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-02-04T22:31:46.768Z,1580855506.768 [DefaultWithUndock:CheckIn:D] Running Loop=1
2020-02-04T22:31:47.166Z,1580855507.166 [DefaultWithUndock:CheckIn:D] Stopped
2020-02-04T22:31:47.166Z,1580855507.166 [DefaultWithUndock:CheckIn:E] Running Loop=1
2020-02-04T22:31:47.528Z,1580855507.528 [DefaultWithUndock:CheckIn:E](IMPORTANT): Default mission has been running for 22.760824 min 
2020-02-04T22:31:47.529Z,1580855507.529 [DefaultWithUndock:CheckIn:E] Stopped
2020-02-04T22:31:47.529Z,1580855507.529 [DefaultWithUndock:CheckIn](INFO): Completed DefaultWithUndock:CheckIn
2020-02-04T22:31:47.529Z,1580855507.529 [DefaultWithUndock:CheckIn] Stopped
2020-02-04T22:31:47.529Z,1580855507.529 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:CheckIn
2020-02-04T22:31:47.529Z,1580855507.529 [DefaultWithUndock:CheckIn](INFO): Running loop #4
2020-02-04T22:31:47.529Z,1580855507.529 [DefaultWithUndock:CheckIn] Running Loop=4
2020-02-04T22:31:47.529Z,1580855507.529 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:CheckIn
2020-02-04T22:31:47.529Z,1580855507.529 [DefaultWithUndock:CheckIn:Read_GPS] Running Loop=1
2020-02-04T22:31:49.521Z,1580855509.521 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223149.00,A,4131.45843,N,07040.31315,W,0.117,318.66,040220,,,D*70
2020-02-04T22:31:49.523Z,1580855509.523 [NAL9602](INFO): GPS fix at 20200204T223149: (41.524307, -70.671886)
2020-02-04T22:31:49.593Z,1580855509.593 [DefaultWithUndock:CheckIn:Read_GPS] Stopped
2020-02-04T22:31:49.593Z,1580855509.593 [DefaultWithUndock:CheckIn:Read_Iridium] Running Loop=1
2020-02-04T22:31:57.016Z,1580855517.016 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20200204T214949/Courier0019.lzma
2020-02-04T22:31:59.022Z,1580855519.022 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214949/Courier0019.lzma.bak
2020-02-04T22:31:59.022Z,1580855519.022 [DataOverHttps](INFO): SBD MOMSN=12219302
2020-02-04T22:32:05.566Z,1580855525.566 [RDI_Pathfinder](ERROR): Failed to parse:
:RA,  0.00,   0.00,   0.00,   0.00,   0.00
2020-02-04T22:32:10.790Z,1580855530.790 [NAL9602](INFO): SBD MO Status=0, MOMSN=10323, MT Status=0, MTMSN=0
2020-02-04T22:32:10.791Z,1580855530.791 [NAL9602](INFO): No messages in MT queue
2020-02-04T22:32:16.192Z,1580855536.192 [DataOverHttps](INFO): Sending 165 bytes from file Logs/20200204T214949/Express0020.lzma
2020-02-04T22:32:18.198Z,1580855538.198 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214949/Express0020.lzma.bak
2020-02-04T22:32:18.198Z,1580855538.198 [DataOverHttps](INFO): SBD MOMSN=12219305
2020-02-04T22:32:19.312Z,1580855539.312 [DefaultWithUndock:CheckIn:Read_Iridium] Stopped
2020-02-04T22:32:19.312Z,1580855539.312 [DefaultWithUndock:CheckIn:C.Wait] Running Loop=1
2020-02-04T22:32:19.312Z,1580855539.312 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-02-04T22:32:41.493Z,1580855561.493 [NAL9602](INFO): Not Powering down - fast GPS
2020-02-04T22:37:14.249Z,1580855834.249 [RDI_Pathfinder](ERROR): Failed to parse:
:SA,   +0.00,   +0.00,  0.00
2020-02-04T22:37:19.897Z,1580855839.897 [DefaultWithUndock:CheckIn:C.Wait](INFO): Done Waiting.
2020-02-04T22:37:19.898Z,1580855839.898 [DefaultWithUndock:CheckIn:C.Wait] Stopped
2020-02-04T22:37:19.898Z,1580855839.898 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-02-04T22:37:19.898Z,1580855839.898 [DefaultWithUndock:CheckIn:D] Running Loop=1
2020-02-04T22:37:20.297Z,1580855840.297 [DefaultWithUndock:CheckIn:D] Stopped
2020-02-04T22:37:20.297Z,1580855840.297 [DefaultWithUndock:CheckIn:E] Running Loop=1
2020-02-04T22:37:20.688Z,1580855840.688 [DefaultWithUndock:CheckIn:E](IMPORTANT): Default mission has been running for 28.312998 min 
2020-02-04T22:37:20.688Z,1580855840.688 [DefaultWithUndock:CheckIn:E] Stopped
2020-02-04T22:37:20.689Z,1580855840.689 [DefaultWithUndock:CheckIn](INFO): Completed DefaultWithUndock:CheckIn
2020-02-04T22:37:20.689Z,1580855840.689 [DefaultWithUndock:CheckIn] Stopped
2020-02-04T22:37:20.689Z,1580855840.689 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:CheckIn
2020-02-04T22:37:20.689Z,1580855840.689 [DefaultWithUndock:CheckIn](INFO): Running loop #5
2020-02-04T22:37:20.689Z,1580855840.689 [DefaultWithUndock:CheckIn] Running Loop=5
2020-02-04T22:37:20.689Z,1580855840.689 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:CheckIn
2020-02-04T22:37:20.689Z,1580855840.689 [DefaultWithUndock:CheckIn:Read_GPS] Running Loop=1
2020-02-04T22:37:22.690Z,1580855842.690 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223722.00,A,4131.45952,N,07040.31362,W,0.117,318.66,040220,,,D*7A
2020-02-04T22:37:22.692Z,1580855842.692 [NAL9602](INFO): GPS fix at 20200204T223722: (41.524325, -70.671894)
2020-02-04T22:37:22.716Z,1580855842.716 [DefaultWithUndock:CheckIn:Read_GPS] Stopped
2020-02-04T22:37:22.716Z,1580855842.716 [DefaultWithUndock:CheckIn:Read_Iridium] Running Loop=1
2020-02-04T22:37:30.344Z,1580855850.344 [DataOverHttps](INFO): Sending 72 bytes from file Logs/20200204T214949/Courier0022.lzma
2020-02-04T22:37:32.350Z,1580855852.350 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214949/Courier0022.lzma.bak
2020-02-04T22:37:32.350Z,1580855852.350 [DataOverHttps](INFO): SBD MOMSN=12219362
2020-02-04T22:37:44.904Z,1580855864.904 [NAL9602](INFO): SBD MO Status=0, MOMSN=10324, MT Status=0, MTMSN=0
2020-02-04T22:37:44.904Z,1580855864.904 [NAL9602](INFO): No messages in MT queue
2020-02-04T22:37:52.140Z,1580855872.140 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20200204T214949/Express0023.lzma
2020-02-04T22:37:54.150Z,1580855874.150 [DataOverHttps](INFO): Moved sent file to Logs/20200204T214949/Express0023.lzma.bak
2020-02-04T22:37:54.150Z,1580855874.150 [DataOverHttps](INFO): SBD MOMSN=12219365
2020-02-04T22:37:55.467Z,1580855875.467 [DefaultWithUndock:CheckIn:Read_Iridium] Stopped
2020-02-04T22:37:55.467Z,1580855875.467 [DefaultWithUndock:CheckIn:C.Wait] Running Loop=1
2020-02-04T22:37:55.467Z,1580855875.467 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2020-02-04T22:38:15.632Z,1580855895.632 [NAL9602](INFO): Not Powering down - fast GPS
2020-02-04T22:38:36.382Z,1580855916.382 [CommandLine](IMPORTANT): got command ibit
2020-02-04T22:38:36.697Z,1580855916.697 [IBIT](IMPORTANT): Beginning Initiated BIT
2020-02-04T22:38:36.697Z,1580855916.697 [IBIT](IMPORTANT): Beginning control surface checks.
2020-02-04T22:38:36.704Z,1580855916.704 [CBIT](IMPORTANT): Beginning ground fault scan
2020-02-04T22:38:38.256Z,1580855918.256 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223838.00,A,4131.46023,N,07040.31356,W,0.039,318.66,040220,,,D*78
2020-02-04T22:38:38.258Z,1580855918.258 [NAL9602](INFO): GPS fix at 20200204T223838: (41.524337, -70.671893)
2020-02-04T22:38:47.595Z,1580855927.595 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.009215
CHAN A1 (24V): -0.028376
CHAN A2 (12V): -0.007414
CHAN A3 (5V): -0.001772
CHAN B0 (3.3V): 0.000346
CHAN B1 (3.15aV): 0.000376
CHAN B2 (3.15bV): 0.000192
CHAN B3 (GND): 0.002116
OPEN: 0.005732
Full Scale Calc: 4.765 mA, -1.589 mA
2020-02-04T22:39:00.489Z,1580855940.489 [NAL9602](INFO): SBD MO Status=0, MOMSN=10325, MT Status=0, MTMSN=0
2020-02-04T22:39:00.489Z,1580855940.489 [NAL9602](INFO): No messages in MT queue
2020-02-04T22:39:01.695Z,1580855941.695 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223901.00,A,4131.46048,N,07040.31362,W,0.097,318.66,040220,,,D*7D
2020-02-04T22:39:01.710Z,1580855941.710 [NAL9602](INFO): GPS fix at 20200204T223901: (41.524341, -70.671894)
2020-02-04T22:39:04.529Z,1580855944.529 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223904.00,A,4131.46059,N,07040.31371,W,0.019,318.66,040220,,,D*7C
2020-02-04T22:39:04.531Z,1580855944.531 [NAL9602](INFO): GPS fix at 20200204T223904: (41.524343, -70.671895)
2020-02-04T22:39:07.758Z,1580855947.758 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223907.00,A,4131.46066,N,07040.31381,W,0.253,318.66,040220,,,D*70
2020-02-04T22:39:07.760Z,1580855947.760 [NAL9602](INFO): GPS fix at 20200204T223907: (41.524344, -70.671897)
2020-02-04T22:39:10.585Z,1580855950.585 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223910.00,A,4131.46081,N,07040.31375,W,0.039,318.66,040220,,,D*7A
2020-02-04T22:39:10.587Z,1580855950.587 [NAL9602](INFO): GPS fix at 20200204T223910: (41.524347, -70.671896)
2020-02-04T22:39:13.416Z,1580855953.416 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223913.00,A,4131.46122,N,07040.31381,W,0.019,318.66,040220,,,D*78
2020-02-04T22:39:13.418Z,1580855953.418 [NAL9602](INFO): GPS fix at 20200204T223913: (41.524354, -70.671897)
2020-02-04T22:39:16.649Z,1580855956.649 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223916.00,A,4131.46162,N,07040.31410,W,0.039,318.66,040220,,,D*74
2020-02-04T22:39:16.651Z,1580855956.651 [NAL9602](INFO): GPS fix at 20200204T223916: (41.524360, -70.671902)
2020-02-04T22:39:19.482Z,1580855959.482 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223919.00,A,4131.46163,N,07040.31414,W,0.019,318.66,040220,,,D*7C
2020-02-04T22:39:19.484Z,1580855959.484 [NAL9602](INFO): GPS fix at 20200204T223919: (41.524361, -70.671902)
2020-02-04T22:39:22.714Z,1580855962.714 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,223922.00,A,4131.46156,N,07040.31398,W,0.019,318.66,040220,,,D*71
2020-02-04T22:39:22.716Z,1580855962.716 [NAL9602](INFO): GPS fix at 20200204T223922: (41.524359, -70.671900)
2020-02-04T22:39:23.166Z,1580855963.166 [IBIT](IMPORTANT): Communications Status:
Fix Status: 1
Iridium Signal Strength: 5
Latitude: 41.524361 Longitude: -70.671898
2020-02-04T22:39:23.542Z,1580855963.542 [IBIT](IMPORTANT): Battery Status:
Battery Charge (AH): 0.000000
Voltage: 15.263000
2020-02-04T22:39:23.543Z,1580855963.543 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah
2020-02-04T22:39:23.543Z,1580855963.543 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V
2020-02-04T22:39:23.949Z,1580855963.949 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 %
2020-02-04T22:39:23.949Z,1580855963.949 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi
2020-02-04T22:39:23.950Z,1580855963.950 [IBIT](IMPORTANT): Pressure:10.143647 PSI
2020-02-04T22:39:23.950Z,1580855963.950 [IBIT](IMPORTANT): Humidity:6.989378 %
2020-02-04T22:39:24.378Z,1580855964.378 [IBIT](IMPORTANT): Vehicle Pitch:-10.535234 degrees
2020-02-04T22:39:24.378Z,1580855964.378 [IBIT](IMPORTANT): Vehicle  Roll:-1.013488 degrees
2020-02-04T22:39:24.379Z,1580855964.379 [IBIT](IMPORTANT): Vehicle  Heading:228.415436 degrees
2020-02-04T22:39:24.761Z,1580855964.761 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m
2020-02-04T22:39:24.761Z,1580855964.761 [IBIT](IMPORTANT): buoyancyNeutral: 105.000000 cc
2020-02-04T22:39:24.762Z,1580855964.762 [IBIT](IMPORTANT): massDefault: 0.500000 cm
2020-02-04T22:39:24.762Z,1580855964.762 [IBIT](IMPORTANT): stopDepth: 215.000000 m
2020-02-04T22:39:24.762Z,1580855964.762 [IBIT](IMPORTANT): abortDepth: 255.000000 m
2020-02-04T22:39:24.762Z,1580855964.762 [IBIT](IMPORTANT): IBIT PASSED
2020-02-04T22:39:55.037Z,1580855995.037 [NAL9602](INFO): Not Powering down - fast GPS
2020-02-04T22:41:37.714Z,1580856097.714 [DataOverHttps](IMPORTANT): SBD MTMSN=20200204T224136
2020-02-04T22:41:45.356Z,1580856105.356 [DataOverHttps](INFO): Received command:restart app
2020-02-04T22:41:45.373Z,1580856105.373 [CommandLine](IMPORTANT): got command restart application
2020-02-04T22:41:46.377Z,1580856106.377 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-04T22:41:46.377Z,1580856106.377 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:46.392Z,1580856106.392 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2020-02-04T22:41:46.393Z,1580856106.393 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:46.393Z,1580856106.393 [CommandLine](INFO): Join timeout helper Thread ID is 1379
2020-02-04T22:41:46.394Z,1580856106.394 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2020-02-04T22:41:46.394Z,1580856106.394 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:46.394Z,1580856106.394 [NavChartDb](INFO): Join timeout helper Thread ID is 1380
2020-02-04T22:41:46.777Z,1580856106.777 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-04T22:41:46.777Z,1580856106.777 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:46.793Z,1580856106.793 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2020-02-04T22:41:46.793Z,1580856106.793 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:46.794Z,1580856106.794 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 1381
2020-02-04T22:41:46.881Z,1580856106.881 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-04T22:41:46.881Z,1580856106.881 [WetLabsSeaOWL_UV_A](INFO): Powering down
2020-02-04T22:41:46.882Z,1580856106.882 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:46.897Z,1580856106.897 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2020-02-04T22:41:46.897Z,1580856106.897 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:46.897Z,1580856106.897 [Radio_Surface](INFO): Join timeout helper Thread ID is 1384
2020-02-04T22:41:47.085Z,1580856107.085 [Radio_Surface](INFO): Powering down
2020-02-04T22:41:47.086Z,1580856107.086 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-04T22:41:47.086Z,1580856107.086 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:47.089Z,1580856107.089 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2020-02-04T22:41:47.089Z,1580856107.089 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:47.089Z,1580856107.089 [DataOverHttps](INFO): Join timeout helper Thread ID is 1385
2020-02-04T22:41:47.361Z,1580856107.361 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-04T22:41:47.364Z,1580856107.364 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:47.365Z,1580856107.365 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2020-02-04T22:41:47.366Z,1580856107.366 [logger ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:47.366Z,1580856107.366 [logger](INFO): Join timeout helper Thread ID is 1386
2020-02-04T22:41:47.377Z,1580856107.377 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-04T22:41:47.377Z,1580856107.377 [logger ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:47.391Z,1580856107.391 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2020-02-04T22:41:47.391Z,1580856107.391 [CommandLine ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:47.391Z,1580856107.391 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2020-02-04T22:41:47.391Z,1580856107.391 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:47.392Z,1580856107.392 [controlThread](INFO): Join timeout helper Thread ID is 1387
2020-02-04T22:41:47.725Z,1580856107.725 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2020-02-04T22:41:47.725Z,1580856107.725 [controlThread](DEBUG): Uninitializing ControlThread
2020-02-04T22:41:47.725Z,1580856107.725 [AHRS_M2](INFO): Powering down
2020-02-04T22:41:47.797Z,1580856107.797 [DDM](INFO): Powering down
2020-02-04T22:41:47.965Z,1580856107.965 [DUSBL_Hydroid](INFO): Powering down
2020-02-04T22:41:48.057Z,1580856108.057 [Micromodem](INFO): Powering down
2020-02-04T22:41:48.153Z,1580856108.153 [NAL9602](INFO): Powering down
2020-02-04T22:41:48.225Z,1580856108.225 [RDI_Pathfinder](INFO): Powering down
2020-02-04T22:41:48.226Z,1580856108.226 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2020-02-04T22:41:48.227Z,1580856108.227 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2020-02-04T22:41:48.227Z,1580856108.227 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2020-02-04T22:41:48.228Z,1580856108.228 [MissionManager](INFO): Uninitializing Mission DefaultWithUndock
2020-02-04T22:41:48.228Z,1580856108.228 [DefaultWithUndock] Stopped
2020-02-04T22:41:48.228Z,1580856108.228 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock
2020-02-04T22:41:48.228Z,1580856108.228 [DefaultWithUndock:C.GoToSurface] Stopped
2020-02-04T22:41:48.228Z,1580856108.228 [DefaultWithUndock:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2020-02-04T22:41:48.228Z,1580856108.228 [DefaultWithUndock:CheckIn] Stopped
2020-02-04T22:41:48.229Z,1580856108.229 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:CheckIn
2020-02-04T22:41:48.229Z,1580856108.229 [DefaultWithUndock:CheckIn:C.Wait] Stopped
2020-02-04T22:41:48.229Z,1580856108.229 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2020-02-04T22:41:48.232Z,1580856108.232 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2020-02-04T22:41:48.232Z,1580856108.232 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2020-02-04T22:41:48.232Z,1580856108.232 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2020-02-04T22:41:48.233Z,1580856108.233 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2020-02-04T22:41:48.233Z,1580856108.233 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2020-02-04T22:41:48.233Z,1580856108.233 [BuoyancyServo](INFO): Powering down
2020-02-04T22:41:48.245Z,1580856108.245 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2020-02-04T22:41:48.245Z,1580856108.245 [ElevatorServo](INFO): Powering down
2020-02-04T22:41:48.246Z,1580856108.246 [MassServo](DEBUG): Uninitialize Mass Servo.
2020-02-04T22:41:48.246Z,1580856108.246 [MassServo](INFO): Powering down
2020-02-04T22:41:48.246Z,1580856108.246 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2020-02-04T22:41:48.247Z,1580856108.247 [RudderServo](INFO): Powering down
2020-02-04T22:41:48.247Z,1580856108.247 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2020-02-04T22:41:48.247Z,1580856108.247 [ThrusterServo](INFO): Powering down
2020-02-04T22:41:48.248Z,1580856108.248 [SBIT](DEBUG): Uninitialize SBIT Component.
2020-02-04T22:41:48.249Z,1580856108.249 [IBIT](DEBUG): Uninitialize IBIT Component.
2020-02-04T22:41:48.249Z,1580856108.249 [CBIT](DEBUG): Uninitialize CBIT Component.
2020-02-04T22:41:48.249Z,1580856108.249 [CBIT](DEBUG): Powering off loads.
2020-02-04T22:41:48.260Z,1580856108.260 [CBIT](DEBUG): Disabling WDT.
2020-02-04T22:41:48.272Z,1580856108.272 [CBIT](DEBUG): Opening all GF detection circuits.
2020-02-04T22:41:48.273Z,1580856108.273 [controlThread ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:48.325Z,1580856108.325 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:48.336Z,1580856108.336 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:48.378Z,1580856108.378 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:48.435Z,1580856108.435 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2020-02-04T22:41:48.499Z,1580856108.499 [logger ThreadHandler](INFO): Thread cancelled.