2019-02-21T23:54:15.231Z,1550793255.231 [Supervisor](DEBUG): Initializing supervisor.
2019-02-21T23:54:15.233Z,1550793255.233 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-02-21T23:54:15.234Z,1550793255.234 [SyncHandler](INFO): Protected caller Thread ID is 1738
2019-02-21T23:54:15.234Z,1550793255.234 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-02-21T23:54:15.235Z,1550793255.235 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-02-21T23:54:15.235Z,1550793255.235 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 1739
2019-02-21T23:54:15.238Z,1550793255.238 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-02-21T23:54:15.290Z,1550793255.290 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-02-21T23:54:15.290Z,1550793255.290 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-02-21T23:54:15.291Z,1550793255.291 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 1740
2019-02-21T23:54:15.292Z,1550793255.292 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-02-21T23:54:15.293Z,1550793255.293 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-02-21T23:54:15.293Z,1550793255.293 [logger ThreadHandler](INFO): Protected caller Thread ID is 1741
2019-02-21T23:54:15.295Z,1550793255.295 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-02-21T23:54:15.295Z,1550793255.295 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-02-21T23:54:15.297Z,1550793255.297 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-02-21T23:54:15.704Z,1550793255.704 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-02-21T23:54:15.704Z,1550793255.704 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-02-21T23:54:15.803Z,1550793255.803 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-02-21T23:54:15.804Z,1550793255.804 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-02-21T23:54:16.123Z,1550793256.123 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-02-21T23:54:16.123Z,1550793256.123 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-02-21T23:54:16.263Z,1550793256.263 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-02-21T23:54:16.263Z,1550793256.263 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-02-21T23:54:16.454Z,1550793256.454 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-02-21T23:54:16.454Z,1550793256.454 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-02-21T23:54:16.911Z,1550793256.911 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-02-21T23:54:16.911Z,1550793256.911 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-02-21T23:54:17.115Z,1550793257.115 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-02-21T23:54:17.115Z,1550793257.115 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-02-21T23:54:17.260Z,1550793257.260 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-02-21T23:54:17.261Z,1550793257.261 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-02-21T23:54:17.453Z,1550793257.453 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-02-21T23:54:17.454Z,1550793257.454 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-02-21T23:54:17.551Z,1550793257.551 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-02-21T23:54:17.552Z,1550793257.552 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-02-21T23:54:17.861Z,1550793257.861 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-02-21T23:54:17.861Z,1550793257.861 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-02-21T23:54:17.943Z,1550793257.943 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-02-21T23:54:18.047Z,1550793258.047 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-02-21T23:54:18.047Z,1550793258.047 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-02-21T23:54:18.531Z,1550793258.531 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-02-21T23:54:18.532Z,1550793258.532 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-02-21T23:54:18.923Z,1550793258.923 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-02-21T23:54:18.925Z,1550793258.925 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/
2019-02-21T23:54:18.926Z,1550793258.926 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/vehicle.cfg
2019-02-21T23:54:19.133Z,1550793259.133 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Control.cfg
2019-02-21T23:54:19.233Z,1550793259.233 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/BIT.cfg
2019-02-21T23:54:19.332Z,1550793259.332 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Battery.cfg
2019-02-21T23:54:19.558Z,1550793259.558 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-02-21T23:54:19.559Z,1550793259.559 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Simulator.cfg
2019-02-21T23:54:19.645Z,1550793259.645 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Navigation.cfg
2019-02-21T23:54:19.739Z,1550793259.739 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/logger.cfg
2019-02-21T23:54:19.837Z,1550793259.837 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/secure.cfg
2019-02-21T23:54:19.921Z,1550793259.921 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Servo.cfg
2019-02-21T23:54:20.110Z,1550793260.110 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Sensor.cfg
2019-02-21T23:54:20.631Z,1550793260.631 [Supervisor](INFO): Opening Config file at: Config/lrauv-whoidhs/Science.cfg
2019-02-21T23:54:20.997Z,1550793260.997 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-whoidhs/LOGIN/
2019-02-21T23:54:20.998Z,1550793260.998 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-02-21T23:54:20.999Z,1550793260.999 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-02-21T23:54:21.452Z,1550793261.452 [DataOverHttps] Loaded
2019-02-21T23:54:21.452Z,1550793261.452 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2019-02-21T23:54:21.467Z,1550793261.467 [Depth_Keller] Loaded
2019-02-21T23:54:21.467Z,1550793261.467 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-02-21T23:54:21.472Z,1550793261.472 [DropWeight] Loaded
2019-02-21T23:54:21.472Z,1550793261.472 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2019-02-21T23:54:21.520Z,1550793261.520 [DUSBL_Hydroid] Loaded
2019-02-21T23:54:21.520Z,1550793261.520 [ComponentRegistry](DEBUG): SyncComponent "DUSBL_Hydroid" handled in the control thread.
2019-02-21T23:54:21.560Z,1550793261.560 [Micromodem] Loaded
2019-02-21T23:54:21.560Z,1550793261.560 [ComponentRegistry](DEBUG): SyncComponent "Micromodem" handled in the control thread.
2019-02-21T23:54:21.656Z,1550793261.656 [NAL9602] Loaded
2019-02-21T23:54:21.657Z,1550793261.657 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-02-21T23:54:21.672Z,1550793261.672 [Onboard] Loaded
2019-02-21T23:54:21.672Z,1550793261.672 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-02-21T23:54:21.682Z,1550793261.682 [Radio_Surface] Loaded
2019-02-21T23:54:21.683Z,1550793261.683 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-02-21T23:54:21.684Z,1550793261.684 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407534E0
2019-02-21T23:54:21.684Z,1550793261.684 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1820
2019-02-21T23:54:21.712Z,1550793261.712 [RDI_Pathfinder] Loaded
2019-02-21T23:54:21.713Z,1550793261.713 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2019-02-21T23:54:21.734Z,1550793261.734 [RDI_PathfinderUp] Loaded
2019-02-21T23:54:21.735Z,1550793261.735 [ComponentRegistry](DEBUG): SyncComponent "RDI_PathfinderUp" handled in the control thread.
2019-02-21T23:54:23.520Z,1550793263.520 [BPC1] Loaded
2019-02-21T23:54:23.520Z,1550793263.520 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-02-21T23:54:23.520Z,1550793263.520 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-02-21T23:54:23.521Z,1550793263.521 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-02-21T23:54:23.534Z,1550793263.534 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-02-21T23:54:23.534Z,1550793263.534 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-02-21T23:54:23.640Z,1550793263.640 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-02-21T23:54:23.641Z,1550793263.641 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-02-21T23:54:23.699Z,1550793263.699 [DeadReckonUsingSpeedCalculator] Loaded
2019-02-21T23:54:23.699Z,1550793263.699 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-02-21T23:54:23.757Z,1550793263.757 [DeadReckonWithRespectToSeafloor] Loaded
2019-02-21T23:54:23.758Z,1550793263.758 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread.
2019-02-21T23:54:23.773Z,1550793263.773 [NavChart] Loaded
2019-02-21T23:54:23.774Z,1550793263.774 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-02-21T23:54:23.778Z,1550793263.778 [UniversalFixResidualReporter] Loaded
2019-02-21T23:54:23.778Z,1550793263.778 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-02-21T23:54:23.778Z,1550793263.778 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-02-21T23:54:23.779Z,1550793263.779 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-02-21T23:54:23.881Z,1550793263.881 [BuoyancyServo] Loaded
2019-02-21T23:54:23.882Z,1550793263.882 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-02-21T23:54:23.897Z,1550793263.897 [ElevatorServo] Loaded
2019-02-21T23:54:23.897Z,1550793263.897 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-02-21T23:54:23.912Z,1550793263.912 [MassServo] Loaded
2019-02-21T23:54:23.912Z,1550793263.912 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-02-21T23:54:23.927Z,1550793263.927 [RudderServo] Loaded
2019-02-21T23:54:23.928Z,1550793263.928 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-02-21T23:54:23.942Z,1550793263.942 [ThrusterServo] Loaded
2019-02-21T23:54:23.942Z,1550793263.942 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-02-21T23:54:23.943Z,1550793263.943 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-02-21T23:54:23.943Z,1550793263.943 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-02-21T23:54:24.120Z,1550793264.120 [Aanderaa_O2] Loaded
2019-02-21T23:54:24.120Z,1550793264.120 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2019-02-21T23:54:24.204Z,1550793264.204 [CTD_NeilBrown] Loaded
2019-02-21T23:54:24.204Z,1550793264.204 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2019-02-21T23:54:24.205Z,1550793264.205 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 408624E0
2019-02-21T23:54:24.206Z,1550793264.206 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 1821
2019-02-21T23:54:24.250Z,1550793264.250 [WetLabsSeaOWL_UV_A] Loaded
2019-02-21T23:54:24.250Z,1550793264.250 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2019-02-21T23:54:24.251Z,1550793264.251 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 408924E0
2019-02-21T23:54:24.251Z,1550793264.251 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 1822
2019-02-21T23:54:24.252Z,1550793264.252 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-02-21T23:54:24.252Z,1550793264.252 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-02-21T23:54:24.490Z,1550793264.490 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-02-21T23:54:24.491Z,1550793264.491 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-02-21T23:54:24.533Z,1550793264.533 [DepthRateCalculator] Loaded
2019-02-21T23:54:24.533Z,1550793264.533 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-02-21T23:54:24.539Z,1550793264.539 [PitchRateCalculator] Loaded
2019-02-21T23:54:24.539Z,1550793264.539 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-02-21T23:54:24.551Z,1550793264.551 [SpeedCalculator] Loaded
2019-02-21T23:54:24.552Z,1550793264.552 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-02-21T23:54:24.572Z,1550793264.572 [TempGradientCalculator] Loaded
2019-02-21T23:54:24.572Z,1550793264.572 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-02-21T23:54:24.578Z,1550793264.578 [YawRateCalculator] Loaded
2019-02-21T23:54:24.578Z,1550793264.578 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-02-21T23:54:24.618Z,1550793264.618 [ElevatorOffsetCalculator] Loaded
2019-02-21T23:54:24.618Z,1550793264.618 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-02-21T23:54:24.619Z,1550793264.619 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-02-21T23:54:24.619Z,1550793264.619 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-02-21T23:54:24.753Z,1550793264.753 [SBIT](DEBUG): Construct Startup Built In Test.
2019-02-21T23:54:24.775Z,1550793264.775 [SBIT] Loaded
2019-02-21T23:54:24.775Z,1550793264.775 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-02-21T23:54:24.776Z,1550793264.776 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-02-21T23:54:24.788Z,1550793264.788 [IBIT] Loaded
2019-02-21T23:54:24.788Z,1550793264.788 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-02-21T23:54:24.791Z,1550793264.791 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-02-21T23:54:24.930Z,1550793264.930 [CBIT] Loaded
2019-02-21T23:54:24.930Z,1550793264.930 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-02-21T23:54:24.930Z,1550793264.930 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-02-21T23:54:24.931Z,1550793264.931 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-02-21T23:54:24.995Z,1550793264.995 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-02-21T23:54:24.995Z,1550793264.995 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-02-21T23:54:25.092Z,1550793265.092 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-02-21T23:54:25.093Z,1550793265.093 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-02-21T23:54:25.162Z,1550793265.161 [VerticalControl](DEBUG): Construct VerticalControl.
2019-02-21T23:54:25.244Z,1550793265.244 [VerticalControl] Loaded
2019-02-21T23:54:25.244Z,1550793265.244 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-02-21T23:54:25.245Z,1550793265.245 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-02-21T23:54:25.302Z,1550793265.302 [HorizontalControl] Loaded
2019-02-21T23:54:25.303Z,1550793265.303 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-02-21T23:54:25.303Z,1550793265.303 [SpeedControl](DEBUG): Construct SpeedControl.
2019-02-21T23:54:25.305Z,1550793265.305 [SpeedControl] Loaded
2019-02-21T23:54:25.305Z,1550793265.305 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-02-21T23:54:25.306Z,1550793265.306 [LoopControl](DEBUG): Construct LoopControl.
2019-02-21T23:54:25.306Z,1550793265.306 [LoopControl] Loaded
2019-02-21T23:54:25.307Z,1550793265.307 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-02-21T23:54:25.307Z,1550793265.307 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-02-21T23:54:25.308Z,1550793265.308 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-02-21T23:54:25.391Z,1550793265.391 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-02-21T23:54:25.395Z,1550793265.395 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-02-21T23:54:25.396Z,1550793265.396 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-02-21T23:54:25.402Z,1550793265.402 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-02-21T23:54:25.404Z,1550793265.404 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A4F4E0
2019-02-21T23:54:25.404Z,1550793265.404 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1823
2019-02-21T23:54:25.409Z,1550793265.409 [Supervisor](INFO): Main Thread ID is 1737
2019-02-21T23:54:25.409Z,1550793265.409 [Supervisor](DEBUG): Running supervisor.
2019-02-21T23:54:25.409Z,1550793265.409 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1824
2019-02-21T23:54:25.411Z,1550793265.411 [controlThread ThreadHandler](INFO): Handler Thread ID is 1825
2019-02-21T23:54:25.412Z,1550793265.412 [controlThread](DEBUG): Initializing ControlThread
2019-02-21T23:54:25.420Z,1550793265.420 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-02-21T23:54:25.421Z,1550793265.421 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-02-21T23:54:25.422Z,1550793265.422 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-02-21T23:54:25.423Z,1550793265.423 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-02-21T23:54:25.423Z,1550793265.423 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-02-21T23:54:25.423Z,1550793265.423 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-02-21T23:54:25.424Z,1550793265.424 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-02-21T23:54:25.424Z,1550793265.424 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-02-21T23:54:25.425Z,1550793265.425 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-02-21T23:54:25.425Z,1550793265.425 [SBIT](INFO): Initialize SBIT Component.
2019-02-21T23:54:25.426Z,1550793265.426 [SBIT](IMPORTANT): git: 2019-02-11-13-g62924c4
2019-02-21T23:54:25.426Z,1550793265.426 [SBIT](INFO): git hash: 62924c492e86bb9d7cd72440302a80a745358b26
2019-02-21T23:54:25.426Z,1550793265.426 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-02-21T23:54:25.426Z,1550793265.426 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2019-02-21T23:54:25.428Z,1550793265.428 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2019-02-21T23:54:25.428Z,1550793265.428 [IBIT](INFO): Initialize IBIT Component.
2019-02-21T23:54:25.429Z,1550793265.429 [CBIT](DEBUG): Initialize CBIT Component.
2019-02-21T23:54:25.430Z,1550793265.430 [logger ThreadHandler](INFO): Handler Thread ID is 1826
2019-02-21T23:54:25.441Z,1550793265.441 [CBIT](DEBUG): Initialized mux pins.
2019-02-21T23:54:25.441Z,1550793265.441 [CBIT](DEBUG): Initializing the watchdog timer.
2019-02-21T23:54:25.449Z,1550793265.449 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1827
2019-02-21T23:54:25.451Z,1550793265.451 [Radio_Surface](INFO): Powering up
2019-02-21T23:54:25.461Z,1550793265.461 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 1828
2019-02-21T23:54:25.462Z,1550793265.462 [CTD_NeilBrown](INFO): Powering down
2019-02-21T23:54:25.469Z,1550793265.469 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-02-21T23:54:25.469Z,1550793265.469 [CBIT](DEBUG): Initializing heartbeat.
2019-02-21T23:54:25.489Z,1550793265.489 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 1829
2019-02-21T23:54:25.490Z,1550793265.490 [WetLabsSeaOWL_UV_A](INFO): Powering down
2019-02-21T23:54:25.520Z,1550793265.520 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1830
2019-02-21T23:54:25.532Z,1550793265.532 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-02-21T23:54:25.532Z,1550793265.532 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-02-21T23:54:25.532Z,1550793265.532 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-02-21T23:54:25.532Z,1550793265.532 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-02-21T23:54:25.532Z,1550793265.532 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-02-21T23:54:25.532Z,1550793265.532 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-02-21T23:54:25.533Z,1550793265.533 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-02-21T23:54:25.533Z,1550793265.533 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-02-21T23:54:25.533Z,1550793265.533 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-02-21T23:54:25.533Z,1550793265.533 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-02-21T23:54:25.534Z,1550793265.534 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-02-21T23:54:25.534Z,1550793265.534 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-02-21T23:54:25.534Z,1550793265.534 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-02-21T23:54:25.534Z,1550793265.534 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-02-21T23:54:25.534Z,1550793265.534 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-02-21T23:54:25.534Z,1550793265.534 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-02-21T23:54:25.541Z,1550793265.541 [CBIT](DEBUG): Deactivating GF circuits.
2019-02-21T23:54:25.541Z,1550793265.541 [CBIT](DEBUG): Deactivating emergency mode.
2019-02-21T23:54:25.577Z,1550793265.577 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-02-21T23:54:25.579Z,1550793265.579 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-02-21T23:54:25.580Z,1550793265.580 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-02-21T23:54:25.580Z,1550793265.580 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-02-21T23:54:25.581Z,1550793265.581 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-02-21T23:54:25.591Z,1550793265.591 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-02-21T23:54:25.610Z,1550793265.610 [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>


2019-02-21T23:54:25.610Z,1550793265.610 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-02-21T23:54:25.678Z,1550793265.678 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-02-21T23:54:25.680Z,1550793265.680 [Default:A.Wait](DEBUG): Construct Wait.
2019-02-21T23:54:25.681Z,1550793265.681 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-02-21T23:54:25.716Z,1550793265.716 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-02-21T23:54:25.736Z,1550793265.736 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-02-21T23:54:25.753Z,1550793265.753 [Default:E.Execute](DEBUG): Construct Execute.
2019-02-21T23:54:25.756Z,1550793265.756 [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="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</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>13</Value></Setting>
    </Guidance:Wait>

    <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>


2019-02-21T23:54:25.769Z,1550793265.769 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,DUSBL_Hydroid,Micromodem,NAL9602,Onboard,RDI_Pathfinder,RDI_PathfinderUp,BPC1,Aanderaa_O2,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2019-02-21T23:54:25.781Z,1550793265.781 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-02-21T23:54:25.802Z,1550793265.802 [Depth_Keller](ERROR): Pressure reading out of range: 1913.424561 decibar
2019-02-21T23:54:25.803Z,1550793265.803 [DUSBL_Hydroid](INFO): Powering up
2019-02-21T23:54:25.803Z,1550793265.803 [DUSBL_Hydroid](DEBUG): Initializing DUSBL_Hydroid.
2019-02-21T23:54:25.821Z,1550793265.821 [Micromodem](INFO): Start
2019-02-21T23:54:25.885Z,1550793265.885 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-21T23:54:25.910Z,1550793265.910 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-02-21T23:54:25.917Z,1550793265.917 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-02-21T23:54:25.918Z,1550793265.918 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-02-21T23:54:25.925Z,1550793265.925 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-02-21T23:54:25.926Z,1550793265.926 [MassServo](DEBUG): Initializing EZServoServo.
2019-02-21T23:54:25.933Z,1550793265.933 [MassServo](DEBUG): Initializing MassServo.
2019-02-21T23:54:25.934Z,1550793265.934 [RudderServo](DEBUG): Initializing EZServoServo.
2019-02-21T23:54:25.941Z,1550793265.941 [RudderServo](DEBUG): Initializing RudderServo.
2019-02-21T23:54:25.942Z,1550793265.942 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-02-21T23:54:25.950Z,1550793265.950 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-02-21T23:54:26.226Z,1550793266.226 [Micromodem](INFO): Starting
2019-02-21T23:54:26.227Z,1550793266.227 [Micromodem](INFO): Powering up
2019-02-21T23:54:26.227Z,1550793266.227 [Micromodem](DEBUG): Initializing Micromodem.
2019-02-21T23:54:26.333Z,1550793266.333 [RDI_PathfinderUp](INFO): Powering down
2019-02-21T23:54:26.393Z,1550793266.393 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-21T23:54:35.078Z,1550793275.078 [Micromodem](INFO): Starting
2019-02-21T23:54:35.079Z,1550793275.079 [Micromodem](INFO): Nmea in: $CAREV,235331,INIT,2.0.27690*48

2019-02-21T23:54:35.080Z,1550793275.080 [Micromodem](INFO): Starting
2019-02-21T23:54:35.081Z,1550793275.081 [Micromodem](INFO): Nmea in: $CAREV,235331,SLOT1,2.0.27690*67

2019-02-21T23:54:35.081Z,1550793275.081 [Micromodem](INFO): Nmea buf: $CCCFG,CST,1*37

2019-02-21T23:54:35.082Z,1550793275.082 [Micromodem](INFO): Nmea out: $CCCFG,CST,1*37

2019-02-21T23:54:35.083Z,1550793275.083 [Micromodem](INFO): Nmea buf: $CCCFG,SRC,1*31

2019-02-21T23:54:35.084Z,1550793275.084 [Micromodem](INFO): Nmea buf: $CCCFG,REV,1*32

2019-02-21T23:54:35.086Z,1550793275.086 [Micromodem](INFO): Nmea buf: $CCCFG,RXP,1*29

2019-02-21T23:54:35.087Z,1550793275.087 [Micromodem](INFO): Nmea buf: $CCMSC,1,1,0*41

2019-02-21T23:54:35.142Z,1550793275.142 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-21T23:54:35.463Z,1550793275.463 [Micromodem](INFO): Starting
2019-02-21T23:54:35.464Z,1550793275.464 [Micromodem](INFO): Nmea in: $CAREV,235331,AUV,2.0.27690*10

2019-02-21T23:54:35.509Z,1550793275.509 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-02-21T23:54:35.859Z,1550793275.859 [Micromodem](INFO): Starting
2019-02-21T23:54:35.860Z,1550793275.860 [Micromodem](INFO): Nmea in: $CAREV,235331,COPROC,0.10.0.46*45

2019-02-21T23:54:35.993Z,1550793275.993 [Aanderaa_O2](INFO): Powering down
2019-02-21T23:54:36.262Z,1550793276.262 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004456
2019-02-21T23:54:36.266Z,1550793276.266 [Micromodem](INFO): Starting
2019-02-21T23:54:36.267Z,1550793276.267 [Micromodem](INFO): Nmea in: $CATMG,2019-02-21T23:53:31Z,RTC,RTC*70

2019-02-21T23:54:36.666Z,1550793276.666 [Micromodem](INFO): Starting
2019-02-21T23:54:37.070Z,1550793277.070 [Micromodem](INFO): Starting
2019-02-21T23:54:37.474Z,1550793277.474 [Micromodem](INFO): Starting
2019-02-21T23:54:37.878Z,1550793277.878 [Micromodem](INFO): Starting
2019-02-21T23:54:38.283Z,1550793278.283 [Micromodem](INFO): Starting
2019-02-21T23:54:38.686Z,1550793278.686 [Micromodem](INFO): Starting
2019-02-21T23:54:39.097Z,1550793279.097 [Micromodem](INFO): Starting
2019-02-21T23:54:39.122Z,1550793279.122 [RDI_Pathfinder](ERROR): Failed to parse:Pathfinder
2019-02-21T23:54:39.494Z,1550793279.494 [Micromodem](INFO): Starting
2019-02-21T23:54:39.898Z,1550793279.898 [Micromodem](INFO): Starting
2019-02-21T23:54:40.302Z,1550793280.302 [Micromodem](INFO): Starting
2019-02-21T23:54:40.303Z,1550793280.303 [Micromodem](INFO): Nmea in: $CACFG,CST,1*35

2019-02-21T23:54:40.303Z,1550793280.303 [Micromodem](INFO): Nmea out: $CCCFG,SRC,1*31

2019-02-21T23:54:40.707Z,1550793280.707 [Micromodem](INFO): Starting
2019-02-21T23:54:40.708Z,1550793280.708 [Micromodem](INFO): Nmea in: $CAREV,235341,AUV,2.0.27690*17

2019-02-21T23:54:41.110Z,1550793281.110 [Micromodem](INFO): Starting
2019-02-21T23:54:41.111Z,1550793281.111 [Micromodem](INFO): Nmea in: $CAREV,235341,COPROC,0.10.0.46*42

2019-02-21T23:54:41.518Z,1550793281.518 [Micromodem](INFO): Starting
2019-02-21T23:54:41.918Z,1550793281.918 [Micromodem](INFO): Starting
2019-02-21T23:54:42.323Z,1550793282.323 [Micromodem](INFO): Starting
2019-02-21T23:54:42.726Z,1550793282.726 [Micromodem](INFO): Starting
2019-02-21T23:54:43.131Z,1550793283.131 [Micromodem](INFO): Starting
2019-02-21T23:54:43.536Z,1550793283.536 [Micromodem](INFO): Starting
2019-02-21T23:54:43.942Z,1550793283.942 [DUSBL_Hydroid](INFO): DUSBL Version:O
2019-02-21T23:54:43.957Z,1550793283.957 [Micromodem](INFO): Starting
2019-02-21T23:54:44.342Z,1550793284.342 [Micromodem](INFO): Starting
2019-02-21T23:54:44.746Z,1550793284.746 [Micromodem](INFO): Starting
2019-02-21T23:54:45.154Z,1550793285.154 [Micromodem](INFO): Starting
2019-02-21T23:54:45.554Z,1550793285.554 [Micromodem](INFO): Starting
2019-02-21T23:54:45.958Z,1550793285.958 [Micromodem](INFO): Starting
2019-02-21T23:54:46.362Z,1550793286.362 [Micromodem](INFO): Starting
2019-02-21T23:54:46.766Z,1550793286.766 [Micromodem](INFO): Starting
2019-02-21T23:54:47.170Z,1550793287.170 [Micromodem](INFO): Starting
2019-02-21T23:54:47.570Z,1550793287.570 [Micromodem](INFO): Starting
2019-02-21T23:54:47.978Z,1550793287.978 [Micromodem](INFO): Starting
2019-02-21T23:54:48.382Z,1550793288.382 [Micromodem](INFO): Starting
2019-02-21T23:54:48.786Z,1550793288.786 [Micromodem](INFO): Starting
2019-02-21T23:54:49.186Z,1550793289.186 [Micromodem](INFO): Starting
2019-02-21T23:54:49.594Z,1550793289.594 [Micromodem](INFO): Starting
2019-02-21T23:54:50.005Z,1550793290.005 [Micromodem](INFO): Starting
2019-02-21T23:54:50.398Z,1550793290.398 [Micromodem](INFO): Starting
2019-02-21T23:54:50.399Z,1550793290.399 [Micromodem](INFO): Nmea in: $CACFG,SRC,1*33

2019-02-21T23:54:50.399Z,1550793290.399 [Micromodem](INFO): Nmea out: $CCCFG,REV,1*32

2019-02-21T23:54:50.806Z,1550793290.806 [Micromodem](INFO): Starting
2019-02-21T23:54:50.807Z,1550793290.807 [Micromodem](INFO): Nmea in: $CAREV,235351,AUV,2.0.27690*16

2019-02-21T23:54:51.206Z,1550793291.206 [Micromodem](INFO): Starting
2019-02-21T23:54:51.207Z,1550793291.207 [Micromodem](INFO): Nmea in: $CAREV,235351,COPROC,0.10.0.46*43

2019-02-21T23:54:51.614Z,1550793291.614 [Micromodem](INFO): Starting
2019-02-21T23:54:52.026Z,1550793292.026 [Micromodem](INFO): Starting
2019-02-21T23:54:52.027Z,1550793292.027 [NAL9602](INFO): Powering up NAL9602
2019-02-21T23:54:52.422Z,1550793292.422 [Micromodem](INFO): Starting
2019-02-21T23:54:52.826Z,1550793292.826 [Micromodem](INFO): Starting
2019-02-21T23:54:53.230Z,1550793293.230 [Micromodem](INFO): Starting
2019-02-21T23:54:53.634Z,1550793293.634 [Micromodem](INFO): Starting
2019-02-21T23:54:54.038Z,1550793294.038 [Micromodem](INFO): Starting
2019-02-21T23:54:54.090Z,1550793294.090 [SBIT](IMPORTANT): Beginning Startup BIT
2019-02-21T23:54:54.118Z,1550793294.118 [CBIT](IMPORTANT): Beginning ground fault scan
2019-02-21T23:54:54.442Z,1550793294.442 [Micromodem](INFO): Starting
2019-02-21T23:54:54.846Z,1550793294.846 [Micromodem](INFO): Starting
2019-02-21T23:54:55.250Z,1550793295.250 [Micromodem](INFO): Starting
2019-02-21T23:54:55.654Z,1550793295.654 [Micromodem](INFO): Starting
2019-02-21T23:54:56.058Z,1550793296.058 [Micromodem](INFO): Starting
2019-02-21T23:54:56.566Z,1550793296.566 [Micromodem](INFO): Starting
2019-02-21T23:54:56.971Z,1550793296.971 [Micromodem](INFO): Starting
2019-02-21T23:54:57.386Z,1550793297.386 [Micromodem](INFO): Starting
2019-02-21T23:54:57.778Z,1550793297.778 [Micromodem](INFO): Starting
2019-02-21T23:54:58.190Z,1550793298.190 [Micromodem](INFO): Starting
2019-02-21T23:54:58.586Z,1550793298.586 [Micromodem](INFO): Starting
2019-02-21T23:54:58.998Z,1550793298.998 [Micromodem](INFO): Starting
2019-02-21T23:54:59.394Z,1550793299.394 [Micromodem](INFO): Starting
2019-02-21T23:54:59.798Z,1550793299.798 [Micromodem](INFO): Starting
2019-02-21T23:55:00.198Z,1550793300.198 [Micromodem](INFO): Starting
2019-02-21T23:55:00.199Z,1550793300.199 [Micromodem](INFO): Nmea in: $CACFG,REV,1*30

2019-02-21T23:55:00.199Z,1550793300.199 [Micromodem](INFO): Nmea out: $CCCFG,RXP,1*29

2019-02-21T23:55:00.606Z,1550793300.606 [Micromodem](INFO): Starting
2019-02-21T23:55:00.607Z,1550793300.607 [Micromodem](INFO): Nmea in: $CAREV,235401,AUV,2.0.27690*14

2019-02-21T23:55:01.020Z,1550793301.020 [Micromodem](INFO): Starting
2019-02-21T23:55:01.022Z,1550793301.022 [Micromodem](INFO): Nmea in: $CAREV,235401,COPROC,0.10.0.46*41

2019-02-21T23:55:01.414Z,1550793301.414 [Micromodem](INFO): Starting
2019-02-21T23:55:07.219Z,1550793307.219 [Micromodem](INFO): Starting
2019-02-21T23:55:07.481Z,1550793307.481 [Micromodem](INFO): Starting
2019-02-21T23:55:07.874Z,1550793307.874 [Micromodem](INFO): Starting
2019-02-21T23:55:07.875Z,1550793307.875 [NAL9602](INFO): NAL9602 initialized
2019-02-21T23:55:08.278Z,1550793308.278 [Micromodem](INFO): Starting
2019-02-21T23:55:08.682Z,1550793308.682 [Micromodem](INFO): Starting
2019-02-21T23:55:08.697Z,1550793308.697 [NAL9602](DEBUG): Fix Requested
2019-02-21T23:55:09.086Z,1550793309.086 [Micromodem](INFO): Starting
2019-02-21T23:55:09.490Z,1550793309.490 [Micromodem](INFO): Starting
2019-02-21T23:55:10.087Z,1550793310.087 [Micromodem](INFO): Starting
2019-02-21T23:55:10.262Z,1550793310.262 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.010442
CHAN A1 (24V): -0.026013
CHAN A2 (12V): -0.007650
CHAN A3 (5V): -0.003284
CHAN B0 (3.3V): -0.000699
CHAN B1 (3.15aV): 0.000107
CHAN B2 (3.15bV): 0.000066
CHAN B3 (GND): 0.000862
OPEN: 0.009219
Full Scale Calc: 4.765 mA, -1.589 mA
2019-02-21T23:55:10.502Z,1550793310.502 [Micromodem](INFO): Starting
2019-02-21T23:55:10.503Z,1550793310.503 [Micromodem](INFO): Nmea in: $CACFG,RXP,1*2B

2019-02-21T23:55:10.503Z,1550793310.503 [Micromodem](INFO): Nmea out: $CCMSC,1,1,0*41

2019-02-21T23:55:10.894Z,1550793310.894 [Micromodem](INFO): Starting
2019-02-21T23:55:10.895Z,1550793310.895 [Micromodem](INFO): Nmea in: $CAREV,235411,AUV,2.0.27690*15

2019-02-21T23:55:11.310Z,1550793311.310 [Micromodem](INFO): Starting
2019-02-21T23:55:11.311Z,1550793311.311 [Micromodem](INFO): Nmea in: $CAREV,235411,COPROC,0.10.0.46*40

2019-02-21T23:55:11.702Z,1550793311.702 [Micromodem](INFO): Starting
2019-02-21T23:55:12.106Z,1550793312.106 [Micromodem](INFO): Starting
2019-02-21T23:55:12.510Z,1550793312.510 [Micromodem](INFO): Starting
2019-02-21T23:55:12.922Z,1550793312.922 [Micromodem](INFO): Starting
2019-02-21T23:55:13.326Z,1550793313.326 [Micromodem](INFO): Starting
2019-02-21T23:55:13.722Z,1550793313.722 [Micromodem](INFO): Starting
2019-02-21T23:55:14.126Z,1550793314.126 [Micromodem](INFO): Starting
2019-02-21T23:55:14.530Z,1550793314.530 [Micromodem](INFO): Starting
2019-02-21T23:55:14.934Z,1550793314.934 [Micromodem](INFO): Starting
2019-02-21T23:55:15.338Z,1550793315.338 [Micromodem](INFO): Starting
2019-02-21T23:55:15.742Z,1550793315.742 [Micromodem](INFO): Starting
2019-02-21T23:55:16.146Z,1550793316.146 [Micromodem](INFO): Starting
2019-02-21T23:55:16.558Z,1550793316.558 [Micromodem](INFO): Starting
2019-02-21T23:55:16.950Z,1550793316.950 [Micromodem](INFO): Starting
2019-02-21T23:55:17.358Z,1550793317.358 [Micromodem](INFO): Starting
2019-02-21T23:55:17.758Z,1550793317.758 [Micromodem](INFO): Starting
2019-02-21T23:55:18.166Z,1550793318.166 [Micromodem](INFO): Starting
2019-02-21T23:55:18.576Z,1550793318.576 [Micromodem](INFO): Starting
2019-02-21T23:55:19.023Z,1550793319.023 [Micromodem](INFO): Starting
2019-02-21T23:55:19.378Z,1550793319.378 [Micromodem](INFO): Starting
2019-02-21T23:55:19.786Z,1550793319.786 [Micromodem](INFO): Starting
2019-02-21T23:55:20.186Z,1550793320.186 [Micromodem](INFO): Starting
2019-02-21T23:55:20.590Z,1550793320.590 [Micromodem](INFO): Starting
2019-02-21T23:55:21.002Z,1550793321.002 [Micromodem](INFO): Starting
2019-02-21T23:55:21.402Z,1550793321.402 [Micromodem](INFO): Starting
2019-02-21T23:55:21.803Z,1550793321.803 [Micromodem](INFO): Starting
2019-02-21T23:55:22.210Z,1550793322.210 [Micromodem](INFO): Starting
2019-02-21T23:55:22.614Z,1550793322.614 [Micromodem](INFO): Starting
2019-02-21T23:55:23.026Z,1550793323.026 [Micromodem](INFO): Starting
2019-02-21T23:55:23.422Z,1550793323.422 [Micromodem](INFO): Starting
2019-02-21T23:55:23.822Z,1550793323.822 [Micromodem](INFO): Starting
2019-02-21T23:55:24.226Z,1550793324.226 [Micromodem](INFO): Starting
2019-02-21T23:55:24.634Z,1550793324.634 [Micromodem](INFO): Starting
2019-02-21T23:55:25.038Z,1550793325.038 [Micromodem](INFO): Starting
2019-02-21T23:55:25.434Z,1550793325.434 [Micromodem](INFO): Starting
2019-02-21T23:55:25.842Z,1550793325.842 [Micromodem](INFO): Starting
2019-02-21T23:55:26.246Z,1550793326.246 [Micromodem](INFO): Starting
2019-02-21T23:55:26.654Z,1550793326.654 [Micromodem](INFO): Starting
2019-02-21T23:55:27.058Z,1550793327.058 [Micromodem](INFO): Starting
2019-02-21T23:55:27.462Z,1550793327.462 [Micromodem](INFO): Starting
2019-02-21T23:55:27.862Z,1550793327.862 [Micromodem](INFO): Starting
2019-02-21T23:55:28.266Z,1550793328.266 [Micromodem](INFO): Starting
2019-02-21T23:55:28.672Z,1550793328.672 [Micromodem](INFO): Starting
2019-02-21T23:55:29.074Z,1550793329.074 [Micromodem](INFO): Starting
2019-02-21T23:55:29.482Z,1550793329.482 [Micromodem](INFO): Starting
2019-02-21T23:55:29.886Z,1550793329.886 [Micromodem](INFO): Starting
2019-02-21T23:55:30.290Z,1550793330.290 [Micromodem](INFO): Starting
2019-02-21T23:55:30.694Z,1550793330.694 [Micromodem](INFO): Starting
2019-02-21T23:55:31.098Z,1550793331.098 [Micromodem](INFO): Starting
2019-02-21T23:55:31.498Z,1550793331.498 [Micromodem](INFO): Starting
2019-02-21T23:55:31.906Z,1550793331.906 [Micromodem](INFO): Starting
2019-02-21T23:55:32.306Z,1550793332.306 [Micromodem](INFO): Starting
2019-02-21T23:55:32.710Z,1550793332.710 [Micromodem](INFO): Starting
2019-02-21T23:55:33.118Z,1550793333.118 [Micromodem](INFO): Starting
2019-02-21T23:55:33.518Z,1550793333.518 [Micromodem](INFO): Starting
2019-02-21T23:55:33.922Z,1550793333.922 [Micromodem](INFO): Starting
2019-02-21T23:55:34.330Z,1550793334.330 [Micromodem](INFO): Starting
2019-02-21T23:55:34.734Z,1550793334.734 [Micromodem](INFO): Starting
2019-02-21T23:55:35.138Z,1550793335.138 [Micromodem](INFO): Starting
2019-02-21T23:55:35.542Z,1550793335.542 [Micromodem](INFO): Starting
2019-02-21T23:55:35.943Z,1550793335.943 [Micromodem](INFO): Starting
2019-02-21T23:55:36.351Z,1550793336.351 [Micromodem](INFO): Starting
2019-02-21T23:55:36.838Z,1550793336.838 [Micromodem](INFO): Starting
2019-02-21T23:55:39.910Z,1550793339.910 [Micromodem](INFO): Starting
2019-02-21T23:55:40.163Z,1550793340.163 [Micromodem](INFO): Starting
2019-02-21T23:55:40.570Z,1550793340.570 [Micromodem](INFO): Starting
2019-02-21T23:55:40.978Z,1550793340.978 [Micromodem](INFO): Starting
2019-02-21T23:55:41.374Z,1550793341.374 [Micromodem](INFO): Starting
2019-02-21T23:55:41.780Z,1550793341.780 [Micromodem](INFO): Starting
2019-02-21T23:55:42.182Z,1550793342.182 [Micromodem](INFO): Starting
2019-02-21T23:55:42.586Z,1550793342.586 [Micromodem](INFO): Starting
2019-02-21T23:55:43.002Z,1550793343.002 [Micromodem](INFO): Starting
2019-02-21T23:55:43.398Z,1550793343.398 [Micromodem](INFO): Starting
2019-02-21T23:55:43.802Z,1550793343.802 [Micromodem](INFO): Starting
2019-02-21T23:55:44.206Z,1550793344.206 [Micromodem](INFO): Starting
2019-02-21T23:55:44.606Z,1550793344.606 [Micromodem](INFO): Starting
2019-02-21T23:55:45.016Z,1550793345.016 [Micromodem](INFO): Starting
2019-02-21T23:55:45.414Z,1550793345.414 [Micromodem](INFO): Starting
2019-02-21T23:55:45.818Z,1550793345.818 [Micromodem](INFO): Starting
2019-02-21T23:55:46.226Z,1550793346.226 [Micromodem](INFO): Starting
2019-02-21T23:55:46.630Z,1550793346.630 [Micromodem](INFO): Starting
2019-02-21T23:55:47.034Z,1550793347.034 [Micromodem](INFO): Starting
2019-02-21T23:55:47.434Z,1550793347.434 [Micromodem](INFO): Starting
2019-02-21T23:55:47.838Z,1550793347.838 [Micromodem](INFO): Starting
2019-02-21T23:55:47.883Z,1550793347.883 [SBIT](IMPORTANT): SBIT PASSED
2019-02-21T23:55:47.949Z,1550793347.949 [CommandLine](IMPORTANT): got command configSet list
2019-02-21T23:55:47.949Z,1550793347.949 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-02-21T23:55:47.950Z,1550793347.950 [CommandLine](IMPORTANT): No configSet variables persisted
2019-02-21T23:55:48.242Z,1550793348.242 [Micromodem](INFO): Starting
2019-02-21T23:55:48.294Z,1550793348.294 [MissionManager](IMPORTANT): Started mission Startup
2019-02-21T23:55:48.294Z,1550793348.294 [Startup] Running Loop=1
2019-02-21T23:55:48.295Z,1550793348.295 [Startup](DEBUG): Aggregate::initialize Startup
2019-02-21T23:55:48.295Z,1550793348.295 [Startup:A.GoToSurface] Running Loop=1
2019-02-21T23:55:48.295Z,1550793348.295 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-02-21T23:55:48.295Z,1550793348.295 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-02-21T23:55:48.296Z,1550793348.296 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-02-21T23:55:48.296Z,1550793348.296 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-02-21T23:55:48.297Z,1550793348.297 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-02-21T23:55:48.298Z,1550793348.298 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-02-21T23:55:48.299Z,1550793348.299 [Startup:StartupSatComms] Running Loop=1
2019-02-21T23:55:48.300Z,1550793348.300 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-02-21T23:55:48.300Z,1550793348.300 [Startup:StartupSatComms:A] Running Loop=1
2019-02-21T23:55:48.647Z,1550793348.647 [Micromodem](INFO): Starting
2019-02-21T23:55:48.687Z,1550793348.687 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-02-21T23:55:49.050Z,1550793349.050 [Micromodem](INFO): Starting
2019-02-21T23:55:49.454Z,1550793349.454 [Micromodem](INFO): Starting
2019-02-21T23:55:49.862Z,1550793349.862 [Micromodem](INFO): Starting
2019-02-21T23:55:50.266Z,1550793350.266 [Micromodem](INFO): Starting
2019-02-21T23:55:50.670Z,1550793350.670 [Micromodem](INFO): Starting
2019-02-21T23:55:51.066Z,1550793351.066 [Micromodem](INFO): Starting
2019-02-21T23:55:51.478Z,1550793351.478 [Micromodem](INFO): Starting
2019-02-21T23:55:51.878Z,1550793351.878 [Micromodem](INFO): Starting
2019-02-21T23:55:52.278Z,1550793352.278 [Micromodem](INFO): Starting
2019-02-21T23:55:52.687Z,1550793352.687 [Micromodem](INFO): Starting
2019-02-21T23:55:53.095Z,1550793353.095 [Micromodem](INFO): Starting
2019-02-21T23:55:53.490Z,1550793353.490 [Micromodem](INFO): Starting
2019-02-21T23:55:53.902Z,1550793353.902 [Micromodem](INFO): Starting
2019-02-21T23:55:54.302Z,1550793354.302 [Micromodem](INFO): Starting
2019-02-21T23:55:54.710Z,1550793354.710 [Micromodem](INFO): Starting
2019-02-21T23:55:55.110Z,1550793355.110 [Micromodem](INFO): Starting
2019-02-21T23:55:55.515Z,1550793355.515 [Micromodem](INFO): Starting
2019-02-21T23:55:55.922Z,1550793355.922 [Micromodem](INFO): Starting
2019-02-21T23:55:56.326Z,1550793356.326 [Micromodem](INFO): Starting
2019-02-21T23:55:56.726Z,1550793356.726 [Micromodem](INFO): Starting
2019-02-21T23:55:57.130Z,1550793357.130 [Micromodem](INFO): Starting
2019-02-21T23:55:57.534Z,1550793357.534 [Micromodem](INFO): Starting
2019-02-21T23:55:57.938Z,1550793357.938 [Micromodem](INFO): Starting
2019-02-21T23:55:58.346Z,1550793358.346 [Micromodem](INFO): Starting
2019-02-21T23:55:58.633Z,1550793358.633 [CommandLine](IMPORTANT): got command quit
2019-02-21T23:55:58.750Z,1550793358.750 [Micromodem](INFO): Starting
2019-02-21T23:55:59.154Z,1550793359.154 [Micromodem](INFO): Starting
2019-02-21T23:55:59.558Z,1550793359.558 [Micromodem](INFO): Starting
2019-02-21T23:55:59.637Z,1550793359.637 [Supervisor](INFO): Stop Mission called by Supervisor::terminate
2019-02-21T23:55:59.637Z,1550793359.637 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-21T23:55:59.638Z,1550793359.638 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:55:59.665Z,1550793359.665 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-02-21T23:55:59.665Z,1550793359.665 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:55:59.666Z,1550793359.666 [CommandLine](INFO): Join timeout helper Thread ID is 1849
2019-02-21T23:55:59.666Z,1550793359.666 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-02-21T23:55:59.666Z,1550793359.666 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:55:59.667Z,1550793359.667 [NavChartDb](INFO): Join timeout helper Thread ID is 1850
2019-02-21T23:55:59.721Z,1550793359.721 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-21T23:55:59.721Z,1550793359.721 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:55:59.729Z,1550793359.729 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2019-02-21T23:55:59.729Z,1550793359.729 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:55:59.729Z,1550793359.729 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 1851
2019-02-21T23:55:59.958Z,1550793359.958 [Micromodem](INFO): Starting
2019-02-21T23:56:00.049Z,1550793360.049 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-21T23:56:00.049Z,1550793360.049 [WetLabsSeaOWL_UV_A](INFO): Powering down
2019-02-21T23:56:00.050Z,1550793360.050 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:56:00.057Z,1550793360.057 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2019-02-21T23:56:00.057Z,1550793360.057 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:56:00.058Z,1550793360.058 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 1852
2019-02-21T23:56:00.237Z,1550793360.237 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-21T23:56:00.237Z,1550793360.237 [CTD_NeilBrown](INFO): Powering down
2019-02-21T23:56:00.249Z,1550793360.249 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:56:00.253Z,1550793360.253 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-02-21T23:56:00.253Z,1550793360.253 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:56:00.253Z,1550793360.253 [Radio_Surface](INFO): Join timeout helper Thread ID is 1853
2019-02-21T23:56:00.362Z,1550793360.362 [Micromodem](INFO): Starting
2019-02-21T23:56:00.417Z,1550793360.417 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-21T23:56:00.417Z,1550793360.417 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:56:00.434Z,1550793360.434 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-02-21T23:56:00.434Z,1550793360.434 [logger ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:56:00.434Z,1550793360.434 [logger](INFO): Join timeout helper Thread ID is 1854
2019-02-21T23:56:00.435Z,1550793360.435 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-21T23:56:00.435Z,1550793360.435 [logger ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:56:00.443Z,1550793360.443 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-02-21T23:56:00.443Z,1550793360.443 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:56:00.443Z,1550793360.443 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-02-21T23:56:00.443Z,1550793360.443 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:56:00.443Z,1550793360.443 [controlThread](INFO): Join timeout helper Thread ID is 1855
2019-02-21T23:56:00.451Z,1550793360.451 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-02-21T23:56:00.451Z,1550793360.451 [controlThread](DEBUG): Uninitializing ControlThread
2019-02-21T23:56:00.452Z,1550793360.452 [DUSBL_Hydroid](INFO): Powering down
2019-02-21T23:56:00.541Z,1550793360.541 [Micromodem](INFO): uninitialize
2019-02-21T23:56:00.541Z,1550793360.541 [Micromodem](INFO): Powering down
2019-02-21T23:56:00.657Z,1550793360.657 [NAL9602](INFO): Powering down
2019-02-21T23:56:00.729Z,1550793360.729 [RDI_Pathfinder](INFO): Powering down
2019-02-21T23:56:00.730Z,1550793360.730 [RDI_PathfinderUp](INFO): Powering down
2019-02-21T23:56:00.731Z,1550793360.731 [Aanderaa_O2](INFO): Powering down
2019-02-21T23:56:00.732Z,1550793360.732 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-02-21T23:56:00.733Z,1550793360.733 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-02-21T23:56:00.734Z,1550793360.734 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-02-21T23:56:00.735Z,1550793360.735 [MissionManager](INFO): Uninitializing Mission Default
2019-02-21T23:56:00.737Z,1550793360.737 [MissionManager](INFO): Uninitializing Mission Startup
2019-02-21T23:56:00.737Z,1550793360.737 [Startup] Stopped
2019-02-21T23:56:00.737Z,1550793360.737 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-02-21T23:56:00.737Z,1550793360.737 [Startup:A.GoToSurface] Stopped
2019-02-21T23:56:00.737Z,1550793360.737 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-02-21T23:56:00.737Z,1550793360.737 [Startup:StartupSatComms] Stopped
2019-02-21T23:56:00.738Z,1550793360.738 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-02-21T23:56:00.738Z,1550793360.738 [Startup:StartupSatComms:A] Stopped
2019-02-21T23:56:00.739Z,1550793360.739 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-02-21T23:56:00.739Z,1550793360.739 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-02-21T23:56:00.739Z,1550793360.739 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-02-21T23:56:00.740Z,1550793360.740 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-02-21T23:56:00.740Z,1550793360.740 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-02-21T23:56:00.740Z,1550793360.740 [BuoyancyServo](INFO): Powering down
2019-02-21T23:56:00.753Z,1550793360.753 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-02-21T23:56:00.753Z,1550793360.753 [ElevatorServo](INFO): Powering down
2019-02-21T23:56:00.754Z,1550793360.754 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-02-21T23:56:00.754Z,1550793360.754 [MassServo](INFO): Powering down
2019-02-21T23:56:00.755Z,1550793360.755 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-02-21T23:56:00.755Z,1550793360.755 [RudderServo](INFO): Powering down
2019-02-21T23:56:00.756Z,1550793360.756 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-02-21T23:56:00.756Z,1550793360.756 [ThrusterServo](INFO): Powering down
2019-02-21T23:56:00.757Z,1550793360.757 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-02-21T23:56:00.757Z,1550793360.757 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-02-21T23:56:00.757Z,1550793360.757 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-02-21T23:56:00.758Z,1550793360.758 [CBIT](DEBUG): Powering off loads.
2019-02-21T23:56:00.769Z,1550793360.769 [CBIT](DEBUG): Disabling WDT.
2019-02-21T23:56:00.781Z,1550793360.781 [CBIT](DEBUG): Opening all GF detection circuits.
2019-02-21T23:56:00.782Z,1550793360.782 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:56:00.844Z,1550793360.844 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:56:00.891Z,1550793360.891 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:56:00.894Z,1550793360.894 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:56:00.947Z,1550793360.947 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-02-21T23:56:01.001Z,1550793361.001 [logger ThreadHandler](INFO): Thread cancelled.