2018-12-12T23:35:58.400Z,1544657758.400 [Supervisor](DEBUG): Initializing supervisor.
2018-12-12T23:35:58.403Z,1544657758.403 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-12-12T23:35:58.404Z,1544657758.404 [SyncHandler](INFO): Protected caller Thread ID is 797
2018-12-12T23:35:58.404Z,1544657758.404 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-12-12T23:35:58.405Z,1544657758.405 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-12-12T23:35:58.405Z,1544657758.405 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 798
2018-12-12T23:35:58.408Z,1544657758.408 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-12-12T23:35:58.420Z,1544657758.420 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-12-12T23:35:58.421Z,1544657758.421 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-12-12T23:35:58.421Z,1544657758.421 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 799
2018-12-12T23:35:58.422Z,1544657758.422 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-12-12T23:35:58.423Z,1544657758.423 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-12-12T23:35:58.423Z,1544657758.423 [logger ThreadHandler](INFO): Protected caller Thread ID is 800
2018-12-12T23:35:58.425Z,1544657758.425 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-12-12T23:35:58.425Z,1544657758.425 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-12-12T23:35:58.429Z,1544657758.429 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-12-12T23:35:58.528Z,1544657758.528 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-12-12T23:35:58.530Z,1544657758.530 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-12-12T23:35:58.630Z,1544657758.630 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-12-12T23:35:58.630Z,1544657758.630 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-12-12T23:35:58.820Z,1544657758.820 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-12-12T23:35:58.821Z,1544657758.821 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-12-12T23:35:59.176Z,1544657759.176 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-12-12T23:35:59.178Z,1544657759.178 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-12-12T23:35:59.495Z,1544657759.495 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-12-12T23:35:59.495Z,1544657759.495 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-12-12T23:35:59.945Z,1544657759.945 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-12-12T23:35:59.947Z,1544657759.947 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-12-12T23:36:00.413Z,1544657760.413 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-12-12T23:36:00.414Z,1544657760.414 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-12-12T23:36:00.857Z,1544657760.857 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-12-12T23:36:00.859Z,1544657760.859 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-12-12T23:36:00.941Z,1544657760.941 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-12-12T23:36:01.244Z,1544657761.244 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-12-12T23:36:01.246Z,1544657761.246 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-12-12T23:36:01.392Z,1544657761.392 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-12-12T23:36:01.393Z,1544657761.393 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-12-12T23:36:01.607Z,1544657761.607 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-12-12T23:36:01.609Z,1544657761.609 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-12-12T23:36:01.813Z,1544657761.813 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-12-12T23:36:01.814Z,1544657761.814 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-12-12T23:36:02.579Z,1544657762.579 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-12-12T23:36:02.580Z,1544657762.580 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-12-12T23:36:02.748Z,1544657762.748 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-12-12T23:36:02.750Z,1544657762.750 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2018-12-12T23:36:02.752Z,1544657762.752 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2018-12-12T23:36:02.982Z,1544657762.982 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-12-12T23:36:02.983Z,1544657762.983 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2018-12-12T23:36:03.088Z,1544657763.088 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2018-12-12T23:36:03.236Z,1544657763.236 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2018-12-12T23:36:03.329Z,1544657763.329 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2018-12-12T23:36:03.414Z,1544657763.414 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2018-12-12T23:36:03.565Z,1544657763.565 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2018-12-12T23:36:03.753Z,1544657763.753 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2018-12-12T23:36:03.851Z,1544657763.851 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2018-12-12T23:36:03.946Z,1544657763.946 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2018-12-12T23:36:04.043Z,1544657764.043 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2018-12-12T23:36:04.125Z,1544657764.125 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-12-12T23:36:04.133Z,1544657764.133 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-12-12T23:36:04.262Z,1544657764.262 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-12-12T23:36:04.263Z,1544657764.263 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-12-12T23:36:04.287Z,1544657764.287 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-12-12T23:36:04.288Z,1544657764.288 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-12-12T23:36:04.345Z,1544657764.345 [DepthRateCalculator] Loaded
2018-12-12T23:36:04.345Z,1544657764.345 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-12-12T23:36:04.351Z,1544657764.351 [PitchRateCalculator] Loaded
2018-12-12T23:36:04.351Z,1544657764.351 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-12-12T23:36:04.367Z,1544657764.367 [SpeedCalculator] Loaded
2018-12-12T23:36:04.368Z,1544657764.368 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-12-12T23:36:04.388Z,1544657764.388 [TempGradientCalculator] Loaded
2018-12-12T23:36:04.388Z,1544657764.388 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-12-12T23:36:04.394Z,1544657764.394 [YawRateCalculator] Loaded
2018-12-12T23:36:04.394Z,1544657764.394 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-12-12T23:36:04.434Z,1544657764.434 [ElevatorOffsetCalculator] Loaded
2018-12-12T23:36:04.435Z,1544657764.435 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-12-12T23:36:04.435Z,1544657764.435 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-12-12T23:36:04.436Z,1544657764.436 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-12-12T23:36:04.477Z,1544657764.477 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-12-12T23:36:04.477Z,1544657764.477 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-12-12T23:36:04.983Z,1544657764.983 [AcousticModem_Benthos_ATM900] Loaded
2018-12-12T23:36:04.983Z,1544657764.983 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2018-12-12T23:36:05.118Z,1544657765.118 [DataOverHttps] Loaded
2018-12-12T23:36:05.118Z,1544657765.118 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-12-12T23:36:05.132Z,1544657765.132 [Depth_Keller] Loaded
2018-12-12T23:36:05.133Z,1544657765.133 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-12-12T23:36:05.137Z,1544657765.137 [DropWeight] Loaded
2018-12-12T23:36:05.138Z,1544657765.138 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2018-12-12T23:36:05.236Z,1544657765.236 [NAL9602] Loaded
2018-12-12T23:36:05.236Z,1544657765.236 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-12-12T23:36:05.252Z,1544657765.252 [Onboard] Loaded
2018-12-12T23:36:05.252Z,1544657765.252 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-12-12T23:36:05.262Z,1544657765.262 [Radio_Surface] Loaded
2018-12-12T23:36:05.262Z,1544657765.262 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-12-12T23:36:05.263Z,1544657765.263 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407CE4E0
2018-12-12T23:36:05.264Z,1544657765.264 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 879
2018-12-12T23:36:05.417Z,1544657765.417 [PNI_TCM] Loaded
2018-12-12T23:36:05.417Z,1544657765.417 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2018-12-12T23:36:05.477Z,1544657765.477 [Rowe_600LCM] Loaded
2018-12-12T23:36:05.478Z,1544657765.478 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread.
2018-12-12T23:36:05.479Z,1544657765.479 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 407FE4E0
2018-12-12T23:36:05.479Z,1544657765.479 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 880
2018-12-12T23:36:07.349Z,1544657767.349 [BPC1] Loaded
2018-12-12T23:36:07.349Z,1544657767.349 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-12-12T23:36:07.350Z,1544657767.350 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-12-12T23:36:07.350Z,1544657767.350 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-12-12T23:36:07.584Z,1544657767.584 [SBIT](DEBUG): Construct Startup Built In Test.
2018-12-12T23:36:07.606Z,1544657767.606 [SBIT] Loaded
2018-12-12T23:36:07.607Z,1544657767.607 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-12-12T23:36:07.607Z,1544657767.607 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-12-12T23:36:07.619Z,1544657767.619 [IBIT] Loaded
2018-12-12T23:36:07.619Z,1544657767.619 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-12-12T23:36:07.622Z,1544657767.622 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-12-12T23:36:07.760Z,1544657767.760 [CBIT] Loaded
2018-12-12T23:36:07.760Z,1544657767.760 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-12-12T23:36:07.761Z,1544657767.761 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-12-12T23:36:07.761Z,1544657767.761 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-12-12T23:36:07.995Z,1544657767.995 [Aanderaa_O2] Loaded
2018-12-12T23:36:07.995Z,1544657767.995 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2018-12-12T23:36:08.078Z,1544657768.078 [CTD_Seabird] Loaded
2018-12-12T23:36:08.078Z,1544657768.078 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2018-12-12T23:36:08.079Z,1544657768.079 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 408DD4E0
2018-12-12T23:36:08.079Z,1544657768.079 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 881
2018-12-12T23:36:08.097Z,1544657768.097 [ESPComponent] Loaded
2018-12-12T23:36:08.097Z,1544657768.097 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2018-12-12T23:36:08.111Z,1544657768.111 [PAR_Licor] Loaded
2018-12-12T23:36:08.112Z,1544657768.112 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2018-12-12T23:36:08.160Z,1544657768.160 [WetLabsBB2FL] Loaded
2018-12-12T23:36:08.160Z,1544657768.160 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2018-12-12T23:36:08.161Z,1544657768.161 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4090D4E0
2018-12-12T23:36:08.162Z,1544657768.162 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 882
2018-12-12T23:36:08.162Z,1544657768.162 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-12-12T23:36:08.164Z,1544657768.164 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-12-12T23:36:08.451Z,1544657768.451 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-12-12T23:36:08.452Z,1544657768.452 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-12-12T23:36:08.543Z,1544657768.543 [VerticalControl](DEBUG): Construct VerticalControl.
2018-12-12T23:36:08.636Z,1544657768.636 [VerticalControl] Loaded
2018-12-12T23:36:08.637Z,1544657768.636 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-12-12T23:36:08.637Z,1544657768.637 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-12-12T23:36:08.698Z,1544657768.698 [HorizontalControl] Loaded
2018-12-12T23:36:08.698Z,1544657768.698 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-12-12T23:36:08.699Z,1544657768.699 [SpeedControl](DEBUG): Construct SpeedControl.
2018-12-12T23:36:08.704Z,1544657768.704 [SpeedControl] Loaded
2018-12-12T23:36:08.704Z,1544657768.704 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-12-12T23:36:08.705Z,1544657768.705 [LoopControl](DEBUG): Construct LoopControl.
2018-12-12T23:36:08.706Z,1544657768.706 [LoopControl] Loaded
2018-12-12T23:36:08.706Z,1544657768.706 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-12-12T23:36:08.706Z,1544657768.706 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-12-12T23:36:08.708Z,1544657768.708 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-12-12T23:36:08.811Z,1544657768.811 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-12-12T23:36:08.812Z,1544657768.812 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-12-12T23:36:08.933Z,1544657768.933 [BuoyancyServo] Loaded
2018-12-12T23:36:08.934Z,1544657768.934 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-12-12T23:36:08.945Z,1544657768.945 [ElevatorServo] Loaded
2018-12-12T23:36:08.945Z,1544657768.945 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-12-12T23:36:08.956Z,1544657768.956 [MassServo] Loaded
2018-12-12T23:36:08.956Z,1544657768.956 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-12-12T23:36:08.967Z,1544657768.967 [RudderServo] Loaded
2018-12-12T23:36:08.968Z,1544657768.968 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-12-12T23:36:08.979Z,1544657768.979 [ThrusterServo] Loaded
2018-12-12T23:36:08.979Z,1544657768.979 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-12-12T23:36:08.979Z,1544657768.979 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-12-12T23:36:08.980Z,1544657768.980 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-12-12T23:36:09.093Z,1544657769.093 [DeadReckonUsingSpeedCalculator] Loaded
2018-12-12T23:36:09.093Z,1544657769.093 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-12-12T23:36:09.110Z,1544657769.110 [NavChart] Loaded
2018-12-12T23:36:09.110Z,1544657769.110 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-12-12T23:36:09.114Z,1544657769.114 [UniversalFixResidualReporter] Loaded
2018-12-12T23:36:09.114Z,1544657769.114 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-12-12T23:36:09.115Z,1544657769.115 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-12-12T23:36:09.119Z,1544657769.119 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-12-12T23:36:09.119Z,1544657769.119 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-12-12T23:36:09.126Z,1544657769.126 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-12-12T23:36:09.127Z,1544657769.127 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A664E0
2018-12-12T23:36:09.127Z,1544657769.127 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 883
2018-12-12T23:36:09.132Z,1544657769.132 [Supervisor](INFO): Main Thread ID is 793
2018-12-12T23:36:09.132Z,1544657769.132 [Supervisor](DEBUG): Running supervisor.
2018-12-12T23:36:09.133Z,1544657769.133 [CommandLine ThreadHandler](INFO): Handler Thread ID is 884
2018-12-12T23:36:09.136Z,1544657769.136 [controlThread ThreadHandler](INFO): Handler Thread ID is 885
2018-12-12T23:36:09.136Z,1544657769.136 [controlThread](DEBUG): Initializing ControlThread
2018-12-12T23:36:09.137Z,1544657769.137 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-12-12T23:36:09.137Z,1544657769.137 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-12-12T23:36:09.138Z,1544657769.138 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-12-12T23:36:09.138Z,1544657769.138 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-12-12T23:36:09.138Z,1544657769.138 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-12-12T23:36:09.139Z,1544657769.139 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2018-12-12T23:36:09.143Z,1544657769.143 [SBIT](INFO): Initialize SBIT Component.
2018-12-12T23:36:09.144Z,1544657769.144 [SBIT](IMPORTANT): git: 2018-11-27-15-gd2bbcb2
2018-12-12T23:36:09.144Z,1544657769.144 [SBIT](INFO): git hash: d2bbcb2cc47253c054f62f2101b467732e90375e
2018-12-12T23:36:09.144Z,1544657769.144 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2018-12-12T23:36:09.144Z,1544657769.144 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018
2018-12-12T23:36:09.145Z,1544657769.145 [SBIT](INFO): Beginning SBIT in 24.000000 seconds.
2018-12-12T23:36:09.146Z,1544657769.146 [IBIT](INFO): Initialize IBIT Component.
2018-12-12T23:36:09.147Z,1544657769.147 [CBIT](DEBUG): Initialize CBIT Component.
2018-12-12T23:36:09.148Z,1544657769.148 [logger ThreadHandler](INFO): Handler Thread ID is 886
2018-12-12T23:36:09.161Z,1544657769.161 [CBIT](DEBUG): Initialized mux pins.
2018-12-12T23:36:09.161Z,1544657769.161 [CBIT](DEBUG): Initializing the watchdog timer.
2018-12-12T23:36:09.165Z,1544657769.165 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 887
2018-12-12T23:36:09.171Z,1544657769.171 [Radio_Surface](INFO): Powering up
2018-12-12T23:36:09.181Z,1544657769.181 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 888
2018-12-12T23:36:09.182Z,1544657769.182 [Rowe_600LCM](INFO): Initializing
2018-12-12T23:36:09.182Z,1544657769.182 [Rowe_600LCM](INFO): Checking LCM
2018-12-12T23:36:09.185Z,1544657769.185 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2018-12-12T23:36:09.185Z,1544657769.185 [CBIT](DEBUG): Initializing heartbeat.
2018-12-12T23:36:09.257Z,1544657769.257 [CBIT](DEBUG): Deactivating GF circuits.
2018-12-12T23:36:09.257Z,1544657769.257 [CBIT](DEBUG): Deactivating emergency mode.
2018-12-12T23:36:09.277Z,1544657769.277 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 889
2018-12-12T23:36:09.278Z,1544657769.278 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:36:09.281Z,1544657769.281 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:36:09.302Z,1544657769.302 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-12-12T23:36:09.303Z,1544657769.303 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-12-12T23:36:09.304Z,1544657769.304 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-12-12T23:36:09.305Z,1544657769.305 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-12-12T23:36:09.306Z,1544657769.306 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-12T23:36:09.307Z,1544657769.307 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-12T23:36:09.307Z,1544657769.307 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-12T23:36:09.308Z,1544657769.308 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-12-12T23:36:09.308Z,1544657769.308 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-12-12T23:36:09.379Z,1544657769.379 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-12-12T23:36:09.390Z,1544657769.390 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 891
2018-12-12T23:36:09.392Z,1544657769.392 [WetLabsBB2FL](INFO): Powering down
2018-12-12T23:36:09.410Z,1544657769.410 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 892
2018-12-12T23:36:09.421Z,1544657769.421 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-12-12T23:36:09.421Z,1544657769.421 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-12-12T23:36:09.421Z,1544657769.421 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-12-12T23:36:09.421Z,1544657769.421 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-12-12T23:36:09.422Z,1544657769.422 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-12-12T23:36:09.422Z,1544657769.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-12-12T23:36:09.422Z,1544657769.422 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-12-12T23:36:09.422Z,1544657769.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-12-12T23:36:09.422Z,1544657769.422 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-12-12T23:36:09.423Z,1544657769.423 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-12-12T23:36:09.423Z,1544657769.423 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-12-12T23:36:09.423Z,1544657769.423 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-12-12T23:36:09.423Z,1544657769.423 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-12-12T23:36:09.423Z,1544657769.423 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-12-12T23:36:09.424Z,1544657769.424 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-12-12T23:36:09.424Z,1544657769.424 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-12-12T23:36:09.530Z,1544657769.530 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-12-12T23:36:09.590Z,1544657769.590 [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-12-12T23:36:09.591Z,1544657769.591 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-12-12T23:36:09.626Z,1544657769.626 [Rowe_600LCM](FAULT): LCM not connected
2018-12-12T23:36:09.626Z,1544657769.626 [Rowe_600LCM] Hardware Fault, FailCount= 1
2018-12-12T23:36:09.626Z,1544657769.626 [Rowe_600LCM](ERROR): Hardware Fault
2018-12-12T23:36:09.648Z,1544657769.648 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-12-12T23:36:09.669Z,1544657769.669 [Default:A.Wait](DEBUG): Construct Wait.
2018-12-12T23:36:09.671Z,1544657769.671 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-12-12T23:36:09.691Z,1544657769.691 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-12-12T23:36:09.721Z,1544657769.721 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-12-12T23:36:09.727Z,1544657769.727 [Default:E.Execute](DEBUG): Construct Execute.
2018-12-12T23:36:09.740Z,1544657769.740 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

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

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

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

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

    </Aggregate>

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

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

</Mission>


2018-12-12T23:36:09.761Z,1544657769.761 [controlThread](DEBUG): Component order: CycleStarter,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,Aanderaa_O2,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-12-12T23:36:09.785Z,1544657769.785 [AcousticModem_Benthos_ATM900](INFO): Powering up
2018-12-12T23:36:09.785Z,1544657769.785 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2018-12-12T23:36:09.812Z,1544657769.812 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-12-12T23:36:10.037Z,1544657770.037 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-12-12T23:36:10.166Z,1544657770.166 [ESPComponent](INFO): powering down ESP
2018-12-12T23:36:10.295Z,1544657770.295 [Rowe_600LCM](INFO): Powering down
2018-12-12T23:36:10.765Z,1544657770.765 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-12-12T23:36:10.773Z,1544657770.773 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-12-12T23:36:10.787Z,1544657770.787 [ElevatorServo](DEBUG): Initializing EZServoServo.
2018-12-12T23:36:10.793Z,1544657770.793 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-12-12T23:36:10.799Z,1544657770.799 [MassServo](DEBUG): Initializing EZServoServo.
2018-12-12T23:36:10.805Z,1544657770.805 [MassServo](DEBUG): Initializing MassServo.
2018-12-12T23:36:10.818Z,1544657770.818 [RudderServo](DEBUG): Initializing EZServoServo.
2018-12-12T23:36:10.825Z,1544657770.825 [RudderServo](DEBUG): Initializing RudderServo.
2018-12-12T23:36:10.842Z,1544657770.842 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-12-12T23:36:10.849Z,1544657770.849 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-12-12T23:36:10.891Z,1544657770.891 [CBIT](ERROR): Hardware Fault in component: Rowe_600LCM
2018-12-12T23:36:11.001Z,1544657771.001 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2018-12-12T23:36:11.001Z,1544657771.001 [DropWeight] Hardware Fault, FailCount= 1
2018-12-12T23:36:11.001Z,1544657771.001 [DropWeight](ERROR): Hardware Fault
2018-12-12T23:36:11.106Z,1544657771.106 [CommandLine](FAULT): Scheduling is paused
2018-12-12T23:36:11.107Z,1544657771.107 [CBIT](INFO): Critical error at 20181212T233611
2018-12-12T23:36:11.107Z,1544657771.107 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2018-12-12T23:36:11.110Z,1544657771.110 [CBIT](ERROR): Hardware Fault in component: DropWeight
2018-12-12T23:36:11.110Z,1544657771.110 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2018-12-12T23:36:11.709Z,1544657771.709 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2018-12-12T23:36:11.709Z,1544657771.709 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2018-12-12T23:36:11.709Z,1544657771.709 [BuoyancyServo] Communications Fault, FailCount= 1
2018-12-12T23:36:11.709Z,1544657771.709 [BuoyancyServo](ERROR): Communications Fault
2018-12-12T23:36:11.914Z,1544657771.914 [CBIT](INFO): Critical error at 20181212T233611
2018-12-12T23:36:11.917Z,1544657771.917 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-12-12T23:36:11.917Z,1544657771.917 [Rowe_600LCM] No Fault, FailCount= 1
2018-12-12T23:36:11.918Z,1544657771.918 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2018-12-12T23:36:11.929Z,1544657771.929 [Rowe_600LCM](INFO): Initializing
2018-12-12T23:36:11.929Z,1544657771.929 [Rowe_600LCM](INFO): Checking LCM
2018-12-12T23:36:11.929Z,1544657771.929 [Rowe_600LCM](FAULT): LCM not connected
2018-12-12T23:36:11.929Z,1544657771.929 [Rowe_600LCM] Hardware Fault, FailCount= 2
2018-12-12T23:36:11.929Z,1544657771.929 [Rowe_600LCM](ERROR): Hardware Fault
2018-12-12T23:36:12.011Z,1544657772.011 [CBIT](ERROR): Hardware Fault in component: Rowe_600LCM
2018-12-12T23:36:12.333Z,1544657772.333 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-12-12T23:36:12.579Z,1544657772.579 [Rowe_600LCM](INFO): Powering down
2018-12-12T23:36:14.014Z,1544657774.014 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-12-12T23:36:14.014Z,1544657774.014 [Rowe_600LCM] No Fault, FailCount= 2
2018-12-12T23:36:14.015Z,1544657774.015 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2018-12-12T23:36:14.015Z,1544657774.015 [BuoyancyServo] No Fault, FailCount= 1
2018-12-12T23:36:14.193Z,1544657774.193 [Rowe_600LCM](INFO): Initializing
2018-12-12T23:36:14.193Z,1544657774.193 [Rowe_600LCM](INFO): Checking LCM
2018-12-12T23:36:14.193Z,1544657774.193 [Rowe_600LCM](FAULT): LCM not connected
2018-12-12T23:36:14.194Z,1544657774.194 [Rowe_600LCM] Hardware Fault, FailCount= 3
2018-12-12T23:36:14.194Z,1544657774.194 [Rowe_600LCM](ERROR): Hardware Fault
2018-12-12T23:36:14.397Z,1544657774.397 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-12-12T23:36:14.518Z,1544657774.518 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-12-12T23:36:14.597Z,1544657774.597 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-12-12T23:36:14.644Z,1544657774.644 [CBIT](ERROR): Hardware Fault in component: Rowe_600LCM
2018-12-12T23:36:15.173Z,1544657775.173 [Rowe_600LCM](INFO): Powering down
2018-12-12T23:36:16.337Z,1544657776.337 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:36:16.337Z,1544657776.337 [CTD_Seabird] Communications Fault, FailCount= 1
2018-12-12T23:36:16.337Z,1544657776.337 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:36:16.547Z,1544657776.547 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-12-12T23:36:16.547Z,1544657776.547 [Rowe_600LCM] No Fault, FailCount= 3
2018-12-12T23:36:16.547Z,1544657776.547 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:36:16.742Z,1544657776.742 [CTD_Seabird](INFO): Powering down
2018-12-12T23:36:16.801Z,1544657776.801 [Rowe_600LCM](INFO): Initializing
2018-12-12T23:36:16.801Z,1544657776.801 [Rowe_600LCM](INFO): Checking LCM
2018-12-12T23:36:16.801Z,1544657776.801 [Rowe_600LCM](FAULT): LCM not connected
2018-12-12T23:36:16.802Z,1544657776.802 [Rowe_600LCM] Hardware Fault, FailCount= 4
2018-12-12T23:36:16.802Z,1544657776.802 [Rowe_600LCM](ERROR): Hardware Fault
2018-12-12T23:36:16.878Z,1544657776.878 [CBIT](ERROR): Hardware Fault in component: Rowe_600LCM
2018-12-12T23:36:17.205Z,1544657777.205 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-12-12T23:36:17.442Z,1544657777.442 [Rowe_600LCM](INFO): Powering down
2018-12-12T23:36:17.526Z,1544657777.526 [AcousticModem_Benthos_ATM900](DEBUG): 
2018-12-12T23:36:17.545Z,1544657777.545 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-12T23:36:17.545Z,1544657777.545 [PNI_TCM] Data Fault, FailCount= 1
2018-12-12T23:36:17.545Z,1544657777.545 [PNI_TCM](ERROR): Data Fault
2018-12-12T23:36:17.718Z,1544657777.718 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-12T23:36:17.945Z,1544657777.945 [PNI_TCM](INFO): Powering down
2018-12-12T23:36:18.727Z,1544657778.727 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series OEM w/burn wire
2018-12-12T23:36:18.727Z,1544657778.727 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2018-12-12T23:36:18.728Z,1544657778.728 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.6.3
2018-12-12T23:36:18.729Z,1544657778.729 [AcousticModem_Benthos_ATM900](DEBUG): Nov 11 2018 09:03:29 
2018-12-12T23:36:18.823Z,1544657778.823 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-12-12T23:36:18.823Z,1544657778.823 [Rowe_600LCM] No Fault, FailCount= 4
2018-12-12T23:36:18.824Z,1544657778.824 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:36:18.824Z,1544657778.824 [CTD_Seabird] No Fault, FailCount= 1
2018-12-12T23:36:19.057Z,1544657779.057 [Rowe_600LCM](INFO): Initializing
2018-12-12T23:36:19.057Z,1544657779.057 [Rowe_600LCM](INFO): Checking LCM
2018-12-12T23:36:19.058Z,1544657779.058 [Rowe_600LCM](FAULT): LCM not connected
2018-12-12T23:36:19.058Z,1544657779.058 [Rowe_600LCM] Hardware Fault, FailCount= 5
2018-12-12T23:36:19.058Z,1544657779.058 [Rowe_600LCM](ERROR): Hardware Fault
2018-12-12T23:36:19.126Z,1544657779.126 [AcousticModem_Benthos_ATM900](DEBUG): WARNING: battery low
2018-12-12T23:36:19.240Z,1544657779.240 [CBIT](CRITICAL): Environmental Failure. Press:14.881536 PSI. Humidity:40%. Temp:25 C. ABORTING MISSION
2018-12-12T23:36:19.241Z,1544657779.241 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-12T23:36:19.241Z,1544657779.241 [PNI_TCM] No Fault, FailCount= 1
2018-12-12T23:36:19.241Z,1544657779.241 [CBIT](ERROR): Hardware Fault in component: Rowe_600LCM
2018-12-12T23:36:19.241Z,1544657779.241 [CBIT](FAULT): Hardware Fault in component: Rowe_600LCM
2018-12-12T23:36:19.461Z,1544657779.461 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-12-12T23:36:19.714Z,1544657779.714 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:36:19.741Z,1544657779.741 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:36:19.852Z,1544657779.852 [CBIT](INFO): Critical error at 20181212T233619
2018-12-12T23:36:19.926Z,1544657779.926 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2018-12-12T23:36:19.997Z,1544657779.997 [Rowe_600LCM](INFO): Powering down
2018-12-12T23:36:20.326Z,1544657780.326 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2018-12-12T23:36:20.327Z,1544657780.327 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 1: user:1>
2018-12-12T23:36:20.327Z,1544657780.327 [AcousticModem_Benthos_ATM900](INFO): command mode acknowledged
2018-12-12T23:36:20.358Z,1544657780.358 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-12-12T23:36:20.358Z,1544657780.358 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-12-12T23:36:20.358Z,1544657780.358 [Aanderaa_O2](ERROR): Communications Fault
2018-12-12T23:36:20.379Z,1544657780.379 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-12-12T23:36:20.726Z,1544657780.726 [AcousticModem_Benthos_ATM900](INFO): setting local address to 3
2018-12-12T23:36:20.873Z,1544657780.873 [Aanderaa_O2](INFO): Powering down
2018-12-12T23:36:21.126Z,1544657781.126 [AcousticModem_Benthos_ATM900](DEBUG): checking for local address setting acknowledgment
2018-12-12T23:36:21.127Z,1544657781.127 [AcousticModem_Benthos_ATM900](INFO): set local address to 3
2018-12-12T23:36:21.527Z,1544657781.527 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 2: user:2>
2018-12-12T23:36:21.617Z,1544657781.617 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-12-12T23:36:21.617Z,1544657781.617 [Aanderaa_O2] No Fault, FailCount= 1
2018-12-12T23:36:26.745Z,1544657786.745 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-12T23:36:26.745Z,1544657786.745 [PNI_TCM] Data Fault, FailCount= 2
2018-12-12T23:36:26.745Z,1544657786.745 [PNI_TCM](ERROR): Data Fault
2018-12-12T23:36:26.781Z,1544657786.781 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:36:26.781Z,1544657786.781 [CTD_Seabird] Communications Fault, FailCount= 2
2018-12-12T23:36:26.781Z,1544657786.781 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:36:26.810Z,1544657786.810 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-12T23:36:26.810Z,1544657786.810 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:36:27.145Z,1544657787.145 [PNI_TCM](INFO): Powering down
2018-12-12T23:36:27.185Z,1544657787.185 [CTD_Seabird](INFO): Powering down
2018-12-12T23:36:28.426Z,1544657788.426 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-12T23:36:28.426Z,1544657788.426 [PNI_TCM] No Fault, FailCount= 2
2018-12-12T23:36:29.183Z,1544657789.183 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:36:29.183Z,1544657789.183 [CTD_Seabird] No Fault, FailCount= 2
2018-12-12T23:36:30.149Z,1544657790.149 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:36:30.161Z,1544657790.161 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:36:32.345Z,1544657792.345 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-12-12T23:36:32.345Z,1544657792.345 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-12-12T23:36:32.345Z,1544657792.345 [Aanderaa_O2](ERROR): Communications Fault
2018-12-12T23:36:32.405Z,1544657792.405 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-12-12T23:36:32.865Z,1544657792.865 [Aanderaa_O2](INFO): Powering down
2018-12-12T23:36:33.609Z,1544657793.609 [SBIT](IMPORTANT): Beginning Startup BIT
2018-12-12T23:36:33.622Z,1544657793.622 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-12-12T23:36:33.622Z,1544657793.622 [Aanderaa_O2] No Fault, FailCount= 2
2018-12-12T23:36:33.622Z,1544657793.622 [CBIT](IMPORTANT): Beginning ground fault scan
2018-12-12T23:36:35.530Z,1544657795.530 [NAL9602](INFO): Powering up NAL9602
2018-12-12T23:36:36.072Z,1544657796.072 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-12T23:36:36.072Z,1544657796.072 [PNI_TCM] Data Fault, FailCount= 3
2018-12-12T23:36:36.072Z,1544657796.072 [PNI_TCM](ERROR): Data Fault
2018-12-12T23:36:36.242Z,1544657796.242 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-12T23:36:36.466Z,1544657796.466 [PNI_TCM](INFO): Powering down
2018-12-12T23:36:37.201Z,1544657797.201 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:36:37.201Z,1544657797.201 [CTD_Seabird] Communications Fault, FailCount= 3
2018-12-12T23:36:37.201Z,1544657797.201 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:36:37.427Z,1544657797.427 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:36:37.427Z,1544657797.427 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2018-12-12T23:36:37.605Z,1544657797.605 [CTD_Seabird](INFO): Powering down
2018-12-12T23:36:37.854Z,1544657797.854 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-12T23:36:37.855Z,1544657797.855 [PNI_TCM] No Fault, FailCount= 3
2018-12-12T23:36:44.068Z,1544657804.068 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-12-12T23:36:44.068Z,1544657804.068 [Aanderaa_O2] Communications Fault, FailCount= 3
2018-12-12T23:36:44.068Z,1544657804.068 [Aanderaa_O2](ERROR): Communications Fault
2018-12-12T23:36:44.163Z,1544657804.163 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-12-12T23:36:44.163Z,1544657804.163 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2018-12-12T23:36:44.585Z,1544657804.585 [Aanderaa_O2](INFO): Powering down
2018-12-12T23:36:44.682Z,1544657804.682 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.006872
CHAN A1 (24V): -0.011199
CHAN A2 (12V): -0.004975
CHAN A3 (5V): -0.001996
CHAN B0 (3.3V): -0.001623
CHAN B1 (3.15aV): -0.001020
CHAN B2 (3.15bV): -0.001353
CHAN B3 (GND): -0.000063
OPEN: 0.004231
Full Scale Calc: 4.765 mA, -1.589 mA
2018-12-12T23:36:45.266Z,1544657805.266 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-12T23:36:45.266Z,1544657805.266 [PNI_TCM] Data Fault, FailCount= 4
2018-12-12T23:36:45.266Z,1544657805.266 [PNI_TCM](ERROR): Data Fault
2018-12-12T23:36:45.338Z,1544657805.338 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-12T23:36:45.667Z,1544657805.667 [PNI_TCM](INFO): Powering down
2018-12-12T23:36:46.446Z,1544657806.446 [NAL9602](INFO): NAL9602 initialized
2018-12-12T23:36:47.055Z,1544657807.055 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-12T23:36:47.055Z,1544657807.055 [PNI_TCM] No Fault, FailCount= 4
2018-12-12T23:36:54.652Z,1544657814.652 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-12T23:36:54.652Z,1544657814.652 [PNI_TCM] Data Fault, FailCount= 5
2018-12-12T23:36:54.652Z,1544657814.652 [PNI_TCM](ERROR): Data Fault
2018-12-12T23:36:54.886Z,1544657814.886 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-12T23:36:54.886Z,1544657814.886 [CBIT](CRITICAL): Data Fault in component: PNI_TCM
2018-12-12T23:36:55.047Z,1544657815.047 [PNI_TCM](INFO): Powering down
2018-12-12T23:36:55.204Z,1544657815.204 [CBIT](INFO): Critical error at 20181212T233654
2018-12-12T23:37:03.326Z,1544657823.326 [CommandLine](IMPORTANT): got command maintain sensor Depth_Keller.depth 0.000000 meter
2018-12-12T23:37:03.327Z,1544657823.327 [ComponentRegistry](DEBUG): SyncComponent "Maintain_Depth_Keller.depth" handled in the control thread.
2018-12-12T23:37:03.601Z,1544657823.601 [controlThread](DEBUG): Component order: CycleStarter,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,Aanderaa_O2,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,Maintain_Depth_Keller.depth,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-12-12T23:37:27.594Z,1544657847.594 [SBIT](IMPORTANT): SBIT PASSED
2018-12-12T23:37:27.635Z,1544657847.635 [CommandLine](IMPORTANT): got command configSet list
2018-12-12T23:37:27.635Z,1544657847.635 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2018-12-12T23:37:27.636Z,1544657847.636 [CommandLine](IMPORTANT): PAR_Licor.loadAtStartup=1 bool;

2018-12-12T23:37:27.971Z,1544657847.971 [MissionManager](IMPORTANT): Started mission Startup
2018-12-12T23:37:27.971Z,1544657847.971 [Startup] Running Loop=1
2018-12-12T23:37:27.972Z,1544657847.972 [Startup](DEBUG): Aggregate::initialize Startup
2018-12-12T23:37:27.972Z,1544657847.972 [Startup:A.GoToSurface] Running Loop=1
2018-12-12T23:37:27.972Z,1544657847.972 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-12-12T23:37:27.972Z,1544657847.972 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-12-12T23:37:27.973Z,1544657847.973 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-12-12T23:37:27.973Z,1544657847.973 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-12-12T23:37:27.974Z,1544657847.974 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-12-12T23:37:27.974Z,1544657847.974 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-12-12T23:37:28.011Z,1544657848.011 [Startup:StartupSatComms] Running Loop=1
2018-12-12T23:37:28.011Z,1544657848.011 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2018-12-12T23:37:28.012Z,1544657848.012 [Startup:StartupSatComms:A] Running Loop=1
2018-12-12T23:37:28.376Z,1544657848.376 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2018-12-12T23:38:09.636Z,1544657889.636 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-12-12T23:38:09.636Z,1544657889.636 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2018-12-12T23:38:09.636Z,1544657889.636 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-12-12T23:38:09.650Z,1544657889.650 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-12-12T23:38:09.994Z,1544657889.994 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-12-12T23:38:09.994Z,1544657889.994 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2018-12-12T23:38:10.368Z,1544657890.368 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-12T23:38:10.368Z,1544657890.368 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-12T23:38:10.368Z,1544657890.368 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-12T23:38:28.398Z,1544657908.398 [Startup:StartupSatComms:A](INFO): Timed out from 2018-12-12T23:37:28.0Z
2018-12-12T23:38:28.398Z,1544657908.398 [Startup:StartupSatComms:A] Stopped
2018-12-12T23:38:28.398Z,1544657908.398 [Startup:StartupSatComms:B] Running Loop=1
2018-12-12T23:38:28.795Z,1544657908.795 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-12-12T23:38:33.968Z,1544657913.968 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004375
2018-12-12T23:38:39.616Z,1544657919.616 [DataOverHttps](INFO): Sending 77 bytes from file Logs/20181116T165325/Courier0046.lzma
2018-12-12T23:38:40.416Z,1544657920.416 [DataOverHttps](INFO): Moved sent file to Logs/20181116T165325/Courier0046.lzma.bak
2018-12-12T23:38:40.417Z,1544657920.417 [DataOverHttps](INFO): SBD MOMSN=9001040
2018-12-12T23:38:52.464Z,1544657932.464 [DataOverHttps](INFO): Sending 232 bytes from file Logs/20181116T192703/Courier0000.lzma
2018-12-12T23:38:53.235Z,1544657933.235 [DataOverHttps](INFO): Moved sent file to Logs/20181116T192703/Courier0000.lzma.bak
2018-12-12T23:38:53.236Z,1544657933.236 [DataOverHttps](INFO): SBD MOMSN=9001044
2018-12-12T23:39:02.628Z,1544657942.628 [DataOverHttps](INFO): Sending 69 bytes from file Logs/20181116T192703/Courier0004.lzma
2018-12-12T23:39:03.428Z,1544657943.428 [DataOverHttps](INFO): Moved sent file to Logs/20181116T192703/Courier0004.lzma.bak
2018-12-12T23:39:03.428Z,1544657943.428 [DataOverHttps](INFO): SBD MOMSN=9001051
2018-12-12T23:39:08.211Z,1544657948.211 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:39:08.212Z,1544657948.212 [CTD_Seabird] No Fault, FailCount= 3
2018-12-12T23:39:08.497Z,1544657948.497 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:39:08.498Z,1544657948.498 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:39:12.979Z,1544657952.979 [DataOverHttps](INFO): Sending 525 bytes from file Logs/20181116T192703/Courier0007.lzma
2018-12-12T23:39:13.775Z,1544657953.775 [DataOverHttps](INFO): Moved sent file to Logs/20181116T192703/Courier0007.lzma.bak
2018-12-12T23:39:13.776Z,1544657953.776 [DataOverHttps](INFO): SBD MOMSN=9001054
2018-12-12T23:39:15.323Z,1544657955.323 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-12-12T23:39:15.323Z,1544657955.323 [Aanderaa_O2] No Fault, FailCount= 3
2018-12-12T23:39:15.541Z,1544657955.541 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:39:15.541Z,1544657955.541 [CTD_Seabird] Communications Fault, FailCount= 1
2018-12-12T23:39:15.541Z,1544657955.541 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:39:15.945Z,1544657955.945 [CTD_Seabird](INFO): Powering down
2018-12-12T23:39:18.566Z,1544657958.566 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:39:18.567Z,1544657958.567 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:39:18.567Z,1544657958.567 [CTD_Seabird] No Fault, FailCount= 1
2018-12-12T23:39:18.893Z,1544657958.893 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:39:18.894Z,1544657958.894 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:39:23.374Z,1544657963.374 [DataOverHttps](INFO): Sending 409 bytes from file Logs/20181116T192703/Courier0010.lzma
2018-12-12T23:39:24.172Z,1544657964.172 [DataOverHttps](INFO): Moved sent file to Logs/20181116T192703/Courier0010.lzma.bak
2018-12-12T23:39:24.172Z,1544657964.172 [DataOverHttps](INFO): SBD MOMSN=9001087
2018-12-12T23:39:25.636Z,1544657965.636 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-12-12T23:39:25.636Z,1544657965.636 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-12-12T23:39:25.636Z,1544657965.636 [Aanderaa_O2](ERROR): Communications Fault
2018-12-12T23:39:25.686Z,1544657965.686 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-12-12T23:39:25.885Z,1544657965.885 [Aanderaa_O2](INFO): Powering down
2018-12-12T23:39:25.937Z,1544657965.937 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:39:25.937Z,1544657965.937 [CTD_Seabird] Communications Fault, FailCount= 2
2018-12-12T23:39:25.937Z,1544657965.937 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:39:26.341Z,1544657966.341 [CTD_Seabird](INFO): Powering down
2018-12-12T23:39:28.836Z,1544657968.836 [Startup:StartupSatComms:B](INFO): Timed out from 2018-12-12T23:38:28.4Z
2018-12-12T23:39:28.836Z,1544657968.836 [Startup:StartupSatComms:B] Stopped
2018-12-12T23:39:28.836Z,1544657968.836 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2018-12-12T23:39:28.836Z,1544657968.836 [Startup:StartupSatComms] Stopped
2018-12-12T23:39:28.837Z,1544657968.837 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2018-12-12T23:39:28.837Z,1544657968.837 [Startup](INFO): Completed Startup
2018-12-12T23:39:28.838Z,1544657968.838 [MissionManager](INFO): Startup is completed.
2018-12-12T23:39:28.838Z,1544657968.838 [MissionManager](INFO): Uninitializing Mission Startup
2018-12-12T23:39:28.838Z,1544657968.838 [Startup] Stopped
2018-12-12T23:39:28.838Z,1544657968.838 [Startup](DEBUG): Aggregate::uninitialize Startup
2018-12-12T23:39:28.838Z,1544657968.838 [Startup:A.GoToSurface] Stopped
2018-12-12T23:39:28.838Z,1544657968.838 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-12-12T23:39:28.886Z,1544657968.886 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:39:28.886Z,1544657968.886 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:39:28.886Z,1544657968.886 [CTD_Seabird] No Fault, FailCount= 2
2018-12-12T23:39:28.972Z,1544657968.972 [MissionManager](IMPORTANT): Started mission Default
2018-12-12T23:39:28.972Z,1544657968.972 [Default] Running Loop=1
2018-12-12T23:39:28.972Z,1544657968.972 [Default](DEBUG): Aggregate::initialize Default
2018-12-12T23:39:28.972Z,1544657968.972 [Default:B.GoToSurface] Running Loop=1
2018-12-12T23:39:28.972Z,1544657968.972 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-12-12T23:39:28.977Z,1544657968.977 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-12-12T23:39:28.977Z,1544657968.977 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-12-12T23:39:28.977Z,1544657968.977 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-12-12T23:39:28.978Z,1544657968.978 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-12-12T23:39:28.978Z,1544657968.978 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-12-12T23:39:28.978Z,1544657968.978 [Default:A.Wait] Running Loop=1
2018-12-12T23:39:28.978Z,1544657968.978 [Default:A.Wait](DEBUG): Initialize Wait Component.
2018-12-12T23:39:29.011Z,1544657969.011 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-12-12T23:39:29.011Z,1544657969.011 [Aanderaa_O2] No Fault, FailCount= 1
2018-12-12T23:39:29.305Z,1544657969.305 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:39:29.309Z,1544657969.309 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:39:33.690Z,1544657973.690 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20181116T192703/Courier0013.lzma
2018-12-12T23:39:34.463Z,1544657974.463 [DataOverHttps](INFO): Moved sent file to Logs/20181116T192703/Courier0013.lzma.bak
2018-12-12T23:39:34.463Z,1544657974.463 [DataOverHttps](INFO): SBD MOMSN=9001135
2018-12-12T23:39:36.353Z,1544657976.353 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:39:36.353Z,1544657976.353 [CTD_Seabird] Communications Fault, FailCount= 3
2018-12-12T23:39:36.353Z,1544657976.353 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:39:36.515Z,1544657976.515 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:39:36.515Z,1544657976.515 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2018-12-12T23:39:36.757Z,1544657976.757 [CTD_Seabird](INFO): Powering down
2018-12-12T23:39:39.694Z,1544657979.694 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-12-12T23:39:39.694Z,1544657979.694 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-12-12T23:39:39.695Z,1544657979.695 [Aanderaa_O2](ERROR): Communications Fault
2018-12-12T23:39:39.748Z,1544657979.748 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-12-12T23:39:40.201Z,1544657980.201 [Aanderaa_O2](INFO): Powering down
2018-12-12T23:39:40.915Z,1544657980.915 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-12-12T23:39:40.915Z,1544657980.915 [Aanderaa_O2] No Fault, FailCount= 2
2018-12-12T23:39:42.102Z,1544657982.102 [Default:A.Wait](INFO): Done Waiting.
2018-12-12T23:39:42.102Z,1544657982.102 [Default:A.Wait] Stopped
2018-12-12T23:39:42.102Z,1544657982.102 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2018-12-12T23:39:42.490Z,1544657982.490 [Default:CheckIn] Running Loop=1
2018-12-12T23:39:42.490Z,1544657982.490 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-12-12T23:39:42.491Z,1544657982.491 [Default:CheckIn:Read_GPS] Running Loop=1
2018-12-12T23:39:42.909Z,1544657982.909 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2018-12-12T23:39:51.680Z,1544657991.680 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-12-12T23:39:51.680Z,1544657991.680 [Aanderaa_O2] Communications Fault, FailCount= 3
2018-12-12T23:39:51.680Z,1544657991.680 [Aanderaa_O2](ERROR): Communications Fault
2018-12-12T23:39:51.716Z,1544657991.716 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-12-12T23:39:51.716Z,1544657991.716 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2018-12-12T23:39:52.205Z,1544657992.205 [Aanderaa_O2](INFO): Powering down
2018-12-12T23:40:10.580Z,1544658010.580 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-12-12T23:40:10.580Z,1544658010.580 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2018-12-12T23:40:10.580Z,1544658010.580 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-12-12T23:40:10.643Z,1544658010.643 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-12-12T23:40:10.951Z,1544658010.951 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-12-12T23:40:10.951Z,1544658010.951 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2018-12-12T23:40:11.350Z,1544658011.350 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-12T23:40:11.352Z,1544658011.352 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-12T23:40:11.353Z,1544658011.353 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-12T23:41:49.990Z,1544658109.990 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2018-12-12T23:41:54.885Z,1544658114.885 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-12T23:41:54.885Z,1544658114.885 [PNI_TCM] No Fault, FailCount= 5
2018-12-12T23:42:02.422Z,1544658122.422 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-12T23:42:02.422Z,1544658122.422 [PNI_TCM] Data Fault, FailCount= 1
2018-12-12T23:42:02.422Z,1544658122.422 [PNI_TCM](ERROR): Data Fault
2018-12-12T23:42:02.516Z,1544658122.516 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-12T23:42:02.812Z,1544658122.812 [PNI_TCM](INFO): Powering down
2018-12-12T23:42:04.078Z,1544658124.078 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-12T23:42:04.078Z,1544658124.078 [PNI_TCM] No Fault, FailCount= 1
2018-12-12T23:42:06.502Z,1544658126.502 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:42:06.502Z,1544658126.502 [CTD_Seabird] No Fault, FailCount= 3
2018-12-12T23:42:06.809Z,1544658126.809 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:42:06.814Z,1544658126.814 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:42:11.631Z,1544658131.631 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-12T23:42:11.631Z,1544658131.631 [PNI_TCM] Data Fault, FailCount= 2
2018-12-12T23:42:11.632Z,1544658131.632 [PNI_TCM](ERROR): Data Fault
2018-12-12T23:42:11.655Z,1544658131.655 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-12-12T23:42:11.655Z,1544658131.655 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2018-12-12T23:42:11.655Z,1544658131.655 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-12-12T23:42:11.720Z,1544658131.720 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-12T23:42:11.720Z,1544658131.720 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-12-12T23:42:12.028Z,1544658132.028 [PNI_TCM](INFO): Powering down
2018-12-12T23:42:12.172Z,1544658132.172 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-12-12T23:42:12.172Z,1544658132.172 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2018-12-12T23:42:12.453Z,1544658132.453 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-12T23:42:12.454Z,1544658132.454 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-12T23:42:12.454Z,1544658132.454 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-12T23:42:13.277Z,1544658133.277 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-12T23:42:13.277Z,1544658133.277 [PNI_TCM] No Fault, FailCount= 2
2018-12-12T23:42:13.853Z,1544658133.853 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:42:13.853Z,1544658133.853 [CTD_Seabird] Communications Fault, FailCount= 1
2018-12-12T23:42:13.853Z,1544658133.853 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:42:14.079Z,1544658134.079 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:42:14.257Z,1544658134.257 [CTD_Seabird](INFO): Powering down
2018-12-12T23:42:16.447Z,1544658136.447 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:42:16.447Z,1544658136.447 [CTD_Seabird] No Fault, FailCount= 1
2018-12-12T23:42:17.220Z,1544658137.220 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:42:17.224Z,1544658137.224 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:42:20.811Z,1544658140.811 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-12T23:42:20.811Z,1544658140.811 [PNI_TCM] Data Fault, FailCount= 3
2018-12-12T23:42:20.811Z,1544658140.811 [PNI_TCM](ERROR): Data Fault
2018-12-12T23:42:20.913Z,1544658140.913 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-12T23:42:21.206Z,1544658141.206 [PNI_TCM](INFO): Powering down
2018-12-12T23:42:22.099Z,1544658142.099 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-12-12T23:42:22.099Z,1544658142.099 [Aanderaa_O2] No Fault, FailCount= 3
2018-12-12T23:42:22.576Z,1544658142.576 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-12T23:42:22.576Z,1544658142.576 [PNI_TCM] No Fault, FailCount= 3
2018-12-12T23:42:24.265Z,1544658144.265 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:42:24.265Z,1544658144.265 [CTD_Seabird] Communications Fault, FailCount= 2
2018-12-12T23:42:24.265Z,1544658144.265 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:42:24.492Z,1544658144.492 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:42:24.670Z,1544658144.670 [CTD_Seabird](INFO): Powering down
2018-12-12T23:42:27.002Z,1544658147.002 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:42:27.002Z,1544658147.002 [CTD_Seabird] No Fault, FailCount= 2
2018-12-12T23:42:27.625Z,1544658147.625 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:42:27.653Z,1544658147.653 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:42:30.012Z,1544658150.012 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-12T23:42:30.012Z,1544658150.012 [PNI_TCM] Data Fault, FailCount= 4
2018-12-12T23:42:30.012Z,1544658150.012 [PNI_TCM](ERROR): Data Fault
2018-12-12T23:42:30.113Z,1544658150.113 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-12T23:42:30.416Z,1544658150.416 [PNI_TCM](INFO): Powering down
2018-12-12T23:42:31.717Z,1544658151.717 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-12T23:42:31.718Z,1544658151.718 [PNI_TCM] No Fault, FailCount= 4
2018-12-12T23:42:34.693Z,1544658154.693 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:42:34.693Z,1544658154.693 [CTD_Seabird] Communications Fault, FailCount= 3
2018-12-12T23:42:34.693Z,1544658154.693 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:42:35.098Z,1544658155.098 [CTD_Seabird](INFO): Powering down
2018-12-12T23:42:38.899Z,1544658158.899 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-12-12T23:42:38.899Z,1544658158.899 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-12-12T23:42:38.899Z,1544658158.899 [Aanderaa_O2](ERROR): Communications Fault
2018-12-12T23:42:38.991Z,1544658158.991 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-12-12T23:42:38.991Z,1544658158.991 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:42:38.991Z,1544658158.991 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2018-12-12T23:42:39.185Z,1544658159.185 [Aanderaa_O2](INFO): Powering down
2018-12-12T23:42:39.945Z,1544658159.945 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-12-12T23:42:39.945Z,1544658159.945 [Aanderaa_O2] No Fault, FailCount= 1
2018-12-12T23:42:45.042Z,1544658165.042 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-12T23:42:45.042Z,1544658165.042 [PNI_TCM] Data Fault, FailCount= 5
2018-12-12T23:42:45.042Z,1544658165.042 [PNI_TCM](ERROR): Data Fault
2018-12-12T23:42:45.143Z,1544658165.143 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-12T23:42:45.143Z,1544658165.143 [CBIT](CRITICAL): Data Fault in component: PNI_TCM
2018-12-12T23:42:45.434Z,1544658165.434 [PNI_TCM](INFO): Powering down
2018-12-12T23:42:45.579Z,1544658165.579 [CBIT](INFO): Critical error at 20181212T234245
2018-12-12T23:42:50.268Z,1544658170.268 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-12-12T23:42:50.268Z,1544658170.268 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-12-12T23:42:50.268Z,1544658170.268 [Aanderaa_O2](ERROR): Communications Fault
2018-12-12T23:42:50.359Z,1544658170.359 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-12-12T23:42:50.785Z,1544658170.785 [Aanderaa_O2](INFO): Powering down
2018-12-12T23:42:51.629Z,1544658171.629 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-12-12T23:42:51.629Z,1544658171.629 [Aanderaa_O2] No Fault, FailCount= 2
2018-12-12T23:43:02.262Z,1544658182.262 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-12-12T23:43:02.262Z,1544658182.262 [Aanderaa_O2] Communications Fault, FailCount= 3
2018-12-12T23:43:02.262Z,1544658182.262 [Aanderaa_O2](ERROR): Communications Fault
2018-12-12T23:43:02.363Z,1544658182.363 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-12-12T23:43:02.363Z,1544658182.363 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2018-12-12T23:43:02.786Z,1544658182.786 [Aanderaa_O2](INFO): Powering down
2018-12-12T23:44:12.471Z,1544658252.471 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-12-12T23:44:12.471Z,1544658252.471 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2018-12-12T23:44:12.471Z,1544658252.471 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-12-12T23:44:12.520Z,1544658252.520 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-12-12T23:44:12.921Z,1544658252.921 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-12-12T23:44:12.921Z,1544658252.921 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2018-12-12T23:44:13.265Z,1544658253.265 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-12T23:44:13.266Z,1544658253.266 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-12T23:44:13.266Z,1544658253.266 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-12T23:44:16.144Z,1544658256.144 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2018-12-12T23:44:42.614Z,1544658282.614 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-12-12T23:39:42.5Z
2018-12-12T23:44:42.615Z,1544658282.615 [Default:CheckIn:Read_GPS] Stopped
2018-12-12T23:44:42.615Z,1544658282.615 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-12-12T23:44:43.005Z,1544658283.005 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-12-12T23:44:53.765Z,1544658293.765 [DataOverHttps](INFO): Sending 517 bytes from file Logs/20181117T005347/Courier0000.lzma
2018-12-12T23:44:54.513Z,1544658294.513 [DataOverHttps](INFO): Moved sent file to Logs/20181117T005347/Courier0000.lzma.bak
2018-12-12T23:44:54.513Z,1544658294.513 [DataOverHttps](INFO): SBD MOMSN=9001154
2018-12-12T23:44:57.441Z,1544658297.441 [BPC1](FAULT): Failed to parse data from all battery packs.
2018-12-12T23:44:57.441Z,1544658297.441 [BPC1] Data Fault, FailCount= 1
2018-12-12T23:44:57.441Z,1544658297.441 [BPC1](ERROR): Data Fault
2018-12-12T23:44:57.534Z,1544658297.534 [CBIT](ERROR): Data Fault in component: BPC1
2018-12-12T23:45:04.786Z,1544658304.786 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:45:04.786Z,1544658304.786 [CTD_Seabird] No Fault, FailCount= 3
2018-12-12T23:45:05.161Z,1544658305.161 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:45:05.168Z,1544658305.168 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:45:12.209Z,1544658312.209 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:45:12.209Z,1544658312.209 [CTD_Seabird] Communications Fault, FailCount= 1
2018-12-12T23:45:12.209Z,1544658312.209 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:45:12.613Z,1544658312.613 [CTD_Seabird](INFO): Powering down
2018-12-12T23:45:13.276Z,1544658313.276 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:45:13.307Z,1544658313.307 [DataOverHttps](INFO): Sending 370 bytes from file Logs/20181117T005347/Courier0004.lzma
2018-12-12T23:45:14.092Z,1544658314.092 [DataOverHttps](INFO): Moved sent file to Logs/20181117T005347/Courier0004.lzma.bak
2018-12-12T23:45:14.092Z,1544658314.092 [DataOverHttps](INFO): SBD MOMSN=9001170
2018-12-12T23:45:17.850Z,1544658317.850 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:45:17.850Z,1544658317.850 [CTD_Seabird] No Fault, FailCount= 1
2018-12-12T23:45:17.985Z,1544658317.985 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:45:17.990Z,1544658317.990 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:45:25.033Z,1544658325.033 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:45:25.033Z,1544658325.033 [CTD_Seabird] Communications Fault, FailCount= 2
2018-12-12T23:45:25.033Z,1544658325.033 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:45:25.064Z,1544658325.064 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:45:25.437Z,1544658325.437 [CTD_Seabird](INFO): Powering down
2018-12-12T23:45:33.428Z,1544658333.428 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-12-12T23:45:33.428Z,1544658333.428 [Aanderaa_O2] No Fault, FailCount= 3
2018-12-12T23:45:33.428Z,1544658333.428 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:45:33.429Z,1544658333.429 [CTD_Seabird] No Fault, FailCount= 2
2018-12-12T23:45:33.444Z,1544658333.444 [DataOverHttps](INFO): Sending 449 bytes from file Logs/20181117T005347/Courier0007.lzma
2018-12-12T23:45:33.641Z,1544658333.641 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:45:33.643Z,1544658333.643 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:45:34.240Z,1544658334.240 [DataOverHttps](INFO): Moved sent file to Logs/20181117T005347/Courier0007.lzma.bak
2018-12-12T23:45:34.241Z,1544658334.241 [DataOverHttps](INFO): SBD MOMSN=9001179
2018-12-12T23:45:40.685Z,1544658340.685 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:45:40.685Z,1544658340.685 [CTD_Seabird] Communications Fault, FailCount= 3
2018-12-12T23:45:40.685Z,1544658340.685 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:45:41.089Z,1544658341.089 [CTD_Seabird](INFO): Powering down
2018-12-12T23:45:44.037Z,1544658344.037 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-12-12T23:45:44.038Z,1544658344.038 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-12-12T23:45:44.038Z,1544658344.038 [Aanderaa_O2](ERROR): Communications Fault
2018-12-12T23:45:44.108Z,1544658344.108 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-12-12T23:45:44.108Z,1544658344.108 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:45:44.131Z,1544658344.131 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2018-12-12T23:45:44.321Z,1544658344.321 [Aanderaa_O2](INFO): Powering down
2018-12-12T23:45:45.013Z,1544658345.013 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-12-12T23:45:45.013Z,1544658345.013 [Aanderaa_O2] No Fault, FailCount= 1
2018-12-12T23:45:53.441Z,1544658353.441 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20181117T005347/Courier0010.lzma
2018-12-12T23:45:54.219Z,1544658354.219 [DataOverHttps](INFO): Moved sent file to Logs/20181117T005347/Courier0010.lzma.bak
2018-12-12T23:45:54.220Z,1544658354.220 [DataOverHttps](INFO): SBD MOMSN=9001225
2018-12-12T23:45:57.942Z,1544658357.942 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-12-12T23:45:57.942Z,1544658357.942 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-12-12T23:45:57.942Z,1544658357.942 [Aanderaa_O2](ERROR): Communications Fault
2018-12-12T23:45:58.032Z,1544658358.032 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-12-12T23:45:58.217Z,1544658358.217 [Aanderaa_O2](INFO): Powering down
2018-12-12T23:46:05.018Z,1544658365.018 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-12-12T23:46:05.019Z,1544658365.019 [Aanderaa_O2] No Fault, FailCount= 2
2018-12-12T23:46:13.330Z,1544658373.330 [DataOverHttps](INFO): Sending 523 bytes from file Logs/20181117T051943/Courier0000.lzma
2018-12-12T23:46:13.371Z,1544658373.371 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-12-12T23:46:13.371Z,1544658373.371 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2018-12-12T23:46:13.371Z,1544658373.371 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-12-12T23:46:13.450Z,1544658373.450 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-12-12T23:46:13.772Z,1544658373.772 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-12-12T23:46:13.772Z,1544658373.772 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2018-12-12T23:46:14.080Z,1544658374.080 [DataOverHttps](INFO): Moved sent file to Logs/20181117T051943/Courier0000.lzma.bak
2018-12-12T23:46:14.081Z,1544658374.081 [DataOverHttps](INFO): SBD MOMSN=9001227
2018-12-12T23:46:14.146Z,1544658374.146 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-12T23:46:14.146Z,1544658374.146 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-12T23:46:14.147Z,1544658374.147 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-12T23:46:17.025Z,1544658377.025 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-12-12T23:46:17.026Z,1544658377.026 [Aanderaa_O2] Communications Fault, FailCount= 3
2018-12-12T23:46:17.026Z,1544658377.026 [Aanderaa_O2](ERROR): Communications Fault
2018-12-12T23:46:17.115Z,1544658377.115 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-12-12T23:46:17.115Z,1544658377.115 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2018-12-12T23:46:17.318Z,1544658377.318 [Aanderaa_O2](INFO): Powering down
2018-12-12T23:46:25.130Z,1544658385.130 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-12-12T23:46:25.130Z,1544658385.130 [Rowe_600LCM] No Fault, FailCount= 5
2018-12-12T23:46:25.445Z,1544658385.445 [Rowe_600LCM](INFO): Initializing
2018-12-12T23:46:25.445Z,1544658385.445 [Rowe_600LCM](INFO): Checking LCM
2018-12-12T23:46:25.446Z,1544658385.446 [Rowe_600LCM](FAULT): LCM not connected
2018-12-12T23:46:25.446Z,1544658385.446 [Rowe_600LCM] Hardware Fault, FailCount= 1
2018-12-12T23:46:25.446Z,1544658385.446 [Rowe_600LCM](ERROR): Hardware Fault
2018-12-12T23:46:25.659Z,1544658385.659 [CBIT](ERROR): Hardware Fault in component: Rowe_600LCM
2018-12-12T23:46:25.849Z,1544658385.849 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-12-12T23:46:26.175Z,1544658386.175 [Rowe_600LCM](INFO): Powering down
2018-12-12T23:46:33.589Z,1544658393.589 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-12-12T23:46:33.589Z,1544658393.589 [Rowe_600LCM] No Fault, FailCount= 1
2018-12-12T23:46:33.630Z,1544658393.630 [DataOverHttps](INFO): Sending 224 bytes from file Logs/20181117T051943/Courier0004.lzma
2018-12-12T23:46:33.849Z,1544658393.849 [Rowe_600LCM](INFO): Initializing
2018-12-12T23:46:33.849Z,1544658393.849 [Rowe_600LCM](INFO): Checking LCM
2018-12-12T23:46:33.849Z,1544658393.849 [Rowe_600LCM](FAULT): LCM not connected
2018-12-12T23:46:33.850Z,1544658393.850 [Rowe_600LCM] Hardware Fault, FailCount= 2
2018-12-12T23:46:33.850Z,1544658393.850 [Rowe_600LCM](ERROR): Hardware Fault
2018-12-12T23:46:34.107Z,1544658394.107 [CBIT](ERROR): Hardware Fault in component: Rowe_600LCM
2018-12-12T23:46:34.253Z,1544658394.253 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-12-12T23:46:34.416Z,1544658394.416 [DataOverHttps](INFO): Moved sent file to Logs/20181117T051943/Courier0004.lzma.bak
2018-12-12T23:46:34.416Z,1544658394.416 [DataOverHttps](INFO): SBD MOMSN=9001243
2018-12-12T23:46:34.485Z,1544658394.485 [Rowe_600LCM](INFO): Powering down
2018-12-12T23:46:37.398Z,1544658397.398 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-12-12T23:46:37.398Z,1544658397.398 [Rowe_600LCM] No Fault, FailCount= 2
2018-12-12T23:46:37.717Z,1544658397.717 [Rowe_600LCM](INFO): Initializing
2018-12-12T23:46:37.718Z,1544658397.718 [Rowe_600LCM](INFO): Checking LCM
2018-12-12T23:46:37.718Z,1544658397.718 [Rowe_600LCM](FAULT): LCM not connected
2018-12-12T23:46:37.718Z,1544658397.718 [Rowe_600LCM] Hardware Fault, FailCount= 3
2018-12-12T23:46:37.718Z,1544658397.718 [Rowe_600LCM](ERROR): Hardware Fault
2018-12-12T23:46:37.896Z,1544658397.896 [CBIT](ERROR): Hardware Fault in component: Rowe_600LCM
2018-12-12T23:46:38.121Z,1544658398.121 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-12-12T23:46:38.433Z,1544658398.433 [Rowe_600LCM](INFO): Powering down
2018-12-12T23:46:44.824Z,1544658404.824 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-12-12T23:46:44.824Z,1544658404.824 [Rowe_600LCM] No Fault, FailCount= 3
2018-12-12T23:46:44.897Z,1544658404.897 [Rowe_600LCM](INFO): Initializing
2018-12-12T23:46:44.898Z,1544658404.898 [Rowe_600LCM](INFO): Checking LCM
2018-12-12T23:46:44.898Z,1544658404.898 [Rowe_600LCM](FAULT): LCM not connected
2018-12-12T23:46:44.898Z,1544658404.898 [Rowe_600LCM] Hardware Fault, FailCount= 4
2018-12-12T23:46:44.898Z,1544658404.898 [Rowe_600LCM](ERROR): Hardware Fault
2018-12-12T23:46:44.998Z,1544658404.998 [CBIT](ERROR): Hardware Fault in component: Rowe_600LCM
2018-12-12T23:46:45.301Z,1544658405.301 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-12-12T23:46:45.547Z,1544658405.547 [Rowe_600LCM](INFO): Powering down
2018-12-12T23:46:46.942Z,1544658406.942 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-12-12T23:46:46.942Z,1544658406.942 [Rowe_600LCM] No Fault, FailCount= 4
2018-12-12T23:46:47.161Z,1544658407.161 [Rowe_600LCM](INFO): Initializing
2018-12-12T23:46:47.162Z,1544658407.162 [Rowe_600LCM](INFO): Checking LCM
2018-12-12T23:46:47.162Z,1544658407.162 [Rowe_600LCM](FAULT): LCM not connected
2018-12-12T23:46:47.162Z,1544658407.162 [Rowe_600LCM] Hardware Fault, FailCount= 5
2018-12-12T23:46:47.162Z,1544658407.162 [Rowe_600LCM](ERROR): Hardware Fault
2018-12-12T23:46:47.324Z,1544658407.324 [CBIT](ERROR): Hardware Fault in component: Rowe_600LCM
2018-12-12T23:46:47.324Z,1544658407.324 [CBIT](FAULT): Hardware Fault in component: Rowe_600LCM
2018-12-12T23:46:47.566Z,1544658407.566 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-12-12T23:46:47.850Z,1544658407.850 [Rowe_600LCM](INFO): Powering down
2018-12-12T23:46:54.172Z,1544658414.172 [DataOverHttps](INFO): Sending 586 bytes from file Logs/20181117T051943/Courier0007.lzma
2018-12-12T23:46:54.192Z,1544658414.192 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-12-12T23:46:54.192Z,1544658414.192 [NAL9602] Data Fault, FailCount= 1
2018-12-12T23:46:54.192Z,1544658414.192 [NAL9602](ERROR): Data Fault
2018-12-12T23:46:54.291Z,1544658414.291 [CBIT](ERROR): Data Fault in component: NAL9602
2018-12-12T23:46:54.534Z,1544658414.534 [NAL9602](INFO): Powering down
2018-12-12T23:46:54.932Z,1544658414.932 [DataOverHttps](INFO): Moved sent file to Logs/20181117T051943/Courier0007.lzma.bak
2018-12-12T23:46:54.932Z,1544658414.932 [DataOverHttps](INFO): SBD MOMSN=9001252
2018-12-12T23:46:57.893Z,1544658417.893 [CBIT](INFO): Clearing failed state for component NAL9602
2018-12-12T23:46:57.893Z,1544658417.893 [NAL9602] No Fault, FailCount= 1
2018-12-12T23:47:13.157Z,1544658433.157 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20181117T051943/Courier0010.lzma
2018-12-12T23:47:13.934Z,1544658433.934 [DataOverHttps](INFO): Moved sent file to Logs/20181117T051943/Courier0010.lzma.bak
2018-12-12T23:47:13.934Z,1544658433.934 [DataOverHttps](INFO): SBD MOMSN=9001298
2018-12-12T23:47:24.740Z,1544658444.740 [NAL9602](INFO): Powering up NAL9602
2018-12-12T23:47:34.078Z,1544658454.078 [DataOverHttps](INFO): Sending 523 bytes from file Logs/20181117T083254/Courier0000.lzma
2018-12-12T23:47:34.841Z,1544658454.841 [DataOverHttps](INFO): Moved sent file to Logs/20181117T083254/Courier0000.lzma.bak
2018-12-12T23:47:34.841Z,1544658454.841 [DataOverHttps](INFO): SBD MOMSN=9001300
2018-12-12T23:47:37.826Z,1544658457.826 [NAL9602](INFO): NAL9602 initialized
2018-12-12T23:47:45.106Z,1544658465.106 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-12T23:47:45.106Z,1544658465.106 [PNI_TCM] No Fault, FailCount= 5
2018-12-12T23:47:53.159Z,1544658473.159 [DataOverHttps](INFO): Sending 370 bytes from file Logs/20181117T083254/Courier0004.lzma
2018-12-12T23:47:53.928Z,1544658473.928 [DataOverHttps](INFO): Moved sent file to Logs/20181117T083254/Courier0004.lzma.bak
2018-12-12T23:47:53.928Z,1544658473.928 [DataOverHttps](INFO): SBD MOMSN=9001316
2018-12-12T23:48:04.119Z,1544658484.119 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-12T23:48:04.119Z,1544658484.119 [PNI_TCM] Data Fault, FailCount= 1
2018-12-12T23:48:04.119Z,1544658484.119 [PNI_TCM](ERROR): Data Fault
2018-12-12T23:48:04.201Z,1544658484.201 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-12T23:48:04.272Z,1544658484.272 [PNI_TCM](INFO): Powering down
2018-12-12T23:48:05.552Z,1544658485.552 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-12T23:48:05.552Z,1544658485.552 [PNI_TCM] No Fault, FailCount= 1
2018-12-12T23:48:13.076Z,1544658493.076 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:48:13.076Z,1544658493.076 [CTD_Seabird] No Fault, FailCount= 3
2018-12-12T23:48:13.130Z,1544658493.130 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20181117T083254/Courier0007.lzma
2018-12-12T23:48:13.137Z,1544658493.137 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:48:13.140Z,1544658493.140 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:48:13.912Z,1544658493.912 [DataOverHttps](INFO): Moved sent file to Logs/20181117T083254/Courier0007.lzma.bak
2018-12-12T23:48:13.912Z,1544658493.912 [DataOverHttps](INFO): SBD MOMSN=9001325
2018-12-12T23:48:17.076Z,1544658497.076 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-12-12T23:48:17.076Z,1544658497.076 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2018-12-12T23:48:17.076Z,1544658497.076 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-12-12T23:48:17.133Z,1544658497.133 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-12-12T23:48:17.288Z,1544658497.288 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-12-12T23:48:17.288Z,1544658497.288 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2018-12-12T23:48:17.609Z,1544658497.609 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-12T23:48:17.609Z,1544658497.609 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-12T23:48:17.610Z,1544658497.610 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-12T23:48:20.181Z,1544658500.181 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:48:20.181Z,1544658500.181 [CTD_Seabird] Communications Fault, FailCount= 1
2018-12-12T23:48:20.181Z,1544658500.181 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:48:20.585Z,1544658500.585 [CTD_Seabird](INFO): Powering down
2018-12-12T23:48:24.359Z,1544658504.359 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-12T23:48:24.359Z,1544658504.359 [PNI_TCM] Data Fault, FailCount= 2
2018-12-12T23:48:24.359Z,1544658504.359 [PNI_TCM](ERROR): Data Fault
2018-12-12T23:48:24.445Z,1544658504.445 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-12T23:48:24.445Z,1544658504.445 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:48:24.445Z,1544658504.445 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:48:24.445Z,1544658504.445 [CTD_Seabird] No Fault, FailCount= 1
2018-12-12T23:48:24.534Z,1544658504.534 [PNI_TCM](INFO): Powering down
2018-12-12T23:48:24.746Z,1544658504.746 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:48:24.749Z,1544658504.749 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:48:25.751Z,1544658505.751 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-12T23:48:25.751Z,1544658505.751 [PNI_TCM] No Fault, FailCount= 2
2018-12-12T23:48:31.789Z,1544658511.789 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:48:31.789Z,1544658511.789 [CTD_Seabird] Communications Fault, FailCount= 2
2018-12-12T23:48:31.789Z,1544658511.789 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:48:32.193Z,1544658512.193 [CTD_Seabird](INFO): Powering down
2018-12-12T23:48:32.825Z,1544658512.825 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:48:32.847Z,1544658512.847 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20181117T104537/Courier0000.lzma
2018-12-12T23:48:33.649Z,1544658513.649 [DataOverHttps](INFO): Moved sent file to Logs/20181117T104537/Courier0000.lzma.bak
2018-12-12T23:48:33.649Z,1544658513.649 [DataOverHttps](INFO): SBD MOMSN=9001327
2018-12-12T23:48:36.951Z,1544658516.951 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:48:36.951Z,1544658516.951 [CTD_Seabird] No Fault, FailCount= 2
2018-12-12T23:48:37.165Z,1544658517.165 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:48:37.168Z,1544658517.168 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:48:44.052Z,1544658524.052 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-12T23:48:44.052Z,1544658524.052 [PNI_TCM] Data Fault, FailCount= 3
2018-12-12T23:48:44.052Z,1544658524.052 [PNI_TCM](ERROR): Data Fault
2018-12-12T23:48:44.142Z,1544658524.142 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-12T23:48:44.210Z,1544658524.210 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:48:44.210Z,1544658524.210 [CTD_Seabird] Communications Fault, FailCount= 3
2018-12-12T23:48:44.210Z,1544658524.210 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:48:44.235Z,1544658524.235 [PNI_TCM](INFO): Powering down
2018-12-12T23:48:44.397Z,1544658524.397 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:48:44.398Z,1544658524.398 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2018-12-12T23:48:44.613Z,1544658524.613 [CTD_Seabird](INFO): Powering down
2018-12-12T23:48:45.418Z,1544658525.418 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-12T23:48:45.418Z,1544658525.418 [PNI_TCM] No Fault, FailCount= 3
2018-12-12T23:48:52.899Z,1544658532.899 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-12-12T23:48:52.899Z,1544658532.899 [Aanderaa_O2] No Fault, FailCount= 3
2018-12-12T23:48:52.938Z,1544658532.938 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20181117T110649/Courier0000.lzma
2018-12-12T23:48:53.716Z,1544658533.716 [DataOverHttps](INFO): Moved sent file to Logs/20181117T110649/Courier0000.lzma.bak
2018-12-12T23:48:53.716Z,1544658533.716 [DataOverHttps](INFO): SBD MOMSN=9001330
2018-12-12T23:49:04.091Z,1544658544.091 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-12T23:49:04.091Z,1544658544.091 [PNI_TCM] Data Fault, FailCount= 4
2018-12-12T23:49:04.091Z,1544658544.091 [PNI_TCM](ERROR): Data Fault
2018-12-12T23:49:04.092Z,1544658544.092 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-12-12T23:49:04.092Z,1544658544.092 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-12-12T23:49:04.092Z,1544658544.092 [Aanderaa_O2](ERROR): Communications Fault
2018-12-12T23:49:04.195Z,1544658544.195 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-12T23:49:04.196Z,1544658544.196 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-12-12T23:49:04.291Z,1544658544.291 [PNI_TCM](INFO): Powering down
2018-12-12T23:49:04.497Z,1544658544.497 [Aanderaa_O2](INFO): Powering down
2018-12-12T23:49:05.126Z,1544658545.126 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-12-12T23:49:05.126Z,1544658545.126 [Aanderaa_O2] No Fault, FailCount= 1
2018-12-12T23:49:05.547Z,1544658545.547 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-12T23:49:05.548Z,1544658545.548 [PNI_TCM] No Fault, FailCount= 4
2018-12-12T23:49:13.476Z,1544658553.476 [DataOverHttps](INFO): Sending 520 bytes from file Logs/20181117T111354/Courier0000.lzma
2018-12-12T23:49:14.257Z,1544658554.257 [DataOverHttps](INFO): Moved sent file to Logs/20181117T111354/Courier0000.lzma.bak
2018-12-12T23:49:14.257Z,1544658554.257 [DataOverHttps](INFO): SBD MOMSN=9001333
2018-12-12T23:49:17.272Z,1544658557.272 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-12-12T23:49:17.272Z,1544658557.272 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-12-12T23:49:17.272Z,1544658557.272 [Aanderaa_O2](ERROR): Communications Fault
2018-12-12T23:49:17.343Z,1544658557.343 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-12-12T23:49:17.525Z,1544658557.525 [Aanderaa_O2](INFO): Powering down
2018-12-12T23:49:24.103Z,1544658564.103 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-12T23:49:24.103Z,1544658564.103 [PNI_TCM] Data Fault, FailCount= 5
2018-12-12T23:49:24.103Z,1544658564.103 [PNI_TCM](ERROR): Data Fault
2018-12-12T23:49:24.203Z,1544658564.203 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-12T23:49:24.204Z,1544658564.204 [CBIT](CRITICAL): Data Fault in component: PNI_TCM
2018-12-12T23:49:24.303Z,1544658564.303 [PNI_TCM](INFO): Powering down
2018-12-12T23:49:24.454Z,1544658564.454 [CBIT](INFO): Critical error at 20181212T234924
2018-12-12T23:49:24.462Z,1544658564.462 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-12-12T23:49:24.462Z,1544658564.462 [Aanderaa_O2] No Fault, FailCount= 2
2018-12-12T23:49:32.863Z,1544658572.863 [DataOverHttps](INFO): Sending 222 bytes from file Logs/20181117T111354/Courier0004.lzma
2018-12-12T23:49:33.635Z,1544658573.635 [DataOverHttps](INFO): Moved sent file to Logs/20181117T111354/Courier0004.lzma.bak
2018-12-12T23:49:33.636Z,1544658573.636 [DataOverHttps](INFO): SBD MOMSN=9001349
2018-12-12T23:49:36.543Z,1544658576.543 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-12-12T23:49:36.543Z,1544658576.543 [Aanderaa_O2] Communications Fault, FailCount= 3
2018-12-12T23:49:36.543Z,1544658576.543 [Aanderaa_O2](ERROR): Communications Fault
2018-12-12T23:49:36.572Z,1544658576.572 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-12-12T23:49:36.572Z,1544658576.572 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2018-12-12T23:49:36.774Z,1544658576.774 [Aanderaa_O2](INFO): Powering down
2018-12-12T23:49:51.880Z,1544658591.880 [DataOverHttps](INFO): Sending 587 bytes from file Logs/20181117T111354/Courier0007.lzma
2018-12-12T23:49:52.655Z,1544658592.655 [DataOverHttps](INFO): Moved sent file to Logs/20181117T111354/Courier0007.lzma.bak
2018-12-12T23:49:52.656Z,1544658592.656 [DataOverHttps](INFO): SBD MOMSN=9001358
2018-12-12T23:50:12.918Z,1544658612.918 [DataOverHttps](INFO): Sending 421 bytes from file Logs/20181117T111354/Courier0010.lzma
2018-12-12T23:50:13.699Z,1544658613.699 [DataOverHttps](INFO): Moved sent file to Logs/20181117T111354/Courier0010.lzma.bak
2018-12-12T23:50:13.700Z,1544658613.700 [DataOverHttps](INFO): SBD MOMSN=9001404
2018-12-12T23:50:23.565Z,1544658623.565 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-12-12T23:50:23.565Z,1544658623.565 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2018-12-12T23:50:23.565Z,1544658623.565 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-12-12T23:50:23.631Z,1544658623.631 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-12-12T23:50:23.739Z,1544658623.739 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-12-12T23:50:23.739Z,1544658623.739 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2018-12-12T23:50:24.093Z,1544658624.093 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-12T23:50:24.094Z,1544658624.094 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-12T23:50:24.094Z,1544658624.094 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-12T23:50:32.249Z,1544658632.249 [DataOverHttps](INFO): Sending 561 bytes from file Logs/20181117T111354/Courier0013.lzma
2018-12-12T23:50:33.021Z,1544658633.021 [DataOverHttps](INFO): Moved sent file to Logs/20181117T111354/Courier0013.lzma.bak
2018-12-12T23:50:33.021Z,1544658633.021 [DataOverHttps](INFO): SBD MOMSN=9001450
2018-12-12T23:50:52.599Z,1544658652.599 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20181117T111354/Courier0016.lzma
2018-12-12T23:50:53.393Z,1544658653.393 [DataOverHttps](INFO): Moved sent file to Logs/20181117T111354/Courier0016.lzma.bak
2018-12-12T23:50:53.393Z,1544658653.393 [DataOverHttps](INFO): SBD MOMSN=9001497
2018-12-12T23:51:12.664Z,1544658672.664 [CBIT](INFO): Clearing failed state for component DropWeight
2018-12-12T23:51:12.664Z,1544658672.664 [DropWeight] No Fault, FailCount= 1
2018-12-12T23:51:12.728Z,1544658672.728 [DataOverHttps](INFO): Sending 521 bytes from file Logs/20181117T182943/Courier0000.lzma
2018-12-12T23:51:13.477Z,1544658673.477 [DataOverHttps](INFO): Moved sent file to Logs/20181117T182943/Courier0000.lzma.bak
2018-12-12T23:51:13.477Z,1544658673.477 [DataOverHttps](INFO): SBD MOMSN=9001502
2018-12-12T23:51:16.497Z,1544658676.497 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:51:16.497Z,1544658676.497 [CTD_Seabird] No Fault, FailCount= 3
2018-12-12T23:51:16.673Z,1544658676.673 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:51:16.677Z,1544658676.677 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:51:23.717Z,1544658683.717 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:51:23.718Z,1544658683.718 [CTD_Seabird] Communications Fault, FailCount= 1
2018-12-12T23:51:23.718Z,1544658683.718 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:51:23.834Z,1544658683.834 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:51:24.121Z,1544658684.121 [CTD_Seabird](INFO): Powering down
2018-12-12T23:51:26.344Z,1544658686.344 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:51:26.344Z,1544658686.344 [CTD_Seabird] No Fault, FailCount= 1
2018-12-12T23:51:27.069Z,1544658687.069 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:51:27.073Z,1544658687.073 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:51:33.259Z,1544658693.259 [DataOverHttps](INFO): Sending 223 bytes from file Logs/20181117T182943/Courier0004.lzma
2018-12-12T23:51:34.037Z,1544658694.037 [DataOverHttps](INFO): Moved sent file to Logs/20181117T182943/Courier0004.lzma.bak
2018-12-12T23:51:34.038Z,1544658694.038 [DataOverHttps](INFO): SBD MOMSN=9001534
2018-12-12T23:51:34.113Z,1544658694.113 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:51:34.113Z,1544658694.113 [CTD_Seabird] Communications Fault, FailCount= 2
2018-12-12T23:51:34.113Z,1544658694.113 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:51:34.172Z,1544658694.172 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:51:34.517Z,1544658694.517 [CTD_Seabird](INFO): Powering down
2018-12-12T23:51:37.080Z,1544658697.080 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:51:37.080Z,1544658697.080 [CTD_Seabird] No Fault, FailCount= 2
2018-12-12T23:51:37.465Z,1544658697.465 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:51:37.481Z,1544658697.481 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:51:44.521Z,1544658704.521 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:51:44.521Z,1544658704.521 [CTD_Seabird] Communications Fault, FailCount= 3
2018-12-12T23:51:44.521Z,1544658704.521 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:51:44.620Z,1544658704.620 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:51:44.620Z,1544658704.620 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2018-12-12T23:51:44.926Z,1544658704.926 [CTD_Seabird](INFO): Powering down
2018-12-12T23:51:52.849Z,1544658712.849 [DataOverHttps](INFO): Sending 597 bytes from file Logs/20181117T182943/Courier0007.lzma
2018-12-12T23:51:53.621Z,1544658713.621 [DataOverHttps](INFO): Moved sent file to Logs/20181117T182943/Courier0007.lzma.bak
2018-12-12T23:51:53.621Z,1544658713.621 [DataOverHttps](INFO): SBD MOMSN=9001543
2018-12-12T23:52:13.274Z,1544658733.274 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-12-12T23:52:13.274Z,1544658733.274 [Aanderaa_O2] No Fault, FailCount= 3
2018-12-12T23:52:13.340Z,1544658733.340 [DataOverHttps](INFO): Sending 393 bytes from file Logs/20181117T182943/Courier0010.lzma
2018-12-12T23:52:14.084Z,1544658734.084 [DataOverHttps](INFO): Moved sent file to Logs/20181117T182943/Courier0010.lzma.bak
2018-12-12T23:52:14.084Z,1544658734.084 [DataOverHttps](INFO): SBD MOMSN=9001589
2018-12-12T23:52:24.118Z,1544658744.118 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-12-12T23:52:24.118Z,1544658744.118 [Aanderaa_O2] Communications Fault, FailCount= 1
2018-12-12T23:52:24.119Z,1544658744.119 [Aanderaa_O2](ERROR): Communications Fault
2018-12-12T23:52:24.126Z,1544658744.126 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-12-12T23:52:24.126Z,1544658744.126 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8
2018-12-12T23:52:24.127Z,1544658744.127 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-12-12T23:52:24.199Z,1544658744.199 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-12-12T23:52:24.199Z,1544658744.199 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-12-12T23:52:24.377Z,1544658744.377 [Aanderaa_O2](INFO): Powering down
2018-12-12T23:52:24.454Z,1544658744.454 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-12-12T23:52:24.454Z,1544658744.454 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8
2018-12-12T23:52:24.676Z,1544658744.676 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-12T23:52:24.677Z,1544658744.677 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-12T23:52:24.677Z,1544658744.677 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-12T23:52:25.110Z,1544658745.110 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-12-12T23:52:25.110Z,1544658745.110 [Aanderaa_O2] No Fault, FailCount= 1
2018-12-12T23:52:32.660Z,1544658752.660 [DataOverHttps](INFO): Sending 578 bytes from file Logs/20181117T182943/Courier0013.lzma
2018-12-12T23:52:33.429Z,1544658753.429 [DataOverHttps](INFO): Moved sent file to Logs/20181117T182943/Courier0013.lzma.bak
2018-12-12T23:52:33.429Z,1544658753.429 [DataOverHttps](INFO): SBD MOMSN=9001634
2018-12-12T23:52:37.168Z,1544658757.168 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-12-12T23:52:37.168Z,1544658757.168 [Aanderaa_O2] Communications Fault, FailCount= 2
2018-12-12T23:52:37.168Z,1544658757.168 [Aanderaa_O2](ERROR): Communications Fault
2018-12-12T23:52:37.230Z,1544658757.230 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-12-12T23:52:37.405Z,1544658757.405 [Aanderaa_O2](INFO): Powering down
2018-12-12T23:52:44.207Z,1544658764.207 [CBIT](INFO): Clearing failed state for component Aanderaa_O2
2018-12-12T23:52:44.207Z,1544658764.207 [Aanderaa_O2] No Fault, FailCount= 2
2018-12-12T23:52:52.463Z,1544658772.463 [DataOverHttps](INFO): Sending 399 bytes from file Logs/20181117T182943/Courier0016.lzma
2018-12-12T23:52:53.228Z,1544658773.228 [DataOverHttps](INFO): Moved sent file to Logs/20181117T182943/Courier0016.lzma.bak
2018-12-12T23:52:53.228Z,1544658773.228 [DataOverHttps](INFO): SBD MOMSN=9001682
2018-12-12T23:52:56.105Z,1544658776.105 [Aanderaa_O2](FAULT): Failed to initialize within timeout.
2018-12-12T23:52:56.105Z,1544658776.105 [Aanderaa_O2] Communications Fault, FailCount= 3
2018-12-12T23:52:56.105Z,1544658776.105 [Aanderaa_O2](ERROR): Communications Fault
2018-12-12T23:52:56.212Z,1544658776.212 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2
2018-12-12T23:52:56.212Z,1544658776.212 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2
2018-12-12T23:52:56.389Z,1544658776.389 [Aanderaa_O2](INFO): Powering down
2018-12-12T23:53:12.097Z,1544658792.097 [DataOverHttps](INFO): Sending 409 bytes from file Logs/20181117T182943/Courier0019.lzma
2018-12-12T23:53:12.876Z,1544658792.876 [DataOverHttps](INFO): Moved sent file to Logs/20181117T182943/Courier0019.lzma.bak
2018-12-12T23:53:12.876Z,1544658792.876 [DataOverHttps](INFO): SBD MOMSN=9001729
2018-12-12T23:53:31.088Z,1544658811.088 [DataOverHttps](INFO): Sending 573 bytes from file Logs/20181117T182943/Courier0022.lzma
2018-12-12T23:53:31.876Z,1544658811.876 [DataOverHttps](INFO): Moved sent file to Logs/20181117T182943/Courier0022.lzma.bak
2018-12-12T23:53:31.876Z,1544658811.876 [DataOverHttps](INFO): SBD MOMSN=9001776
2018-12-12T23:53:50.434Z,1544658830.434 [DataOverHttps](INFO): Sending 411 bytes from file Logs/20181117T182943/Courier0025.lzma
2018-12-12T23:53:51.495Z,1544658831.495 [DataOverHttps](INFO): Moved sent file to Logs/20181117T182943/Courier0025.lzma.bak
2018-12-12T23:53:51.495Z,1544658831.495 [DataOverHttps](INFO): SBD MOMSN=9001823
2018-12-12T23:54:09.597Z,1544658849.597 [DataOverHttps](INFO): Sending 398 bytes from file Logs/20181117T182943/Courier0028.lzma
2018-12-12T23:54:10.381Z,1544658850.381 [DataOverHttps](INFO): Moved sent file to Logs/20181117T182943/Courier0028.lzma.bak
2018-12-12T23:54:10.381Z,1544658850.381 [DataOverHttps](INFO): SBD MOMSN=9001871
2018-12-12T23:54:19.487Z,1544658859.487 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:54:19.488Z,1544658859.488 [CTD_Seabird] No Fault, FailCount= 3
2018-12-12T23:54:19.793Z,1544658859.793 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-12T23:54:19.809Z,1544658859.809 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-12T23:54:26.849Z,1544658866.849 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-12T23:54:26.849Z,1544658866.849 [CTD_Seabird] Communications Fault, FailCount= 1
2018-12-12T23:54:26.849Z,1544658866.849 [CTD_Seabird](ERROR): Communications Fault
2018-12-12T23:54:27.253Z,1544658867.253 [CTD_Seabird](INFO): Powering down
2018-12-12T23:54:29.242Z,1544658869.242 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-12-12T23:54:29.242Z,1544658869.242 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9
2018-12-12T23:54:29.242Z,1544658869.242 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-12-12T23:54:29.305Z,1544658869.305 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-12T23:54:29.305Z,1544658869.305 [PNI_TCM] No Fault, FailCount= 5
2018-12-12T23:54:29.306Z,1544658869.306 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-12T23:54:29.306Z,1544658869.306 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-12T23:54:29.306Z,1544658869.306 [CTD_Seabird] No Fault, FailCount= 1
2018-12-12T23:54:29.307Z,1544658869.307 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-12-12T23:54:29.365Z,1544658869.365 [DataOverHttps](INFO): Sending 599 bytes from file Logs/20181117T182943/Courier0031.lzma
2018-12-12T23:54:29.508Z,1544658869.508 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-12-12T23:54:29.508Z,1544658869.508 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9
2018-12-12T23:54:29.761Z,1544658869.761 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-12T23:54:29.762Z,1544658869.762 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-1