2018-05-08T03:40:32.273Z,1525750832.273 [Supervisor](DEBUG): Initializing supervisor.
2018-05-08T03:40:32.276Z,1525750832.276 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-05-08T03:40:32.276Z,1525750832.276 [SyncHandler](INFO): Protected caller Thread ID is 530
2018-05-08T03:40:32.277Z,1525750832.277 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-05-08T03:40:32.278Z,1525750832.278 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-05-08T03:40:32.278Z,1525750832.278 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 531
2018-05-08T03:40:32.281Z,1525750832.281 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-05-08T03:40:32.291Z,1525750832.291 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-05-08T03:40:32.292Z,1525750832.292 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-05-08T03:40:32.293Z,1525750832.293 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 532
2018-05-08T03:40:32.294Z,1525750832.294 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-05-08T03:40:32.295Z,1525750832.295 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-05-08T03:40:32.295Z,1525750832.295 [logger ThreadHandler](INFO): Protected caller Thread ID is 533
2018-05-08T03:40:32.297Z,1525750832.297 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-05-08T03:40:32.297Z,1525750832.297 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-05-08T03:40:32.299Z,1525750832.299 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-05-08T03:40:32.391Z,1525750832.391 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-05-08T03:40:32.392Z,1525750832.392 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-05-08T03:40:32.489Z,1525750832.489 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-05-08T03:40:32.490Z,1525750832.490 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-05-08T03:40:32.678Z,1525750832.678 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-05-08T03:40:32.678Z,1525750832.678 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-05-08T03:40:32.977Z,1525750832.977 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-05-08T03:40:32.977Z,1525750832.977 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-05-08T03:40:33.291Z,1525750833.291 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-05-08T03:40:33.291Z,1525750833.291 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-05-08T03:40:33.727Z,1525750833.727 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-05-08T03:40:33.728Z,1525750833.728 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-05-08T03:40:34.074Z,1525750834.074 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-05-08T03:40:34.075Z,1525750834.075 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-05-08T03:40:34.494Z,1525750834.494 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-05-08T03:40:34.494Z,1525750834.494 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-05-08T03:40:34.572Z,1525750834.572 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-05-08T03:40:34.852Z,1525750834.852 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-05-08T03:40:34.853Z,1525750834.853 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-05-08T03:40:34.990Z,1525750834.990 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-05-08T03:40:34.991Z,1525750834.991 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-05-08T03:40:35.191Z,1525750835.191 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-05-08T03:40:35.192Z,1525750835.192 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-05-08T03:40:35.394Z,1525750835.394 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-05-08T03:40:35.394Z,1525750835.394 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-05-08T03:40:35.488Z,1525750835.488 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-05-08T03:40:35.489Z,1525750835.489 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-05-08T03:40:35.622Z,1525750835.622 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-05-08T03:40:35.624Z,1525750835.624 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2018-05-08T03:40:35.625Z,1525750835.625 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2018-05-08T03:40:35.853Z,1525750835.853 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-05-08T03:40:35.853Z,1525750835.853 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2018-05-08T03:40:35.930Z,1525750835.930 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2018-05-08T03:40:36.065Z,1525750836.065 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2018-05-08T03:40:36.155Z,1525750836.155 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2018-05-08T03:40:36.238Z,1525750836.238 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2018-05-08T03:40:36.369Z,1525750836.369 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2018-05-08T03:40:36.536Z,1525750836.536 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2018-05-08T03:40:36.629Z,1525750836.629 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2018-05-08T03:40:36.718Z,1525750836.718 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2018-05-08T03:40:36.811Z,1525750836.811 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2018-05-08T03:40:36.891Z,1525750836.891 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-05-08T03:40:36.905Z,1525750836.905 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-05-08T03:40:37.002Z,1525750837.002 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-05-08T03:40:37.002Z,1525750837.002 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-05-08T03:40:37.039Z,1525750837.039 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-05-08T03:40:37.039Z,1525750837.039 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-05-08T03:40:37.129Z,1525750837.129 [DepthRateCalculator] Loaded
2018-05-08T03:40:37.130Z,1525750837.130 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-05-08T03:40:37.147Z,1525750837.147 [PitchRateCalculator] Loaded
2018-05-08T03:40:37.147Z,1525750837.147 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-05-08T03:40:37.163Z,1525750837.163 [SpeedCalculator] Loaded
2018-05-08T03:40:37.163Z,1525750837.163 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-05-08T03:40:37.193Z,1525750837.193 [TempGradientCalculator] Loaded
2018-05-08T03:40:37.194Z,1525750837.194 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-05-08T03:40:37.209Z,1525750837.209 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2018-05-08T03:40:37.209Z,1525750837.209 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2018-05-08T03:40:37.215Z,1525750837.215 [YawRateCalculator] Loaded
2018-05-08T03:40:37.215Z,1525750837.215 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-05-08T03:40:37.285Z,1525750837.285 [ElevatorOffsetCalculator] Loaded
2018-05-08T03:40:37.286Z,1525750837.286 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-05-08T03:40:37.286Z,1525750837.286 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-05-08T03:40:37.287Z,1525750837.287 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-05-08T03:40:37.311Z,1525750837.311 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-05-08T03:40:37.312Z,1525750837.312 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-05-08T03:40:37.784Z,1525750837.784 [AHRS_M2] Loaded
2018-05-08T03:40:37.784Z,1525750837.784 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2018-05-08T03:40:37.827Z,1525750837.827 [AcousticModem_Benthos_ATM900] Loaded
2018-05-08T03:40:37.827Z,1525750837.827 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2018-05-08T03:40:37.896Z,1525750837.896 [DataOverHttps] Loaded
2018-05-08T03:40:37.896Z,1525750837.896 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-05-08T03:40:37.909Z,1525750837.909 [Depth_Keller] Loaded
2018-05-08T03:40:37.909Z,1525750837.909 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-05-08T03:40:37.910Z,1525750837.910 [Module Loader](CRITICAL): Could not find element GobyModem.loadAtStartup
2018-05-08T03:40:38.004Z,1525750838.004 [NAL9602] Loaded
2018-05-08T03:40:38.004Z,1525750838.004 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-05-08T03:40:38.020Z,1525750838.020 [Onboard] Loaded
2018-05-08T03:40:38.020Z,1525750838.020 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-05-08T03:40:38.030Z,1525750838.030 [Radio_Surface] Loaded
2018-05-08T03:40:38.030Z,1525750838.030 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-05-08T03:40:38.031Z,1525750838.031 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407B24E0
2018-05-08T03:40:38.032Z,1525750838.032 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 612
2018-05-08T03:40:38.032Z,1525750838.032 [Module Loader](CRITICAL): Could not find element RDI_Pathfinder.loadAtStartup
2018-05-08T03:40:39.826Z,1525750839.826 [BPC1] Loaded
2018-05-08T03:40:39.826Z,1525750839.826 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-05-08T03:40:39.826Z,1525750839.826 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-05-08T03:40:39.827Z,1525750839.827 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-05-08T03:40:39.954Z,1525750839.954 [SBIT](DEBUG): Construct Startup Built In Test.
2018-05-08T03:40:39.976Z,1525750839.976 [SBIT] Loaded
2018-05-08T03:40:39.977Z,1525750839.977 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-05-08T03:40:39.977Z,1525750839.977 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-05-08T03:40:39.988Z,1525750839.988 [IBIT] Loaded
2018-05-08T03:40:39.989Z,1525750839.989 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-05-08T03:40:39.992Z,1525750839.992 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-05-08T03:40:40.137Z,1525750840.137 [CBIT] Loaded
2018-05-08T03:40:40.137Z,1525750840.137 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-05-08T03:40:40.138Z,1525750840.138 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-05-08T03:40:40.138Z,1525750840.138 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-05-08T03:40:40.286Z,1525750840.286 [Aanderaa_O2] Loaded
2018-05-08T03:40:40.287Z,1525750840.287 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2018-05-08T03:40:40.333Z,1525750840.333 [CTD_Seabird] Loaded
2018-05-08T03:40:40.333Z,1525750840.333 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2018-05-08T03:40:40.334Z,1525750840.334 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 408724E0
2018-05-08T03:40:40.334Z,1525750840.334 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 614
2018-05-08T03:40:40.351Z,1525750840.351 [ESPComponent] Loaded
2018-05-08T03:40:40.351Z,1525750840.351 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2018-05-08T03:40:40.365Z,1525750840.365 [PAR_Licor] Loaded
2018-05-08T03:40:40.365Z,1525750840.365 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2018-05-08T03:40:40.413Z,1525750840.413 [WetLabsBB2FL] Loaded
2018-05-08T03:40:40.413Z,1525750840.413 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2018-05-08T03:40:40.414Z,1525750840.414 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 408A24E0
2018-05-08T03:40:40.415Z,1525750840.415 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 615
2018-05-08T03:40:40.415Z,1525750840.415 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-05-08T03:40:40.416Z,1525750840.416 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-05-08T03:40:40.649Z,1525750840.649 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-05-08T03:40:40.649Z,1525750840.649 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-05-08T03:40:40.717Z,1525750840.717 [VerticalControl](DEBUG): Construct VerticalControl.
2018-05-08T03:40:40.810Z,1525750840.810 [VerticalControl] Loaded
2018-05-08T03:40:40.810Z,1525750840.810 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-05-08T03:40:40.811Z,1525750840.811 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-05-08T03:40:40.870Z,1525750840.870 [HorizontalControl] Loaded
2018-05-08T03:40:40.871Z,1525750840.871 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-05-08T03:40:40.871Z,1525750840.871 [SpeedControl](DEBUG): Construct SpeedControl.
2018-05-08T03:40:40.877Z,1525750840.877 [SpeedControl] Loaded
2018-05-08T03:40:40.877Z,1525750840.877 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-05-08T03:40:40.877Z,1525750840.877 [LoopControl](DEBUG): Construct LoopControl.
2018-05-08T03:40:40.878Z,1525750840.878 [LoopControl] Loaded
2018-05-08T03:40:40.878Z,1525750840.878 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-05-08T03:40:40.879Z,1525750840.879 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-05-08T03:40:40.879Z,1525750840.879 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-05-08T03:40:40.961Z,1525750840.961 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2018-05-08T03:40:40.961Z,1525750840.961 [StratificationFrontDetector](DEBUG): (re)initializing
2018-05-08T03:40:40.962Z,1525750840.962 [StratificationFrontDetector] Loaded
2018-05-08T03:40:40.962Z,1525750840.962 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2018-05-08T03:40:40.963Z,1525750840.963 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-05-08T03:40:40.963Z,1525750840.963 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-05-08T03:40:41.058Z,1525750841.058 [BuoyancyServo] Loaded
2018-05-08T03:40:41.059Z,1525750841.059 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-05-08T03:40:41.070Z,1525750841.070 [ElevatorServo] Loaded
2018-05-08T03:40:41.070Z,1525750841.070 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-05-08T03:40:41.081Z,1525750841.081 [MassServo] Loaded
2018-05-08T03:40:41.081Z,1525750841.081 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-05-08T03:40:41.092Z,1525750841.092 [RudderServo] Loaded
2018-05-08T03:40:41.092Z,1525750841.092 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-05-08T03:40:41.103Z,1525750841.103 [ThrusterServo] Loaded
2018-05-08T03:40:41.103Z,1525750841.103 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-05-08T03:40:41.104Z,1525750841.104 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-05-08T03:40:41.104Z,1525750841.104 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-05-08T03:40:41.199Z,1525750841.199 [DeadReckonUsingMultipleVelocitySources] Loaded
2018-05-08T03:40:41.199Z,1525750841.199 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2018-05-08T03:40:41.253Z,1525750841.253 [DeadReckonUsingSpeedCalculator] Loaded
2018-05-08T03:40:41.254Z,1525750841.254 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-05-08T03:40:41.270Z,1525750841.270 [NavChart] Loaded
2018-05-08T03:40:41.270Z,1525750841.270 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-05-08T03:40:41.274Z,1525750841.274 [UniversalFixResidualReporter] Loaded
2018-05-08T03:40:41.274Z,1525750841.274 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-05-08T03:40:41.275Z,1525750841.275 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-05-08T03:40:41.278Z,1525750841.278 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-05-08T03:40:41.279Z,1525750841.279 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-05-08T03:40:41.286Z,1525750841.286 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-05-08T03:40:41.287Z,1525750841.287 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 409FB4E0
2018-05-08T03:40:41.287Z,1525750841.287 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 616
2018-05-08T03:40:41.291Z,1525750841.291 [Supervisor](INFO): Main Thread ID is 529
2018-05-08T03:40:41.292Z,1525750841.292 [Supervisor](DEBUG): Running supervisor.
2018-05-08T03:40:41.292Z,1525750841.292 [CommandLine ThreadHandler](INFO): Handler Thread ID is 617
2018-05-08T03:40:41.295Z,1525750841.295 [controlThread ThreadHandler](INFO): Handler Thread ID is 618
2018-05-08T03:40:41.295Z,1525750841.295 [controlThread](DEBUG): Initializing ControlThread
2018-05-08T03:40:41.296Z,1525750841.296 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-05-08T03:40:41.296Z,1525750841.296 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-05-08T03:40:41.297Z,1525750841.297 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-05-08T03:40:41.297Z,1525750841.297 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-05-08T03:40:41.298Z,1525750841.298 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2018-05-08T03:40:41.298Z,1525750841.298 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-05-08T03:40:41.299Z,1525750841.299 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2018-05-08T03:40:41.302Z,1525750841.302 [SBIT](INFO): Initialize SBIT Component.
2018-05-08T03:40:41.302Z,1525750841.302 [SBIT](IMPORTANT): git: 2018-03-26-61-g3a7ff4a
2018-05-08T03:40:41.302Z,1525750841.302 [SBIT](INFO): git hash: 3a7ff4a2c61851fe6454e78a1ec1c4bd5c76df54
2018-05-08T03:40:41.303Z,1525750841.303 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2018-05-08T03:40:41.304Z,1525750841.304 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
Kernel Reported: #16 PREEMPT Thu Apr 12 16:20:47 PDT 2018
2018-05-08T03:40:41.305Z,1525750841.305 [SBIT](INFO): Beginning SBIT in 52.000000 seconds.
2018-05-08T03:40:41.306Z,1525750841.306 [IBIT](INFO): Initialize IBIT Component.
2018-05-08T03:40:41.306Z,1525750841.306 [CBIT](DEBUG): Initialize CBIT Component.
2018-05-08T03:40:41.307Z,1525750841.307 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2018-05-08T03:40:41.307Z,1525750841.307 [logger ThreadHandler](INFO): Handler Thread ID is 619
2018-05-08T03:40:41.325Z,1525750841.325 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 620
2018-05-08T03:40:41.331Z,1525750841.331 [Radio_Surface](INFO): Powering up
2018-05-08T03:40:41.337Z,1525750841.337 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 621
2018-05-08T03:40:41.338Z,1525750841.338 [CTD_Seabird](INFO): Initializing
2018-05-08T03:40:41.338Z,1525750841.338 [CTD_Seabird](INFO): Checking LCM
2018-05-08T03:40:41.347Z,1525750841.347 [CTD_Seabird](INFO): LCM OK
2018-05-08T03:40:41.347Z,1525750841.347 [CTD_Seabird](INFO): Powering up
2018-05-08T03:40:41.353Z,1525750841.353 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 622
2018-05-08T03:40:41.355Z,1525750841.355 [WetLabsBB2FL](INFO): Powering down
2018-05-08T03:40:41.381Z,1525750841.381 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 623
2018-05-08T03:40:41.384Z,1525750841.384 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-05-08T03:40:41.384Z,1525750841.384 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-05-08T03:40:41.385Z,1525750841.385 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-05-08T03:40:41.385Z,1525750841.385 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-05-08T03:40:41.385Z,1525750841.385 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-05-08T03:40:41.385Z,1525750841.385 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-05-08T03:40:41.385Z,1525750841.385 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-05-08T03:40:41.386Z,1525750841.386 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-05-08T03:40:41.386Z,1525750841.386 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-05-08T03:40:41.386Z,1525750841.386 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-05-08T03:40:41.386Z,1525750841.386 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-05-08T03:40:41.386Z,1525750841.386 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-05-08T03:40:41.387Z,1525750841.387 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-05-08T03:40:41.387Z,1525750841.387 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-05-08T03:40:41.387Z,1525750841.387 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-05-08T03:40:41.387Z,1525750841.387 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-05-08T03:40:41.417Z,1525750841.417 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-05-08T03:40:41.419Z,1525750841.419 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-05-08T03:40:41.419Z,1525750841.419 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-05-08T03:40:41.420Z,1525750841.420 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-05-08T03:40:41.422Z,1525750841.422 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2018-05-08T03:40:41.423Z,1525750841.423 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2018-05-08T03:40:41.423Z,1525750841.423 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2018-05-08T03:40:41.424Z,1525750841.424 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-05-08T03:40:41.424Z,1525750841.424 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-05-08T03:40:41.424Z,1525750841.424 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-05-08T03:40:41.425Z,1525750841.425 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-05-08T03:40:41.425Z,1525750841.425 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-05-08T03:40:41.426Z,1525750841.426 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-05-08T03:40:41.457Z,1525750841.457 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-05-08T03:40:41.480Z,1525750841.480 [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>


2018-05-08T03:40:41.493Z,1525750841.493 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-05-08T03:40:41.579Z,1525750841.579 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-05-08T03:40:41.580Z,1525750841.580 [Default:A.Wait](DEBUG): Construct Wait.
2018-05-08T03:40:41.582Z,1525750841.582 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-05-08T03:40:41.617Z,1525750841.617 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-05-08T03:40:41.620Z,1525750841.620 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-05-08T03:40:41.641Z,1525750841.641 [Default:E.Execute](DEBUG): Construct Execute.
2018-05-08T03:40:41.645Z,1525750841.645 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
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/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="Default">

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

    <Guidance:Wait>
        <Sequence/>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <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">
            <Sequence/>
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Sequence/>
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn 300</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>


2018-05-08T03:40:41.672Z,1525750841.672 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,NAL9602,Onboard,BPC1,Aanderaa_O2,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-05-08T03:40:41.703Z,1525750841.703 [AHRS_M2](INFO): Start
2018-05-08T03:40:41.703Z,1525750841.703 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-05-08T03:40:41.716Z,1525750841.716 [AcousticModem_Benthos_ATM900](INFO): Powering up
2018-05-08T03:40:41.716Z,1525750841.716 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2018-05-08T03:40:41.740Z,1525750841.740 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-05-08T03:40:42.036Z,1525750842.036 [ESPComponent](INFO): powering down ESP
2018-05-08T03:40:42.550Z,1525750842.550 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-08T03:40:42.578Z,1525750842.578 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-08T03:40:42.697Z,1525750842.697 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-05-08T03:40:42.705Z,1525750842.705 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-05-08T03:40:42.727Z,1525750842.727 [ElevatorServo](DEBUG): Initializing EZServoServo.
2018-05-08T03:40:42.733Z,1525750842.733 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-05-08T03:40:42.747Z,1525750842.747 [MassServo](DEBUG): Initializing EZServoServo.
2018-05-08T03:40:42.753Z,1525750842.753 [MassServo](DEBUG): Initializing MassServo.
2018-05-08T03:40:42.767Z,1525750842.767 [RudderServo](DEBUG): Initializing EZServoServo.
2018-05-08T03:40:42.773Z,1525750842.773 [RudderServo](DEBUG): Initializing RudderServo.
2018-05-08T03:40:42.779Z,1525750842.779 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-05-08T03:40:42.785Z,1525750842.785 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-05-08T03:40:42.822Z,1525750842.822 [CommandLine](FAULT): Scheduling is paused
2018-05-08T03:40:42.822Z,1525750842.822 [CBIT](INFO): Critical error at 20180508T034038
2018-05-08T03:40:42.823Z,1525750842.823 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2018-05-08T03:40:42.918Z,1525750842.918 [AHRS_M2](INFO): Starting
2018-05-08T03:40:43.101Z,1525750843.101 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2018-05-08T03:40:43.102Z,1525750843.102 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2018-05-08T03:40:43.273Z,1525750843.273 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:43.857Z,1525750843.857 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:44.261Z,1525750844.261 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:44.661Z,1525750844.661 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:45.061Z,1525750845.061 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:45.461Z,1525750845.461 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:45.861Z,1525750845.861 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:46.261Z,1525750846.261 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:46.735Z,1525750846.735 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:46.875Z,1525750846.875 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface
2018-05-08T03:40:47.016Z,1525750847.016 [CTD_Seabird](INFO): Started Seabird LCM interface with command:nohup ./lrauv-framework/onboard/bin/gpctd -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyC6 -b 9600 >& /dev/null &
2018-05-08T03:40:47.058Z,1525750847.058 [CTD_Seabird](INFO): LCM subscribed to channel:ctd_t.seabird-gpctd
2018-05-08T03:40:47.138Z,1525750847.138 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:47.472Z,1525750847.472 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface
2018-05-08T03:40:47.472Z,1525750847.472 [CTD_Seabird](INFO): Powering down
2018-05-08T03:40:47.537Z,1525750847.537 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:47.937Z,1525750847.937 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:48.337Z,1525750848.337 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:48.737Z,1525750848.737 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:49.137Z,1525750849.137 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:49.164Z,1525750849.164 [AcousticModem_Benthos_ATM900](DEBUG): 
2018-05-08T03:40:49.537Z,1525750849.537 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:49.937Z,1525750849.937 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:50.337Z,1525750850.337 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:50.366Z,1525750850.366 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series OEM w/burn wire
2018-05-08T03:40:50.737Z,1525750850.737 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:50.764Z,1525750850.764 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2018-05-08T03:40:50.765Z,1525750850.765 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.6.3
2018-05-08T03:40:50.766Z,1525750850.766 [AcousticModem_Benthos_ATM900](DEBUG): Apr  5 2000 00:33:08 
2018-05-08T03:40:51.137Z,1525750851.137 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:51.164Z,1525750851.164 [AcousticModem_Benthos_ATM900](DEBUG): WARNING: battery low
2018-05-08T03:40:51.537Z,1525750851.537 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:51.937Z,1525750851.937 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:51.964Z,1525750851.964 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2018-05-08T03:40:52.337Z,1525750852.337 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:52.364Z,1525750852.364 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2018-05-08T03:40:52.365Z,1525750852.365 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 1: user:1>
2018-05-08T03:40:52.365Z,1525750852.365 [AcousticModem_Benthos_ATM900](INFO): command mode acknowledged
2018-05-08T03:40:52.387Z,1525750852.387 [Aanderaa_O2](FAULT): Timed out starting
2018-05-08T03:40:52.387Z,1525750852.387 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-05-08T03:40:52.387Z,1525750852.387 [Aanderaa_O2](ERROR): Communications Fault
2018-05-08T03:40:52.474Z,1525750852.474 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-05-08T03:40:52.737Z,1525750852.737 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:52.764Z,1525750852.764 [AcousticModem_Benthos_ATM900](INFO): setting local address to 3
2018-05-08T03:40:52.921Z,1525750852.921 [Aanderaa_O2](INFO): Powering down
2018-05-08T03:40:53.137Z,1525750853.137 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:53.164Z,1525750853.164 [AcousticModem_Benthos_ATM900](DEBUG): checking for local address setting acknowledgment
2018-05-08T03:40:53.165Z,1525750853.165 [AcousticModem_Benthos_ATM900](INFO): set local address to 3
2018-05-08T03:40:53.537Z,1525750853.537 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:53.565Z,1525750853.565 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 2: user:2>
2018-05-08T03:40:53.654Z,1525750853.654 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-05-08T03:40:53.654Z,1525750853.654 [Aanderaa_O2] No Fault, FailCount= 1
2018-05-08T03:40:53.937Z,1525750853.937 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:54.337Z,1525750854.337 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:54.737Z,1525750854.737 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:55.137Z,1525750855.137 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:55.537Z,1525750855.537 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:55.937Z,1525750855.937 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:56.337Z,1525750856.337 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:56.737Z,1525750856.737 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:57.137Z,1525750857.137 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:57.537Z,1525750857.537 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:57.937Z,1525750857.937 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:58.337Z,1525750858.337 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:58.737Z,1525750858.737 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:59.137Z,1525750859.137 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:59.537Z,1525750859.537 [AHRS_M2](INFO): Runnable
2018-05-08T03:40:59.937Z,1525750859.937 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:00.337Z,1525750860.337 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:00.737Z,1525750860.737 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:01.137Z,1525750861.137 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:01.537Z,1525750861.537 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:01.937Z,1525750861.937 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:02.337Z,1525750862.337 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:02.737Z,1525750862.737 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:03.137Z,1525750863.137 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:03.537Z,1525750863.537 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:03.937Z,1525750863.937 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:04.337Z,1525750864.337 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:04.389Z,1525750864.389 [Aanderaa_O2](FAULT): Timed out starting
2018-05-08T03:41:04.390Z,1525750864.390 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-05-08T03:41:04.390Z,1525750864.390 [Aanderaa_O2](ERROR): Communications Fault
2018-05-08T03:41:04.459Z,1525750864.459 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-05-08T03:41:04.737Z,1525750864.737 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:04.905Z,1525750864.905 [Aanderaa_O2](INFO): Powering down
2018-05-08T03:41:05.137Z,1525750865.137 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:05.537Z,1525750865.537 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:05.683Z,1525750865.683 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-05-08T03:41:05.683Z,1525750865.683 [Aanderaa_O2] No Fault, FailCount= 2
2018-05-08T03:41:05.937Z,1525750865.937 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:06.337Z,1525750866.337 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:06.737Z,1525750866.737 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:07.137Z,1525750867.137 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:07.537Z,1525750867.537 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:07.937Z,1525750867.937 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:08.337Z,1525750868.337 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:08.737Z,1525750868.737 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:09.136Z,1525750869.136 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:09.536Z,1525750869.536 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:09.937Z,1525750869.937 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:10.336Z,1525750870.336 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:10.736Z,1525750870.736 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:11.136Z,1525750871.136 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:11.536Z,1525750871.536 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:11.936Z,1525750871.936 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:12.336Z,1525750872.336 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:12.736Z,1525750872.736 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:13.136Z,1525750873.136 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:13.536Z,1525750873.536 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:13.936Z,1525750873.936 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:13.970Z,1525750873.970 [NAL9602](INFO): No messages in MT queue
2018-05-08T03:41:14.337Z,1525750874.337 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:14.737Z,1525750874.737 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:15.137Z,1525750875.137 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:15.537Z,1525750875.537 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:15.937Z,1525750875.937 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:16.006Z,1525750876.006 [Aanderaa_O2](FAULT): Timed out starting
2018-05-08T03:41:16.006Z,1525750876.006 [Aanderaa_O2] Communications Fault, FailCount= 3
2018-05-08T03:41:16.006Z,1525750876.006 [Aanderaa_O2](ERROR): Communications Fault
2018-05-08T03:41:16.064Z,1525750876.064 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-05-08T03:41:16.064Z,1525750876.064 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2018-05-08T03:41:16.336Z,1525750876.336 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:16.509Z,1525750876.509 [Aanderaa_O2](INFO): Powering down
2018-05-08T03:41:16.736Z,1525750876.736 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:17.136Z,1525750877.136 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:17.536Z,1525750877.536 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:17.936Z,1525750877.936 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:18.336Z,1525750878.336 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:18.736Z,1525750878.736 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:19.136Z,1525750879.136 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:19.536Z,1525750879.536 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:19.937Z,1525750879.937 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:20.336Z,1525750880.336 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:20.736Z,1525750880.736 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:21.137Z,1525750881.137 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:21.536Z,1525750881.536 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:21.936Z,1525750881.936 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:22.337Z,1525750882.337 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:22.736Z,1525750882.736 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:23.136Z,1525750883.136 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:23.537Z,1525750883.537 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:23.936Z,1525750883.936 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:24.336Z,1525750884.336 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:24.737Z,1525750884.737 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:25.136Z,1525750885.136 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:25.536Z,1525750885.536 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:25.939Z,1525750885.939 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:26.336Z,1525750886.336 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:26.736Z,1525750886.736 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:27.139Z,1525750887.139 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:27.536Z,1525750887.536 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:27.939Z,1525750887.939 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:28.340Z,1525750888.340 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:28.739Z,1525750888.739 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:29.136Z,1525750889.136 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:29.539Z,1525750889.539 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:29.936Z,1525750889.936 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:30.336Z,1525750890.336 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:30.739Z,1525750890.739 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:31.137Z,1525750891.137 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:31.536Z,1525750891.536 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:31.939Z,1525750891.939 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:32.330Z,1525750892.330 [CommandLine](IMPORTANT): got command report touch AHRS_M2.durationOfLastRun
2018-05-08T03:41:32.341Z,1525750892.341 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:32.457Z,1525750892.457 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026478 s
2018-05-08T03:41:32.737Z,1525750892.737 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:32.856Z,1525750892.856 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026343 s
2018-05-08T03:41:33.138Z,1525750893.138 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:33.259Z,1525750893.259 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.025534 s
2018-05-08T03:41:33.537Z,1525750893.537 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:33.660Z,1525750893.660 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026396 s
2018-05-08T03:41:33.937Z,1525750893.937 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:34.059Z,1525750894.059 [SBIT](IMPORTANT): Beginning Startup BIT
2018-05-08T03:41:34.063Z,1525750894.063 [CBIT](IMPORTANT): Beginning ground fault scan
2018-05-08T03:41:34.065Z,1525750894.065 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026306 s
2018-05-08T03:41:34.337Z,1525750894.337 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:34.534Z,1525750894.534 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026338 s
2018-05-08T03:41:34.737Z,1525750894.737 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:34.895Z,1525750894.895 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026130 s
2018-05-08T03:41:35.137Z,1525750895.137 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:35.305Z,1525750895.305 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026416 s
2018-05-08T03:41:35.537Z,1525750895.537 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:35.866Z,1525750895.866 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026071 s
2018-05-08T03:41:35.939Z,1525750895.939 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:36.503Z,1525750896.503 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.027694 s
2018-05-08T03:41:36.508Z,1525750896.508 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:36.750Z,1525750896.750 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.027347 s
2018-05-08T03:41:36.909Z,1525750896.909 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:37.202Z,1525750897.202 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.027282 s
2018-05-08T03:41:37.309Z,1525750897.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:37.527Z,1525750897.527 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.025970 s
2018-05-08T03:41:37.709Z,1525750897.709 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:38.002Z,1525750898.002 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.025599 s
2018-05-08T03:41:38.109Z,1525750898.109 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:38.366Z,1525750898.366 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026648 s
2018-05-08T03:41:38.509Z,1525750898.509 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:38.719Z,1525750898.719 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026473 s
2018-05-08T03:41:38.909Z,1525750898.909 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:39.163Z,1525750899.163 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.027528 s
2018-05-08T03:41:39.309Z,1525750899.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:39.542Z,1525750899.542 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026505 s
2018-05-08T03:41:39.709Z,1525750899.709 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:39.843Z,1525750899.843 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026305 s
2018-05-08T03:41:40.109Z,1525750900.109 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:40.240Z,1525750900.240 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026497 s
2018-05-08T03:41:40.509Z,1525750900.509 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:40.644Z,1525750900.644 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026299 s
2018-05-08T03:41:40.909Z,1525750900.909 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:41.122Z,1525750901.122 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026308 s
2018-05-08T03:41:41.309Z,1525750901.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:41.440Z,1525750901.440 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026502 s
2018-05-08T03:41:41.710Z,1525750901.710 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:41.852Z,1525750901.852 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.025492 s
2018-05-08T03:41:42.109Z,1525750902.109 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:42.330Z,1525750902.330 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026397 s
2018-05-08T03:41:42.509Z,1525750902.509 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:42.667Z,1525750902.667 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026490 s
2018-05-08T03:41:42.909Z,1525750902.909 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:43.048Z,1525750903.048 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026396 s
2018-05-08T03:41:43.309Z,1525750903.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:43.522Z,1525750903.522 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026314 s
2018-05-08T03:41:43.709Z,1525750903.709 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:43.848Z,1525750903.848 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026404 s
2018-05-08T03:41:44.109Z,1525750904.109 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:44.242Z,1525750904.242 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026267 s
2018-05-08T03:41:44.509Z,1525750904.509 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:44.726Z,1525750904.726 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026127 s
2018-05-08T03:41:44.909Z,1525750904.909 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:45.042Z,1525750905.042 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.007959
CHAN A1 (24V): -0.011496
CHAN A2 (12V): -0.005252
CHAN A3 (5V): -0.003084
CHAN B0 (3.3V): -0.001769
CHAN B1 (3.15aV): -0.000875
CHAN B2 (3.15bV): -0.001197
CHAN B3 (GND): 0.000026
OPEN: -0.000733
Full Scale Calc: 4.765 mA, -1.589 mA
2018-05-08T03:41:45.043Z,1525750905.043 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026526 s
2018-05-08T03:41:45.309Z,1525750905.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:45.433Z,1525750905.433 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026152 s
2018-05-08T03:41:45.709Z,1525750905.709 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:45.831Z,1525750905.831 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026544 s
2018-05-08T03:41:46.109Z,1525750906.109 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:46.231Z,1525750906.231 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026544 s
2018-05-08T03:41:46.509Z,1525750906.509 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:46.635Z,1525750906.635 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026313 s
2018-05-08T03:41:46.909Z,1525750906.909 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:47.055Z,1525750907.055 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026423 s
2018-05-08T03:41:47.309Z,1525750907.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:47.518Z,1525750907.518 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026512 s
2018-05-08T03:41:47.709Z,1525750907.709 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:47.793Z,1525750907.793 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026329 s
2018-05-08T03:41:48.111Z,1525750908.111 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:48.221Z,1525750908.221 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.028768 s
2018-05-08T03:41:48.509Z,1525750908.509 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:48.657Z,1525750908.657 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026554 s
2018-05-08T03:41:48.909Z,1525750908.909 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:49.059Z,1525750909.059 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.024341 s
2018-05-08T03:41:49.309Z,1525750909.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:49.902Z,1525750909.902 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026700 s
2018-05-08T03:41:49.907Z,1525750909.907 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:50.107Z,1525750910.107 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.040714 s
2018-05-08T03:41:50.309Z,1525750910.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:50.483Z,1525750910.483 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026801 s
2018-05-08T03:41:50.709Z,1525750910.709 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:50.891Z,1525750910.891 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026449 s
2018-05-08T03:41:51.109Z,1525750911.109 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:51.291Z,1525750911.291 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026575 s
2018-05-08T03:41:51.509Z,1525750911.509 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:51.695Z,1525750911.695 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026562 s
2018-05-08T03:41:51.909Z,1525750911.909 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:52.095Z,1525750912.095 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026540 s
2018-05-08T03:41:52.309Z,1525750912.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:52.487Z,1525750912.487 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.025786 s
2018-05-08T03:41:52.709Z,1525750912.709 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:52.891Z,1525750912.891 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026551 s
2018-05-08T03:41:53.109Z,1525750913.109 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:53.291Z,1525750913.291 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026453 s
2018-05-08T03:41:53.509Z,1525750913.509 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:53.679Z,1525750913.679 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026698 s
2018-05-08T03:41:53.909Z,1525750913.909 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:54.091Z,1525750914.091 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026437 s
2018-05-08T03:41:54.309Z,1525750914.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:54.491Z,1525750914.491 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026691 s
2018-05-08T03:41:54.709Z,1525750914.709 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:54.915Z,1525750914.915 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026497 s
2018-05-08T03:41:55.109Z,1525750915.109 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:55.459Z,1525750915.459 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026621 s
2018-05-08T03:41:55.509Z,1525750915.509 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:55.639Z,1525750915.639 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026473 s
2018-05-08T03:41:55.909Z,1525750915.909 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:56.025Z,1525750916.025 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026581 s
2018-05-08T03:41:56.309Z,1525750916.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:56.432Z,1525750916.432 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026441 s
2018-05-08T03:41:56.709Z,1525750916.709 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:56.839Z,1525750916.839 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026674 s
2018-05-08T03:41:57.108Z,1525750917.108 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:57.235Z,1525750917.235 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026619 s
2018-05-08T03:41:57.509Z,1525750917.509 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:57.639Z,1525750917.639 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026440 s
2018-05-08T03:41:57.909Z,1525750917.909 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:58.039Z,1525750918.039 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026421 s
2018-05-08T03:41:58.308Z,1525750918.308 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:58.442Z,1525750918.442 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026661 s
2018-05-08T03:41:58.709Z,1525750918.709 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:58.827Z,1525750918.827 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026643 s
2018-05-08T03:41:59.109Z,1525750919.109 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:59.239Z,1525750919.239 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026733 s
2018-05-08T03:41:59.508Z,1525750919.508 [AHRS_M2](INFO): Runnable
2018-05-08T03:41:59.635Z,1525750919.635 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026751 s
2018-05-08T03:41:59.909Z,1525750919.909 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:00.031Z,1525750920.031 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.030300 s
2018-05-08T03:42:00.309Z,1525750920.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:00.439Z,1525750920.439 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026625 s
2018-05-08T03:42:00.709Z,1525750920.708 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:00.855Z,1525750920.855 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026688 s
2018-05-08T03:42:01.109Z,1525750921.109 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:01.243Z,1525750921.243 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026578 s
2018-05-08T03:42:01.509Z,1525750921.509 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:01.635Z,1525750921.635 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026843 s
2018-05-08T03:42:01.909Z,1525750921.909 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:02.047Z,1525750922.047 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026709 s
2018-05-08T03:42:02.309Z,1525750922.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:02.431Z,1525750922.431 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026725 s
2018-05-08T03:42:02.709Z,1525750922.709 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:02.827Z,1525750922.827 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026618 s
2018-05-08T03:42:03.108Z,1525750923.108 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:03.231Z,1525750923.231 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026669 s
2018-05-08T03:42:03.509Z,1525750923.509 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:03.649Z,1525750923.649 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026493 s
2018-05-08T03:42:03.909Z,1525750923.909 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:04.131Z,1525750924.131 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026304 s
2018-05-08T03:42:04.309Z,1525750924.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:04.417Z,1525750924.417 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026513 s
2018-05-08T03:42:04.709Z,1525750924.709 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:04.817Z,1525750924.817 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026414 s
2018-05-08T03:42:05.109Z,1525750925.109 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:05.227Z,1525750925.227 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026410 s
2018-05-08T03:42:05.509Z,1525750925.509 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:05.604Z,1525750925.604 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026490 s
2018-05-08T03:42:05.909Z,1525750925.909 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:06.017Z,1525750926.017 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026414 s
2018-05-08T03:42:06.309Z,1525750926.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:06.421Z,1525750926.421 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026396 s
2018-05-08T03:42:06.708Z,1525750926.708 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:06.816Z,1525750926.816 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026554 s
2018-05-08T03:42:07.108Z,1525750927.108 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:07.219Z,1525750927.219 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026638 s
2018-05-08T03:42:07.509Z,1525750927.509 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:07.621Z,1525750927.621 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026668 s
2018-05-08T03:42:07.908Z,1525750927.908 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:08.021Z,1525750928.021 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026583 s
2018-05-08T03:42:08.309Z,1525750928.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:08.425Z,1525750928.425 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026530 s
2018-05-08T03:42:08.709Z,1525750928.709 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:08.819Z,1525750928.819 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026323 s
2018-05-08T03:42:09.109Z,1525750929.109 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:09.220Z,1525750929.220 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026529 s
2018-05-08T03:42:09.509Z,1525750929.509 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:09.611Z,1525750929.611 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026225 s
2018-05-08T03:42:09.909Z,1525750929.909 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:10.017Z,1525750930.017 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026320 s
2018-05-08T03:42:10.309Z,1525750930.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:10.396Z,1525750930.396 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026501 s
2018-05-08T03:42:10.709Z,1525750930.709 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:10.800Z,1525750930.800 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026591 s
2018-05-08T03:42:11.109Z,1525750931.109 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:11.204Z,1525750931.204 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026395 s
2018-05-08T03:42:11.509Z,1525750931.509 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:11.597Z,1525750931.597 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026524 s
2018-05-08T03:42:11.909Z,1525750931.909 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:12.001Z,1525750932.001 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026263 s
2018-05-08T03:42:12.309Z,1525750932.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:12.399Z,1525750932.399 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026406 s
2018-05-08T03:42:12.709Z,1525750932.709 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:12.793Z,1525750932.793 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026620 s
2018-05-08T03:42:13.109Z,1525750933.109 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:13.198Z,1525750933.198 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026428 s
2018-05-08T03:42:13.509Z,1525750933.509 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:13.602Z,1525750933.602 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.025781 s
2018-05-08T03:42:13.908Z,1525750933.908 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:14.005Z,1525750934.005 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026744 s
2018-05-08T03:42:14.309Z,1525750934.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:14.400Z,1525750934.400 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026732 s
2018-05-08T03:42:14.710Z,1525750934.710 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:14.842Z,1525750934.842 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.025485 s
2018-05-08T03:42:15.109Z,1525750935.109 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:15.212Z,1525750935.212 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.029650 s
2018-05-08T03:42:15.509Z,1525750935.509 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:15.601Z,1525750935.601 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026452 s
2018-05-08T03:42:15.909Z,1525750935.909 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:16.158Z,1525750936.158 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026396 s
2018-05-08T03:42:16.309Z,1525750936.309 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:16.827Z,1525750936.827 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026395 s
2018-05-08T03:42:16.832Z,1525750936.832 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:17.019Z,1525750937.019 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.027447 s
2018-05-08T03:42:17.233Z,1525750937.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:17.423Z,1525750937.423 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.030594 s
2018-05-08T03:42:17.633Z,1525750937.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:17.811Z,1525750937.811 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026538 s
2018-05-08T03:42:18.033Z,1525750938.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:18.215Z,1525750938.215 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026415 s
2018-05-08T03:42:18.433Z,1525750938.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:18.619Z,1525750938.619 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026257 s
2018-05-08T03:42:18.833Z,1525750938.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:19.095Z,1525750939.095 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.030544 s
2018-05-08T03:42:19.233Z,1525750939.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:19.603Z,1525750939.603 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.026470 s
2018-05-08T03:42:19.633Z,1525750939.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:19.759Z,1525750939.759 [Reporter](INFO): AHRS_M2.durationOfLastRun 0.030402 s
2018-05-08T03:42:19.978Z,1525750939.978 [CommandLine](IMPORTANT): got command report clear
2018-05-08T03:42:20.033Z,1525750940.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:20.433Z,1525750940.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:20.834Z,1525750940.834 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:21.232Z,1525750941.232 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:21.633Z,1525750941.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:22.033Z,1525750942.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:22.433Z,1525750942.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:22.833Z,1525750942.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:23.233Z,1525750943.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:23.632Z,1525750943.632 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:24.033Z,1525750944.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:24.433Z,1525750944.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:24.833Z,1525750944.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:25.233Z,1525750945.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:25.633Z,1525750945.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:26.032Z,1525750946.032 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:26.436Z,1525750946.436 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:26.832Z,1525750946.832 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:27.233Z,1525750947.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:27.632Z,1525750947.632 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:28.033Z,1525750948.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:28.115Z,1525750948.115 [SBIT](IMPORTANT): SBIT PASSED
2018-05-08T03:42:28.194Z,1525750948.194 [CommandLine](IMPORTANT): got command configSet list
2018-05-08T03:42:28.194Z,1525750948.194 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2018-05-08T03:42:28.195Z,1525750948.195 [CommandLine](IMPORTANT): CBIT.abortDepth=300 meter;

2018-05-08T03:42:28.195Z,1525750948.195 [CommandLine](IMPORTANT): CBIT.gf24Offset=107 microampere;

2018-05-08T03:42:28.195Z,1525750948.195 [CommandLine](IMPORTANT): CBIT.stopDepth=285 meter;

2018-05-08T03:42:28.195Z,1525750948.195 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2018-05-08T03:42:28.195Z,1525750948.195 [CommandLine](IMPORTANT): ESPComponent.simulateHardware=0 bool;

2018-05-08T03:42:28.195Z,1525750948.195 [CommandLine](IMPORTANT): ElevatorOffsetCalculator.loadAtStartup=1 bool;

2018-05-08T03:42:28.196Z,1525750948.196 [CommandLine](IMPORTANT): NAL9602.simulateHardware=1 bool;

2018-05-08T03:42:28.196Z,1525750948.196 [CommandLine](IMPORTANT): Normal all CTD_Seabird.sea_water_salinity;

2018-05-08T03:42:28.196Z,1525750948.196 [CommandLine](IMPORTANT): Normal all CTD_Seabird.sea_water_temperature;

2018-05-08T03:42:28.196Z,1525750948.196 [CommandLine](IMPORTANT): Rowe_600LCM.loadAtStartup=0 bool;

2018-05-08T03:42:28.196Z,1525750948.196 [CommandLine](IMPORTANT): RudderServo.offsetAngle=0.5 degree;

2018-05-08T03:42:28.196Z,1525750948.196 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=130 cubic_centimeter;

2018-05-08T03:42:28.196Z,1525750948.196 [CommandLine](IMPORTANT): VerticalControl.massDefault=8 millimeter;

2018-05-08T03:42:28.433Z,1525750948.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:28.505Z,1525750948.505 [MissionManager](IMPORTANT): Started mission Startup
2018-05-08T03:42:28.505Z,1525750948.505 [Startup] Running Loop=1
2018-05-08T03:42:28.505Z,1525750948.505 [Startup](DEBUG): Aggregate::initialize Startup
2018-05-08T03:42:28.505Z,1525750948.505 [Startup:A.GoToSurface] Running Loop=1
2018-05-08T03:42:28.506Z,1525750948.506 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-05-08T03:42:28.506Z,1525750948.506 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-05-08T03:42:28.507Z,1525750948.507 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-05-08T03:42:28.507Z,1525750948.507 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-05-08T03:42:28.508Z,1525750948.508 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-05-08T03:42:28.508Z,1525750948.508 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-05-08T03:42:28.514Z,1525750948.514 [Startup:StartupSatComms] Running Loop=1
2018-05-08T03:42:28.514Z,1525750948.514 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2018-05-08T03:42:28.514Z,1525750948.514 [Startup:StartupSatComms:A] Running Loop=1
2018-05-08T03:42:28.833Z,1525750948.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:28.910Z,1525750948.910 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2018-05-08T03:42:29.233Z,1525750949.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:29.633Z,1525750949.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:30.033Z,1525750950.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:30.433Z,1525750950.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:30.832Z,1525750950.832 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:31.233Z,1525750951.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:31.633Z,1525750951.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:32.032Z,1525750952.032 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:32.433Z,1525750952.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:32.833Z,1525750952.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:33.232Z,1525750953.232 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:33.633Z,1525750953.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:34.033Z,1525750954.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:34.432Z,1525750954.432 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:34.833Z,1525750954.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:35.233Z,1525750955.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:35.633Z,1525750955.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:36.033Z,1525750956.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:36.433Z,1525750956.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:36.832Z,1525750956.832 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:37.233Z,1525750957.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:37.633Z,1525750957.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:38.033Z,1525750958.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:38.433Z,1525750958.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:38.833Z,1525750958.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:39.233Z,1525750959.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:39.632Z,1525750959.632 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:40.033Z,1525750960.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:40.433Z,1525750960.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:40.833Z,1525750960.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:41.233Z,1525750961.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:41.632Z,1525750961.632 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:42.033Z,1525750962.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:42.433Z,1525750962.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:42.832Z,1525750962.832 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:43.232Z,1525750963.232 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:43.633Z,1525750963.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:44.033Z,1525750964.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:44.433Z,1525750964.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:44.833Z,1525750964.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:45.233Z,1525750965.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:45.633Z,1525750965.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:46.033Z,1525750966.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:46.432Z,1525750966.432 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:46.833Z,1525750966.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:47.233Z,1525750967.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:47.633Z,1525750967.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:48.033Z,1525750968.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:48.433Z,1525750968.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:48.832Z,1525750968.832 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:49.233Z,1525750969.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:49.633Z,1525750969.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:50.033Z,1525750970.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:50.433Z,1525750970.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:50.833Z,1525750970.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:51.233Z,1525750971.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:51.633Z,1525750971.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:52.033Z,1525750972.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:52.432Z,1525750972.432 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:52.832Z,1525750972.832 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:53.233Z,1525750973.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:53.633Z,1525750973.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:54.033Z,1525750974.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:54.433Z,1525750974.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:54.833Z,1525750974.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:55.233Z,1525750975.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:55.633Z,1525750975.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:56.033Z,1525750976.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:56.433Z,1525750976.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:56.836Z,1525750976.836 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:57.233Z,1525750977.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:57.633Z,1525750977.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:58.033Z,1525750978.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:58.432Z,1525750978.432 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:58.833Z,1525750978.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:59.233Z,1525750979.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:42:59.633Z,1525750979.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:00.033Z,1525750980.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:00.433Z,1525750980.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:00.833Z,1525750980.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:01.233Z,1525750981.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:01.633Z,1525750981.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:02.033Z,1525750982.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:02.433Z,1525750982.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:02.836Z,1525750982.836 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:03.233Z,1525750983.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:03.633Z,1525750983.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:04.033Z,1525750984.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:04.433Z,1525750984.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:04.833Z,1525750984.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:05.233Z,1525750985.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:05.633Z,1525750985.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:06.033Z,1525750986.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:06.434Z,1525750986.434 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:06.833Z,1525750986.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:07.233Z,1525750987.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:07.633Z,1525750987.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:08.032Z,1525750988.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:08.433Z,1525750988.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:08.833Z,1525750988.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:09.233Z,1525750989.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:09.633Z,1525750989.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:10.033Z,1525750990.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:10.433Z,1525750990.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:10.833Z,1525750990.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:11.233Z,1525750991.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:11.633Z,1525750991.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:12.033Z,1525750992.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:12.433Z,1525750992.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:12.833Z,1525750992.833 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:13.233Z,1525750993.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:13.636Z,1525750993.636 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:14.036Z,1525750994.036 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:14.436Z,1525750994.436 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:14.462Z,1525750994.462 [AHRS_M2](ERROR): Read Heading/Pitch/Roll Failure.
2018-05-08T03:43:14.462Z,1525750994.462 [AHRS_M2] Communications Fault, FailCount= 1
2018-05-08T03:43:14.462Z,1525750994.462 [AHRS_M2](ERROR): Communications Fault
2018-05-08T03:43:14.559Z,1525750994.559 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.431634 seconds old.
2018-05-08T03:43:14.560Z,1525750994.560 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.432063 seconds old.
2018-05-08T03:43:14.629Z,1525750994.629 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2018-05-08T03:43:14.833Z,1525750994.833 [AHRS_M2](INFO): Stop
2018-05-08T03:43:14.833Z,1525750994.833 [AHRS_M2](INFO): uninitialize
2018-05-08T03:43:14.833Z,1525750994.833 [AHRS_M2](INFO): Powering down
2018-05-08T03:43:14.951Z,1525750994.951 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 0.823942 seconds old.
2018-05-08T03:43:14.973Z,1525750994.973 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 0.824347 seconds old.
2018-05-08T03:43:15.233Z,1525750995.233 [AHRS_M2](INFO): Stopping
2018-05-08T03:43:15.294Z,1525750995.294 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.166448 seconds old.
2018-05-08T03:43:15.295Z,1525750995.295 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.166861 seconds old.
2018-05-08T03:43:15.635Z,1525750995.635 [AHRS_M2](INFO): Stopping
2018-05-08T03:43:15.687Z,1525750995.687 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.560109 seconds old.
2018-05-08T03:43:15.697Z,1525750995.697 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.560519 seconds old.
2018-05-08T03:43:16.037Z,1525750996.037 [AHRS_M2](INFO): Stopping
2018-05-08T03:43:16.105Z,1525750996.105 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 1.978119 seconds old.
2018-05-08T03:43:16.107Z,1525750996.107 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 1.978530 seconds old.
2018-05-08T03:43:16.433Z,1525750996.433 [AHRS_M2](INFO): Stopped
2018-05-08T03:43:16.518Z,1525750996.518 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.390980 seconds old.
2018-05-08T03:43:16.519Z,1525750996.519 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.391396 seconds old.
2018-05-08T03:43:16.556Z,1525750996.556 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-05-08T03:43:16.556Z,1525750996.556 [AHRS_M2] No Fault, FailCount= 1
2018-05-08T03:43:16.833Z,1525750996.833 [AHRS_M2](INFO): Start
2018-05-08T03:43:16.833Z,1525750996.833 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-05-08T03:43:16.902Z,1525750996.902 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 2.774939 seconds old.
2018-05-08T03:43:16.903Z,1525750996.903 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 2.775335 seconds old.
2018-05-08T03:43:17.233Z,1525750997.233 [AHRS_M2](INFO): Starting
2018-05-08T03:43:17.302Z,1525750997.302 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.174463 seconds old.
2018-05-08T03:43:17.303Z,1525750997.303 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.174881 seconds old.
2018-05-08T03:43:17.633Z,1525750997.633 [AHRS_M2](INFO): Starting
2018-05-08T03:43:17.694Z,1525750997.694 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.566952 seconds old.
2018-05-08T03:43:17.695Z,1525750997.695 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 3.567400 seconds old.
2018-05-08T03:43:18.035Z,1525750998.035 [AHRS_M2](INFO): Starting
2018-05-08T03:43:18.065Z,1525750998.065 [AHRS_M2](FAULT): AHRS_M2 failed to initialize
2018-05-08T03:43:18.066Z,1525750998.066 [AHRS_M2] Hardware Fault, FailCount= 2
2018-05-08T03:43:18.066Z,1525750998.066 [AHRS_M2](ERROR): Hardware Fault
2018-05-08T03:43:18.127Z,1525750998.127 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 3.999648 seconds old.
2018-05-08T03:43:18.128Z,1525750998.128 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.000056 seconds old.
2018-05-08T03:43:18.172Z,1525750998.172 [CBIT](ERROR): Hardware Fault in component: AHRS_M2
2018-05-08T03:43:18.433Z,1525750998.433 [AHRS_M2](INFO): Stop
2018-05-08T03:43:18.433Z,1525750998.433 [AHRS_M2](INFO): uninitialize
2018-05-08T03:43:18.433Z,1525750998.433 [AHRS_M2](INFO): Powering down
2018-05-08T03:43:18.581Z,1525750998.581 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.449429 seconds old.
2018-05-08T03:43:18.582Z,1525750998.582 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.454223 seconds old.
2018-05-08T03:43:18.833Z,1525750998.833 [AHRS_M2](INFO): Stopping
2018-05-08T03:43:18.888Z,1525750998.888 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 4.760351 seconds old.
2018-05-08T03:43:18.889Z,1525750998.889 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 4.761111 seconds old.
2018-05-08T03:43:19.233Z,1525750999.233 [AHRS_M2](INFO): Stopping
2018-05-08T03:43:19.282Z,1525750999.282 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.154458 seconds old.
2018-05-08T03:43:19.283Z,1525750999.283 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.154858 seconds old.
2018-05-08T03:43:19.632Z,1525750999.632 [AHRS_M2](INFO): Stopping
2018-05-08T03:43:19.679Z,1525750999.679 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.551820 seconds old.
2018-05-08T03:43:19.680Z,1525750999.680 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.552221 seconds old.
2018-05-08T03:43:20.032Z,1525751000.032 [AHRS_M2](INFO): Stopped
2018-05-08T03:43:20.075Z,1525751000.075 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 5.947551 seconds old.
2018-05-08T03:43:20.076Z,1525751000.076 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 5.947943 seconds old.
2018-05-08T03:43:20.087Z,1525751000.087 [CBIT](INFO): Clearing failed state for component AHRS_M2
2018-05-08T03:43:20.087Z,1525751000.087 [AHRS_M2] No Fault, FailCount= 2
2018-05-08T03:43:20.433Z,1525751000.433 [AHRS_M2](INFO): Start
2018-05-08T03:43:20.433Z,1525751000.433 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2018-05-08T03:43:20.479Z,1525751000.479 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 6.351577 seconds old.
2018-05-08T03:43:20.480Z,1525751000.480 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 6.351984 seconds old.
2018-05-08T03:43:20.833Z,1525751000.833 [AHRS_M2](INFO): Starting
2018-05-08T03:43:20.877Z,1525751000.877 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 6.750189 seconds old.
2018-05-08T03:43:20.879Z,1525751000.879 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 6.750590 seconds old.
2018-05-08T03:43:21.232Z,1525751001.232 [AHRS_M2](INFO): Starting
2018-05-08T03:43:21.282Z,1525751001.282 [DeadReckonUsingMultipleVelocitySources](DEBUG): Most recent orientation data is 7.154264 seconds old.
2018-05-08T03:43:21.283Z,1525751001.283 [DeadReckonUsingSpeedCalculator](DEBUG): Most recent orientation data is 7.154660 seconds old.
2018-05-08T03:43:21.633Z,1525751001.633 [AHRS_M2](INFO): Starting
2018-05-08T03:43:22.032Z,1525751002.032 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:22.432Z,1525751002.432 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:22.832Z,1525751002.832 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:23.233Z,1525751003.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:23.633Z,1525751003.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:24.032Z,1525751004.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:24.433Z,1525751004.433 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:24.832Z,1525751004.832 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:25.233Z,1525751005.233 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:25.632Z,1525751005.632 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:26.033Z,1525751006.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:26.432Z,1525751006.432 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:26.613Z,1525751006.613 [CommandLine](IMPORTANT): got command restart application
2018-05-08T03:43:26.835Z,1525751006.835 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:27.235Z,1525751007.235 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:27.620Z,1525751007.620 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-08T03:43:27.620Z,1525751007.620 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:27.633Z,1525751007.633 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:27.805Z,1525751007.805 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2018-05-08T03:43:27.805Z,1525751007.805 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:27.805Z,1525751007.805 [CommandLine](INFO): Join timeout helper Thread ID is 661
2018-05-08T03:43:27.806Z,1525751007.806 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2018-05-08T03:43:27.806Z,1525751007.806 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:27.807Z,1525751007.807 [NavChartDb](INFO): Join timeout helper Thread ID is 662
2018-05-08T03:43:28.001Z,1525751008.001 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-08T03:43:28.001Z,1525751008.001 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:28.005Z,1525751008.005 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2018-05-08T03:43:28.005Z,1525751008.005 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:28.005Z,1525751008.005 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 663
2018-05-08T03:43:28.006Z,1525751008.006 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-08T03:43:28.006Z,1525751008.006 [WetLabsBB2FL](INFO): Powering down
2018-05-08T03:43:28.007Z,1525751008.007 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:28.007Z,1525751008.007 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2018-05-08T03:43:28.007Z,1525751008.007 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:28.008Z,1525751008.008 [CTD_Seabird](INFO): Join timeout helper Thread ID is 664
2018-05-08T03:43:28.033Z,1525751008.033 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:28.385Z,1525751008.385 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-08T03:43:28.434Z,1525751008.434 [AHRS_M2](INFO): Runnable
2018-05-08T03:43:28.532Z,1525751008.532 [Startup:StartupSatComms:A](INFO): Timed out from 2018-05-08T03:42:28.5Z
2018-05-08T03:43:28.532Z,1525751008.532 [Startup:StartupSatComms:A] Stopped
2018-05-08T03:43:28.532Z,1525751008.532 [Startup:StartupSatComms:B] Running Loop=1
2018-05-08T03:43:28.573Z,1525751008.573 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface
2018-05-08T03:43:28.573Z,1525751008.573 [CTD_Seabird](INFO): Powering down
2018-05-08T03:43:28.574Z,1525751008.574 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:28.577Z,1525751008.577 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2018-05-08T03:43:28.577Z,1525751008.577 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:28.577Z,1525751008.577 [Radio_Surface](INFO): Join timeout helper Thread ID is 666
2018-05-08T03:43:28.641Z,1525751008.641 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-08T03:43:28.641Z,1525751008.641 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:28.658Z,1525751008.658 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2018-05-08T03:43:28.658Z,1525751008.658 [logger ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:28.658Z,1525751008.658 [logger](INFO): Join timeout helper Thread ID is 667
2018-05-08T03:43:28.693Z,1525751008.693 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-08T03:43:28.693Z,1525751008.693 [logger ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:28.697Z,1525751008.697 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2018-05-08T03:43:28.698Z,1525751008.698 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:28.698Z,1525751008.698 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2018-05-08T03:43:28.698Z,1525751008.698 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:28.698Z,1525751008.698 [controlThread](INFO): Join timeout helper Thread ID is 668
2018-05-08T03:43:28.829Z,1525751008.829 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2018-05-08T03:43:28.829Z,1525751008.829 [controlThread](DEBUG): Uninitializing ControlThread
2018-05-08T03:43:28.829Z,1525751008.829 [AHRS_M2](INFO): uninitialize
2018-05-08T03:43:28.830Z,1525751008.830 [AHRS_M2](INFO): Powering down
2018-05-08T03:43:28.901Z,1525751008.901 [AcousticModem_Benthos_ATM900](INFO): Powering down
2018-05-08T03:43:29.021Z,1525751009.021 [NAL9602](INFO): Powering down
2018-05-08T03:43:29.023Z,1525751009.023 [Aanderaa_O2](INFO): Powering down
2018-05-08T03:43:29.025Z,1525751009.025 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-05-08T03:43:29.026Z,1525751009.026 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2018-05-08T03:43:29.027Z,1525751009.027 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2018-05-08T03:43:29.028Z,1525751009.028 [MissionManager](INFO): Uninitializing Mission Default
2018-05-08T03:43:29.030Z,1525751009.030 [MissionManager](INFO): Uninitializing Mission Startup
2018-05-08T03:43:29.030Z,1525751009.030 [Startup] Stopped
2018-05-08T03:43:29.031Z,1525751009.031 [Startup](DEBUG): Aggregate::uninitialize Startup
2018-05-08T03:43:29.031Z,1525751009.031 [Startup:A.GoToSurface] Stopped
2018-05-08T03:43:29.031Z,1525751009.031 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-05-08T03:43:29.031Z,1525751009.031 [Startup:StartupSatComms] Stopped
2018-05-08T03:43:29.031Z,1525751009.031 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2018-05-08T03:43:29.031Z,1525751009.031 [Startup:StartupSatComms:B] Stopped
2018-05-08T03:43:29.033Z,1525751009.033 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2018-05-08T03:43:29.033Z,1525751009.033 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2018-05-08T03:43:29.033Z,1525751009.033 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2018-05-08T03:43:29.034Z,1525751009.034 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2018-05-08T03:43:29.034Z,1525751009.034 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-05-08T03:43:29.034Z,1525751009.034 [BuoyancyServo](INFO): Powering down
2018-05-08T03:43:29.049Z,1525751009.049 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2018-05-08T03:43:29.049Z,1525751009.049 [ElevatorServo](INFO): Powering down
2018-05-08T03:43:29.050Z,1525751009.050 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-05-08T03:43:29.050Z,1525751009.050 [MassServo](INFO): Powering down
2018-05-08T03:43:29.051Z,1525751009.051 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2018-05-08T03:43:29.051Z,1525751009.051 [RudderServo](INFO): Powering down
2018-05-08T03:43:29.052Z,1525751009.052 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-05-08T03:43:29.052Z,1525751009.052 [ThrusterServo](INFO): Powering down
2018-05-08T03:43:29.053Z,1525751009.053 [SBIT](DEBUG): Uninitialize SBIT Component.
2018-05-08T03:43:29.053Z,1525751009.053 [IBIT](DEBUG): Uninitialize IBIT Component.
2018-05-08T03:43:29.053Z,1525751009.053 [CBIT](DEBUG): Uninitialize CBIT Component.
2018-05-08T03:43:29.054Z,1525751009.054 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:29.140Z,1525751009.140 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:29.180Z,1525751009.180 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:29.185Z,1525751009.185 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:29.233Z,1525751009.233 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-05-08T03:43:29.289Z,1525751009.289 [logger ThreadHandler](INFO): Thread cancelled.