2019-05-07T23:39:59.346Z,1557272399.346 [Supervisor](DEBUG): Initializing supervisor.
2019-05-07T23:39:59.349Z,1557272399.349 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-05-07T23:39:59.350Z,1557272399.350 [SyncHandler](INFO): Protected caller Thread ID is 3464
2019-05-07T23:39:59.350Z,1557272399.350 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-05-07T23:39:59.351Z,1557272399.351 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-05-07T23:39:59.351Z,1557272399.351 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 3465
2019-05-07T23:39:59.354Z,1557272399.354 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-05-07T23:39:59.366Z,1557272399.366 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-05-07T23:39:59.367Z,1557272399.367 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-05-07T23:39:59.367Z,1557272399.367 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 3466
2019-05-07T23:39:59.368Z,1557272399.368 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-05-07T23:39:59.369Z,1557272399.369 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-05-07T23:39:59.370Z,1557272399.370 [logger ThreadHandler](INFO): Protected caller Thread ID is 3467
2019-05-07T23:39:59.372Z,1557272399.372 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-05-07T23:39:59.372Z,1557272399.372 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-05-07T23:39:59.374Z,1557272399.374 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-05-07T23:39:59.536Z,1557272399.536 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-05-07T23:39:59.536Z,1557272399.536 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-05-07T23:40:00.145Z,1557272400.145 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-05-07T23:40:00.146Z,1557272400.146 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-05-07T23:40:00.245Z,1557272400.245 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-05-07T23:40:00.246Z,1557272400.246 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-05-07T23:40:00.350Z,1557272400.350 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-05-07T23:40:00.350Z,1557272400.350 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-05-07T23:40:00.432Z,1557272400.432 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-05-07T23:40:00.571Z,1557272400.571 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-05-07T23:40:00.572Z,1557272400.572 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-05-07T23:40:00.867Z,1557272400.867 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-05-07T23:40:00.867Z,1557272400.867 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-05-07T23:40:01.330Z,1557272401.330 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-05-07T23:40:01.331Z,1557272401.331 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-05-07T23:40:01.476Z,1557272401.476 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-05-07T23:40:01.477Z,1557272401.477 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-05-07T23:40:01.672Z,1557272401.672 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-05-07T23:40:01.673Z,1557272401.673 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-05-07T23:40:02.133Z,1557272402.133 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-05-07T23:40:02.134Z,1557272402.134 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-05-07T23:40:02.347Z,1557272402.347 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-05-07T23:40:02.348Z,1557272402.348 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-05-07T23:40:02.567Z,1557272402.567 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-05-07T23:40:02.568Z,1557272402.568 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-05-07T23:40:03.284Z,1557272403.284 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-05-07T23:40:03.285Z,1557272403.285 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-05-07T23:40:03.619Z,1557272403.619 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-05-07T23:40:03.621Z,1557272403.621 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/
2019-05-07T23:40:03.622Z,1557272403.622 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg
2019-05-07T23:40:03.705Z,1557272403.705 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg
2019-05-07T23:40:03.851Z,1557272403.851 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg
2019-05-07T23:40:03.960Z,1557272403.960 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg
2019-05-07T23:40:04.046Z,1557272404.046 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg
2019-05-07T23:40:04.142Z,1557272404.142 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg
2019-05-07T23:40:04.324Z,1557272404.324 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg
2019-05-07T23:40:04.552Z,1557272404.552 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-05-07T23:40:04.553Z,1557272404.553 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg
2019-05-07T23:40:04.648Z,1557272404.648 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg
2019-05-07T23:40:04.746Z,1557272404.746 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg
2019-05-07T23:40:04.863Z,1557272404.863 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg
2019-05-07T23:40:04.965Z,1557272404.965 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/root/
2019-05-07T23:40:04.965Z,1557272404.965 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-05-07T23:40:04.974Z,1557272404.974 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-05-07T23:40:05.059Z,1557272405.059 [VerticalControl](DEBUG): Construct VerticalControl.
2019-05-07T23:40:05.168Z,1557272405.168 [VerticalControl] Loaded
2019-05-07T23:40:05.169Z,1557272405.169 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-05-07T23:40:05.169Z,1557272405.169 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-05-07T23:40:05.237Z,1557272405.237 [HorizontalControl] Loaded
2019-05-07T23:40:05.237Z,1557272405.237 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-05-07T23:40:05.237Z,1557272405.237 [SpeedControl](DEBUG): Construct SpeedControl.
2019-05-07T23:40:05.243Z,1557272405.243 [SpeedControl] Loaded
2019-05-07T23:40:05.243Z,1557272405.243 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-05-07T23:40:05.244Z,1557272405.244 [LoopControl](DEBUG): Construct LoopControl.
2019-05-07T23:40:05.244Z,1557272405.244 [LoopControl] Loaded
2019-05-07T23:40:05.245Z,1557272405.245 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-05-07T23:40:05.245Z,1557272405.245 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-05-07T23:40:05.246Z,1557272405.246 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-05-07T23:40:05.299Z,1557272405.299 [DepthRateCalculator] Loaded
2019-05-07T23:40:05.299Z,1557272405.299 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-05-07T23:40:05.304Z,1557272405.304 [PitchRateCalculator] Loaded
2019-05-07T23:40:05.304Z,1557272405.304 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-05-07T23:40:05.320Z,1557272405.320 [SpeedCalculator] Loaded
2019-05-07T23:40:05.320Z,1557272405.320 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-05-07T23:40:05.340Z,1557272405.340 [TempGradientCalculator] Loaded
2019-05-07T23:40:05.341Z,1557272405.341 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-05-07T23:40:05.345Z,1557272405.345 [YawRateCalculator] Loaded
2019-05-07T23:40:05.346Z,1557272405.346 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-05-07T23:40:05.374Z,1557272405.374 [ElevatorOffsetCalculator] Loaded
2019-05-07T23:40:05.374Z,1557272405.374 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-05-07T23:40:05.374Z,1557272405.374 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-05-07T23:40:05.375Z,1557272405.375 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-05-07T23:40:05.415Z,1557272405.415 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-05-07T23:40:05.416Z,1557272405.416 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-05-07T23:40:05.523Z,1557272405.523 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-05-07T23:40:05.523Z,1557272405.523 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-05-07T23:40:05.851Z,1557272405.851 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-05-07T23:40:05.851Z,1557272405.851 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-05-07T23:40:05.969Z,1557272405.969 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-05-07T23:40:05.970Z,1557272405.970 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-05-07T23:40:06.749Z,1557272406.749 [DataOverHttps] Loaded
2019-05-07T23:40:06.749Z,1557272406.749 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-05-07T23:40:06.751Z,1557272406.751 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408C74E0
2019-05-07T23:40:06.751Z,1557272406.751 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 3547
2019-05-07T23:40:06.764Z,1557272406.764 [Depth_Keller] Loaded
2019-05-07T23:40:06.765Z,1557272406.765 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-05-07T23:40:06.861Z,1557272406.861 [NAL9602] Loaded
2019-05-07T23:40:06.862Z,1557272406.862 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-05-07T23:40:06.877Z,1557272406.877 [Onboard] Loaded
2019-05-07T23:40:06.877Z,1557272406.877 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-05-07T23:40:06.880Z,1557272406.880 [Radio_Surface] Loaded
2019-05-07T23:40:06.881Z,1557272406.881 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-05-07T23:40:06.882Z,1557272406.882 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408F74E0
2019-05-07T23:40:06.882Z,1557272406.882 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 3548
2019-05-07T23:40:08.689Z,1557272408.689 [BPC1] Loaded
2019-05-07T23:40:08.690Z,1557272408.690 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-05-07T23:40:08.690Z,1557272408.690 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-05-07T23:40:08.691Z,1557272408.691 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-05-07T23:40:08.808Z,1557272408.808 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-05-07T23:40:08.809Z,1557272408.809 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-05-07T23:40:08.829Z,1557272408.829 [NavChart] Loaded
2019-05-07T23:40:08.829Z,1557272408.829 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-05-07T23:40:08.833Z,1557272408.833 [UniversalFixResidualReporter] Loaded
2019-05-07T23:40:08.833Z,1557272408.833 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-05-07T23:40:08.834Z,1557272408.834 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-05-07T23:40:08.834Z,1557272408.834 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-05-07T23:40:08.987Z,1557272408.987 [SBIT](DEBUG): Construct Startup Built In Test.
2019-05-07T23:40:08.997Z,1557272408.997 [SBIT] Loaded
2019-05-07T23:40:08.998Z,1557272408.998 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-05-07T23:40:08.998Z,1557272408.998 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-05-07T23:40:09.010Z,1557272409.010 [IBIT] Loaded
2019-05-07T23:40:09.010Z,1557272409.010 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-05-07T23:40:09.013Z,1557272409.013 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-05-07T23:40:09.146Z,1557272409.146 [CBIT] Loaded
2019-05-07T23:40:09.147Z,1557272409.147 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-05-07T23:40:09.147Z,1557272409.147 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-05-07T23:40:09.148Z,1557272409.148 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-05-07T23:40:09.270Z,1557272409.270 [BuoyancyServo] Loaded
2019-05-07T23:40:09.270Z,1557272409.270 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-05-07T23:40:09.281Z,1557272409.281 [ElevatorServo] Loaded
2019-05-07T23:40:09.282Z,1557272409.282 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-05-07T23:40:09.292Z,1557272409.292 [MassServo] Loaded
2019-05-07T23:40:09.293Z,1557272409.293 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-05-07T23:40:09.304Z,1557272409.304 [RudderServo] Loaded
2019-05-07T23:40:09.304Z,1557272409.304 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-05-07T23:40:09.314Z,1557272409.314 [ThrusterServo] Loaded
2019-05-07T23:40:09.315Z,1557272409.315 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-05-07T23:40:09.315Z,1557272409.315 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-05-07T23:40:09.316Z,1557272409.316 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-05-07T23:40:09.339Z,1557272409.339 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-05-07T23:40:09.339Z,1557272409.339 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-05-07T23:40:09.655Z,1557272409.655 [CTD_NeilBrown] Loaded
2019-05-07T23:40:09.656Z,1557272409.656 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2019-05-07T23:40:09.657Z,1557272409.657 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 40A734E0
2019-05-07T23:40:09.657Z,1557272409.657 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 3549
2019-05-07T23:40:09.704Z,1557272409.704 [WetLabsBB2FL] Loaded
2019-05-07T23:40:09.705Z,1557272409.705 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-05-07T23:40:09.706Z,1557272409.706 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40AA34E0
2019-05-07T23:40:09.706Z,1557272409.706 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 3550
2019-05-07T23:40:09.707Z,1557272409.707 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-05-07T23:40:09.710Z,1557272409.710 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-05-07T23:40:09.711Z,1557272409.711 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-05-07T23:40:09.718Z,1557272409.718 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-05-07T23:40:09.719Z,1557272409.719 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AD34E0
2019-05-07T23:40:09.719Z,1557272409.719 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 3551
2019-05-07T23:40:09.724Z,1557272409.724 [Supervisor](INFO): Main Thread ID is 3463
2019-05-07T23:40:09.724Z,1557272409.724 [Supervisor](DEBUG): Running supervisor.
2019-05-07T23:40:09.725Z,1557272409.725 [CommandLine ThreadHandler](INFO): Handler Thread ID is 3552
2019-05-07T23:40:09.728Z,1557272409.728 [controlThread ThreadHandler](INFO): Handler Thread ID is 3553
2019-05-07T23:40:09.728Z,1557272409.728 [controlThread](DEBUG): Initializing ControlThread
2019-05-07T23:40:09.729Z,1557272409.729 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-05-07T23:40:09.730Z,1557272409.730 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-05-07T23:40:09.731Z,1557272409.731 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-05-07T23:40:09.732Z,1557272409.732 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-05-07T23:40:09.732Z,1557272409.732 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-05-07T23:40:09.732Z,1557272409.732 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-05-07T23:40:09.733Z,1557272409.733 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-05-07T23:40:09.733Z,1557272409.733 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-05-07T23:40:09.733Z,1557272409.733 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-05-07T23:40:09.734Z,1557272409.734 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-05-07T23:40:09.738Z,1557272409.738 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-05-07T23:40:09.738Z,1557272409.738 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-05-07T23:40:09.739Z,1557272409.739 [SBIT](INFO): Initialize SBIT Component.
2019-05-07T23:40:09.739Z,1557272409.739 [SBIT](IMPORTANT): git: 2019-05-01-6-g08bb213
2019-05-07T23:40:09.739Z,1557272409.739 [SBIT](INFO): git hash: 08bb2137fac00bb96d649b4144ef516361bafd54
2019-05-07T23:40:09.740Z,1557272409.740 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-05-07T23:40:09.740Z,1557272409.740 [SBIT](IMPORTANT): Kernel Version:#1 PREEMPT Thu Feb 21 11:17:40 PST 2019
2019-05-07T23:40:09.761Z,1557272409.761 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2019-05-07T23:40:09.761Z,1557272409.761 [logger ThreadHandler](INFO): Handler Thread ID is 3554
2019-05-07T23:40:09.789Z,1557272409.789 [IBIT](INFO): Initialize IBIT Component.
2019-05-07T23:40:09.790Z,1557272409.790 [CBIT](DEBUG): Initialize CBIT Component.
2019-05-07T23:40:09.791Z,1557272409.791 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 3555
2019-05-07T23:40:09.792Z,1557272409.792 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-05-07T23:40:09.801Z,1557272409.801 [CBIT](DEBUG): Initialized mux pins.
2019-05-07T23:40:09.801Z,1557272409.801 [CBIT](DEBUG): Initializing the watchdog timer.
2019-05-07T23:40:09.802Z,1557272409.802 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 3556
2019-05-07T23:40:09.809Z,1557272409.809 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 3557
2019-05-07T23:40:09.825Z,1557272409.825 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-05-07T23:40:09.825Z,1557272409.825 [CBIT](DEBUG): Initializing heartbeat.
2019-05-07T23:40:09.826Z,1557272409.826 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 3558
2019-05-07T23:40:09.827Z,1557272409.827 [WetLabsBB2FL](INFO): Powering down
2019-05-07T23:40:09.853Z,1557272409.853 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 3559
2019-05-07T23:40:09.868Z,1557272409.868 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-05-07T23:40:09.868Z,1557272409.868 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-05-07T23:40:09.868Z,1557272409.868 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-05-07T23:40:09.868Z,1557272409.868 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-05-07T23:40:09.869Z,1557272409.869 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-05-07T23:40:09.869Z,1557272409.869 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-05-07T23:40:09.869Z,1557272409.869 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-05-07T23:40:09.869Z,1557272409.869 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-05-07T23:40:09.869Z,1557272409.869 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-05-07T23:40:09.869Z,1557272409.869 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-05-07T23:40:09.870Z,1557272409.870 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-05-07T23:40:09.870Z,1557272409.870 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-05-07T23:40:09.870Z,1557272409.870 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-05-07T23:40:09.870Z,1557272409.870 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-05-07T23:40:09.870Z,1557272409.870 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-05-07T23:40:09.871Z,1557272409.871 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-05-07T23:40:09.897Z,1557272409.897 [CBIT](DEBUG): Deactivating GF circuits.
2019-05-07T23:40:09.897Z,1557272409.897 [CBIT](DEBUG): Deactivating emergency mode.
2019-05-07T23:40:09.933Z,1557272409.933 [CBIT](DEBUG): Backplane powered.
2019-05-07T23:40:09.935Z,1557272409.935 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-05-07T23:40:09.946Z,1557272409.946 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-05-07T23:40:09.956Z,1557272409.956 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

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

    <Aggregate Id="StartupSatComms">

        <Sequence/>

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

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

    </Aggregate>

</Mission>


2019-05-07T23:40:09.973Z,1557272409.973 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-05-07T23:40:10.037Z,1557272410.037 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-05-07T23:40:10.038Z,1557272410.038 [Default:A.Wait](DEBUG): Construct Wait.
2019-05-07T23:40:10.040Z,1557272410.040 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-05-07T23:40:10.071Z,1557272410.071 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-05-07T23:40:10.095Z,1557272410.095 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-05-07T23:40:10.117Z,1557272410.117 [Default:E.Execute](DEBUG): Construct Execute.
2019-05-07T23:40:10.120Z,1557272410.120 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

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

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

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

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

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

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

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

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

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

    </Aggregate>

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

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

</Mission>


2019-05-07T23:40:10.144Z,1557272410.144 [controlThread](DEBUG): Component order: CycleStarter,Depth_Keller,NAL9602,Onboard,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2019-05-07T23:40:10.151Z,1557272410.151 [Depth_Keller](ERROR): Pressure reading out of range: 1925.893799 decibar
2019-05-07T23:40:10.205Z,1557272410.205 [Radio_Surface](INFO): Powering up
2019-05-07T23:40:10.209Z,1557272410.209 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-05-07T23:40:10.713Z,1557272410.713 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-05-07T23:40:10.725Z,1557272410.725 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-05-07T23:40:10.726Z,1557272410.726 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-05-07T23:40:10.737Z,1557272410.737 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-05-07T23:40:10.738Z,1557272410.738 [MassServo](DEBUG): Initializing EZServoServo.
2019-05-07T23:40:10.749Z,1557272410.749 [MassServo](DEBUG): Initializing MassServo.
2019-05-07T23:40:10.750Z,1557272410.750 [RudderServo](DEBUG): Initializing EZServoServo.
2019-05-07T23:40:10.761Z,1557272410.761 [RudderServo](DEBUG): Initializing RudderServo.
2019-05-07T23:40:10.762Z,1557272410.762 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-05-07T23:40:10.773Z,1557272410.773 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-05-07T23:40:21.514Z,1557272421.514 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004502
2019-05-07T23:40:37.050Z,1557272437.050 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:40:38.294Z,1557272438.294 [SBIT](IMPORTANT): Beginning Startup BIT
2019-05-07T23:40:38.304Z,1557272438.304 [CBIT](IMPORTANT): Beginning ground fault scan
2019-05-07T23:40:49.353Z,1557272449.353 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.001585
CHAN A1 (24V): 0.003420
CHAN A2 (12V): -0.007376
CHAN A3 (5V): -0.002107
CHAN B0 (3.3V): -0.000820
CHAN B1 (3.15aV): -0.000807
CHAN B2 (3.15bV): -0.000688
CHAN B3 (GND): 0.001504
OPEN: -0.000668
Full Scale Calc: 4.765 mA, -1.589 mA
2019-05-07T23:40:57.894Z,1557272457.894 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-07T23:40:57.894Z,1557272457.894 [NAL9602] Communications Fault, FailCount= 1
2019-05-07T23:40:57.894Z,1557272457.894 [NAL9602](ERROR): Communications Fault
2019-05-07T23:40:58.062Z,1557272458.062 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-07T23:40:58.286Z,1557272458.286 [NAL9602](INFO): Powering down
2019-05-07T23:40:59.285Z,1557272459.285 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-07T23:40:59.285Z,1557272459.285 [NAL9602] No Fault, FailCount= 1
2019-05-07T23:41:28.662Z,1557272488.662 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:41:31.942Z,1557272491.942 [SBIT](IMPORTANT): SBIT PASSED
2019-05-07T23:41:31.994Z,1557272491.994 [CommandLine](IMPORTANT): got command configSet list
2019-05-07T23:41:31.994Z,1557272491.994 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-05-07T23:41:31.995Z,1557272491.995 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup=0 bool;

2019-05-07T23:41:31.995Z,1557272491.995 [CommandLine](IMPORTANT): BPC1.batteryMissingStickThreshold=0 count;

2019-05-07T23:41:31.995Z,1557272491.995 [CommandLine](IMPORTANT): CBIT.vehicleOpen=1 bool;

2019-05-07T23:41:31.995Z,1557272491.995 [CommandLine](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool;

2019-05-07T23:41:31.995Z,1557272491.995 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2019-05-07T23:41:32.328Z,1557272492.328 [MissionManager](IMPORTANT): Started mission Startup
2019-05-07T23:41:32.329Z,1557272492.329 [Startup] Running Loop=1
2019-05-07T23:41:32.329Z,1557272492.329 [Startup](DEBUG): Aggregate::initialize Startup
2019-05-07T23:41:32.329Z,1557272492.329 [Startup:A.GoToSurface] Running Loop=1
2019-05-07T23:41:32.329Z,1557272492.329 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-05-07T23:41:32.330Z,1557272492.330 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-05-07T23:41:32.330Z,1557272492.330 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-05-07T23:41:32.331Z,1557272492.331 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-05-07T23:41:32.331Z,1557272492.331 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-05-07T23:41:32.331Z,1557272492.331 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-05-07T23:41:32.333Z,1557272492.333 [Startup:StartupSatComms] Running Loop=1
2019-05-07T23:41:32.333Z,1557272492.333 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-05-07T23:41:32.333Z,1557272492.333 [Startup:StartupSatComms:A] Running Loop=1
2019-05-07T23:41:32.726Z,1557272492.726 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-05-07T23:41:49.266Z,1557272509.266 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-07T23:41:49.266Z,1557272509.266 [NAL9602] Communications Fault, FailCount= 2
2019-05-07T23:41:49.266Z,1557272509.266 [NAL9602](ERROR): Communications Fault
2019-05-07T23:41:49.309Z,1557272509.309 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-07T23:41:49.666Z,1557272509.666 [NAL9602](INFO): Powering down
2019-05-07T23:41:50.506Z,1557272510.506 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-07T23:41:50.506Z,1557272510.506 [NAL9602] No Fault, FailCount= 2
2019-05-07T23:42:09.894Z,1557272529.894 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:42:09.894Z,1557272529.894 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-05-07T23:42:09.894Z,1557272529.894 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-05-07T23:42:09.905Z,1557272529.905 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-05-07T23:42:10.315Z,1557272530.315 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-05-07T23:42:10.315Z,1557272530.315 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-05-07T23:42:19.970Z,1557272539.970 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:42:32.517Z,1557272552.517 [Startup:StartupSatComms:A](INFO): Timed out from 2019-05-07T23:41:32.3Z
2019-05-07T23:42:32.517Z,1557272552.517 [Startup:StartupSatComms:A] Stopped
2019-05-07T23:42:32.517Z,1557272552.517 [Startup:StartupSatComms:B] Running Loop=1
2019-05-07T23:42:32.930Z,1557272552.930 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-05-07T23:42:35.127Z,1557272555.127 [DataOverHttps](INFO): Sending 102 bytes from file Logs/20190501T072355/Courier0711.lzma
2019-05-07T23:42:35.939Z,1557272555.939 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0711.lzma.bak
2019-05-07T23:42:35.939Z,1557272555.939 [DataOverHttps](INFO): SBD MOMSN=10961474
2019-05-07T23:42:40.570Z,1557272560.570 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-07T23:42:40.570Z,1557272560.570 [NAL9602] Communications Fault, FailCount= 3
2019-05-07T23:42:40.570Z,1557272560.570 [NAL9602](ERROR): Communications Fault
2019-05-07T23:42:40.602Z,1557272560.602 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-07T23:42:40.974Z,1557272560.974 [NAL9602](INFO): Powering down
2019-05-07T23:42:41.813Z,1557272561.813 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-07T23:42:41.813Z,1557272561.813 [NAL9602] No Fault, FailCount= 3
2019-05-07T23:42:57.818Z,1557272577.818 [DataOverHttps](INFO): Sending 286 bytes from file Logs/20190501T072355/Courier0714.lzma
2019-05-07T23:42:58.623Z,1557272578.623 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0714.lzma.bak
2019-05-07T23:42:58.623Z,1557272578.623 [DataOverHttps](INFO): SBD MOMSN=10961478
2019-05-07T23:43:09.318Z,1557272589.318 [DataOverHttps](INFO): Sending 239 bytes from file Logs/20190501T072355/Courier0717.lzma
2019-05-07T23:43:10.123Z,1557272590.123 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0717.lzma.bak
2019-05-07T23:43:10.123Z,1557272590.123 [DataOverHttps](INFO): SBD MOMSN=10961503
2019-05-07T23:43:11.274Z,1557272591.274 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:43:20.854Z,1557272600.854 [DataOverHttps](INFO): Sending 232 bytes from file Logs/20190501T072355/Courier0720.lzma
2019-05-07T23:43:21.659Z,1557272601.659 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0720.lzma.bak
2019-05-07T23:43:21.659Z,1557272601.659 [DataOverHttps](INFO): SBD MOMSN=10961529
2019-05-07T23:43:31.878Z,1557272611.878 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-07T23:43:31.878Z,1557272611.878 [NAL9602] Communications Fault, FailCount= 4
2019-05-07T23:43:31.878Z,1557272611.878 [NAL9602](ERROR): Communications Fault
2019-05-07T23:43:31.962Z,1557272611.962 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-07T23:43:32.282Z,1557272612.282 [NAL9602](INFO): Powering down
2019-05-07T23:43:32.526Z,1557272612.526 [DataOverHttps](INFO): Sending 239 bytes from file Logs/20190501T072355/Courier0723.lzma
2019-05-07T23:43:32.725Z,1557272612.725 [Startup:StartupSatComms:B](INFO): Timed out from 2019-05-07T23:42:32.5Z
2019-05-07T23:43:32.725Z,1557272612.725 [Startup:StartupSatComms:B] Stopped
2019-05-07T23:43:32.725Z,1557272612.725 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-05-07T23:43:32.725Z,1557272612.725 [Startup:StartupSatComms] Stopped
2019-05-07T23:43:32.725Z,1557272612.725 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-05-07T23:43:32.726Z,1557272612.726 [Startup](INFO): Completed Startup
2019-05-07T23:43:32.726Z,1557272612.726 [MissionManager](INFO): Startup is completed.
2019-05-07T23:43:32.727Z,1557272612.727 [MissionManager](INFO): Uninitializing Mission Startup
2019-05-07T23:43:32.727Z,1557272612.727 [Startup] Stopped
2019-05-07T23:43:32.727Z,1557272612.727 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-05-07T23:43:32.727Z,1557272612.727 [Startup:A.GoToSurface] Stopped
2019-05-07T23:43:32.727Z,1557272612.727 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-05-07T23:43:33.117Z,1557272613.117 [MissionManager](IMPORTANT): Started mission Default
2019-05-07T23:43:33.117Z,1557272613.117 [Default] Running Loop=1
2019-05-07T23:43:33.117Z,1557272613.117 [Default](DEBUG): Aggregate::initialize Default
2019-05-07T23:43:33.117Z,1557272613.117 [Default:B.GoToSurface] Running Loop=1
2019-05-07T23:43:33.117Z,1557272613.117 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-05-07T23:43:33.117Z,1557272613.117 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-05-07T23:43:33.118Z,1557272613.118 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-05-07T23:43:33.118Z,1557272613.118 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-05-07T23:43:33.118Z,1557272613.118 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-05-07T23:43:33.119Z,1557272613.119 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-05-07T23:43:33.119Z,1557272613.119 [Default:A.Wait] Running Loop=1
2019-05-07T23:43:33.119Z,1557272613.119 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-05-07T23:43:33.128Z,1557272613.128 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-07T23:43:33.128Z,1557272613.128 [NAL9602] No Fault, FailCount= 4
2019-05-07T23:43:33.331Z,1557272613.331 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0723.lzma.bak
2019-05-07T23:43:33.331Z,1557272613.331 [DataOverHttps](INFO): SBD MOMSN=10961554
2019-05-07T23:43:46.458Z,1557272626.458 [Default:A.Wait](INFO): Done Waiting.
2019-05-07T23:43:46.458Z,1557272626.458 [Default:A.Wait] Stopped
2019-05-07T23:43:46.458Z,1557272626.458 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-05-07T23:43:46.850Z,1557272626.850 [Default:CheckIn] Running Loop=1
2019-05-07T23:43:46.850Z,1557272626.850 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-05-07T23:43:46.850Z,1557272626.850 [Default:CheckIn:Read_GPS] Running Loop=1
2019-05-07T23:43:47.257Z,1557272627.257 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-05-07T23:44:02.586Z,1557272642.586 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:44:10.804Z,1557272650.804 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:44:10.804Z,1557272650.804 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-05-07T23:44:10.804Z,1557272650.804 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-05-07T23:44:10.823Z,1557272650.823 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-05-07T23:44:11.122Z,1557272651.122 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-05-07T23:44:11.122Z,1557272651.122 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-05-07T23:44:23.190Z,1557272663.190 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-07T23:44:23.190Z,1557272663.190 [NAL9602] Communications Fault, FailCount= 5
2019-05-07T23:44:23.190Z,1557272663.190 [NAL9602](ERROR): Communications Fault
2019-05-07T23:44:23.219Z,1557272663.219 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-07T23:44:23.220Z,1557272663.220 [CBIT](CRITICAL): Communications Fault in component: NAL9602
2019-05-07T23:44:23.590Z,1557272663.590 [NAL9602](INFO): Powering down
2019-05-07T23:44:23.623Z,1557272663.623 [CommandLine](FAULT): Scheduling is paused
2019-05-07T23:44:23.623Z,1557272663.623 [CBIT](INFO): Critical error at 20190507T234423
2019-05-07T23:44:23.624Z,1557272663.624 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-05-07T23:44:52.706Z,1557272692.706 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2019-05-07T23:46:11.887Z,1557272771.887 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:46:11.887Z,1557272771.887 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-05-07T23:46:11.887Z,1557272771.887 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-05-07T23:46:11.897Z,1557272771.897 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-05-07T23:46:12.312Z,1557272772.312 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-05-07T23:46:12.312Z,1557272772.312 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-05-07T23:46:23.210Z,1557272783.210 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-07T23:46:23.210Z,1557272783.210 [NAL9602] No Fault, FailCount= 5
2019-05-07T23:46:23.578Z,1557272783.578 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:46:44.182Z,1557272804.182 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-07T23:46:44.182Z,1557272804.182 [NAL9602] Communications Fault, FailCount= 1
2019-05-07T23:46:44.182Z,1557272804.182 [NAL9602](ERROR): Communications Fault
2019-05-07T23:46:44.217Z,1557272804.217 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-07T23:46:44.586Z,1557272804.586 [NAL9602](INFO): Powering down
2019-05-07T23:46:45.425Z,1557272805.425 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-07T23:46:45.425Z,1557272805.425 [NAL9602] No Fault, FailCount= 1
2019-05-07T23:47:14.890Z,1557272834.890 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:47:35.494Z,1557272855.494 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-07T23:47:35.494Z,1557272855.494 [NAL9602] Communications Fault, FailCount= 2
2019-05-07T23:47:35.494Z,1557272855.494 [NAL9602](ERROR): Communications Fault
2019-05-07T23:47:35.523Z,1557272855.523 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-07T23:47:35.898Z,1557272855.898 [NAL9602](INFO): Powering down
2019-05-07T23:47:36.733Z,1557272856.733 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-07T23:47:36.733Z,1557272856.733 [NAL9602] No Fault, FailCount= 2
2019-05-07T23:47:43.999Z,1557272863.999 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2019-05-07T23:47:44.003Z,1557272864.003 [BPC1](INFO): Received data from all battery sticks.
2019-05-07T23:48:06.198Z,1557272886.198 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:48:13.075Z,1557272893.075 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:48:13.075Z,1557272893.075 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2019-05-07T23:48:13.075Z,1557272893.075 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-05-07T23:48:13.086Z,1557272893.086 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-05-07T23:48:13.497Z,1557272893.497 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-05-07T23:48:13.497Z,1557272893.497 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2019-05-07T23:48:26.802Z,1557272906.802 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-07T23:48:26.802Z,1557272906.802 [NAL9602] Communications Fault, FailCount= 3
2019-05-07T23:48:26.802Z,1557272906.802 [NAL9602](ERROR): Communications Fault
2019-05-07T23:48:26.830Z,1557272906.830 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-07T23:48:27.202Z,1557272907.202 [NAL9602](INFO): Powering down
2019-05-07T23:48:28.039Z,1557272908.039 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-07T23:48:28.039Z,1557272908.039 [NAL9602] No Fault, FailCount= 3
2019-05-07T23:48:47.013Z,1557272927.013 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-05-07T23:43:46.8Z
2019-05-07T23:48:47.013Z,1557272927.013 [Default:CheckIn:Read_GPS] Stopped
2019-05-07T23:48:47.013Z,1557272927.013 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-05-07T23:48:47.429Z,1557272927.429 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-05-07T23:48:52.334Z,1557272932.334 [DataOverHttps](INFO): Sending 233 bytes from file Logs/20190501T072355/Courier0726.lzma
2019-05-07T23:48:53.138Z,1557272933.138 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0726.lzma.bak
2019-05-07T23:48:53.139Z,1557272933.139 [DataOverHttps](INFO): SBD MOMSN=10961611
2019-05-07T23:48:57.502Z,1557272937.502 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:49:03.638Z,1557272943.638 [DataOverHttps](INFO): Sending 240 bytes from file Logs/20190501T072355/Courier0729.lzma
2019-05-07T23:49:04.443Z,1557272944.443 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0729.lzma.bak
2019-05-07T23:49:04.443Z,1557272944.443 [DataOverHttps](INFO): SBD MOMSN=10961638
2019-05-07T23:49:15.014Z,1557272955.014 [DataOverHttps](INFO): Sending 238 bytes from file Logs/20190501T072355/Courier0732.lzma
2019-05-07T23:49:15.819Z,1557272955.819 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0732.lzma.bak
2019-05-07T23:49:15.819Z,1557272955.819 [DataOverHttps](INFO): SBD MOMSN=10961664
2019-05-07T23:49:18.106Z,1557272958.106 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-07T23:49:18.106Z,1557272958.106 [NAL9602] Communications Fault, FailCount= 4
2019-05-07T23:49:18.106Z,1557272958.106 [NAL9602](ERROR): Communications Fault
2019-05-07T23:49:18.141Z,1557272958.141 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-07T23:49:18.510Z,1557272958.510 [NAL9602](INFO): Powering down
2019-05-07T23:49:19.350Z,1557272959.350 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-07T23:49:19.350Z,1557272959.350 [NAL9602] No Fault, FailCount= 4
2019-05-07T23:49:26.662Z,1557272966.662 [DataOverHttps](INFO): Sending 236 bytes from file Logs/20190501T072355/Courier0735.lzma
2019-05-07T23:49:27.467Z,1557272967.467 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0735.lzma.bak
2019-05-07T23:49:27.467Z,1557272967.467 [DataOverHttps](INFO): SBD MOMSN=10961690
2019-05-07T23:49:37.986Z,1557272977.986 [DataOverHttps](INFO): Sending 238 bytes from file Logs/20190501T072355/Courier0738.lzma
2019-05-07T23:49:38.791Z,1557272978.791 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0738.lzma.bak
2019-05-07T23:49:38.791Z,1557272978.791 [DataOverHttps](INFO): SBD MOMSN=10961715
2019-05-07T23:49:48.810Z,1557272988.810 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:49:49.326Z,1557272989.326 [DataOverHttps](INFO): Sending 236 bytes from file Logs/20190501T072355/Courier0741.lzma
2019-05-07T23:49:50.131Z,1557272990.131 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0741.lzma.bak
2019-05-07T23:49:50.131Z,1557272990.131 [DataOverHttps](INFO): SBD MOMSN=10961741
2019-05-07T23:50:00.682Z,1557273000.682 [DataOverHttps](INFO): Sending 239 bytes from file Logs/20190501T072355/Courier0744.lzma
2019-05-07T23:50:01.487Z,1557273001.487 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0744.lzma.bak
2019-05-07T23:50:01.487Z,1557273001.487 [DataOverHttps](INFO): SBD MOMSN=10961769
2019-05-07T23:50:09.411Z,1557273009.411 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-07T23:50:09.411Z,1557273009.411 [NAL9602] Communications Fault, FailCount= 5
2019-05-07T23:50:09.411Z,1557273009.411 [NAL9602](ERROR): Communications Fault
2019-05-07T23:50:09.442Z,1557273009.442 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-07T23:50:09.442Z,1557273009.442 [CBIT](CRITICAL): Communications Fault in component: NAL9602
2019-05-07T23:50:09.818Z,1557273009.818 [NAL9602](INFO): Powering down
2019-05-07T23:50:09.848Z,1557273009.848 [CBIT](INFO): Critical error at 20190507T235009
2019-05-07T23:50:12.098Z,1557273012.098 [DataOverHttps](INFO): Sending 235 bytes from file Logs/20190501T072355/Courier0747.lzma
2019-05-07T23:50:12.903Z,1557273012.903 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0747.lzma.bak
2019-05-07T23:50:12.903Z,1557273012.903 [DataOverHttps](INFO): SBD MOMSN=10961796
2019-05-07T23:50:14.287Z,1557273014.287 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:50:14.287Z,1557273014.287 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5
2019-05-07T23:50:14.287Z,1557273014.287 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-05-07T23:50:14.298Z,1557273014.298 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-05-07T23:50:14.710Z,1557273014.710 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-05-07T23:50:14.710Z,1557273014.710 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5
2019-05-07T23:50:23.442Z,1557273023.442 [DataOverHttps](INFO): Sending 238 bytes from file Logs/20190501T072355/Courier0750.lzma
2019-05-07T23:50:24.247Z,1557273024.247 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0750.lzma.bak
2019-05-07T23:50:24.247Z,1557273024.247 [DataOverHttps](INFO): SBD MOMSN=10961830
2019-05-07T23:50:40.598Z,1557273040.598 [DataOverHttps](INFO): Sending 233 bytes from file Logs/20190501T072355/Courier0753.lzma
2019-05-07T23:50:41.403Z,1557273041.403 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0753.lzma.bak
2019-05-07T23:50:41.403Z,1557273041.403 [DataOverHttps](INFO): SBD MOMSN=10961858
2019-05-07T23:50:57.314Z,1557273057.314 [DataOverHttps](INFO): Sending 235 bytes from file Logs/20190501T072355/Courier0756.lzma
2019-05-07T23:50:58.119Z,1557273058.119 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0756.lzma.bak
2019-05-07T23:50:58.119Z,1557273058.119 [DataOverHttps](INFO): SBD MOMSN=10961902
2019-05-07T23:51:12.006Z,1557273072.006 [DataOverHttps](INFO): Sending 234 bytes from file Logs/20190501T072355/Courier0759.lzma
2019-05-07T23:51:12.811Z,1557273072.811 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0759.lzma.bak
2019-05-07T23:51:12.811Z,1557273072.811 [DataOverHttps](INFO): SBD MOMSN=10961980
2019-05-07T23:51:23.850Z,1557273083.850 [DataOverHttps](INFO): Sending 238 bytes from file Logs/20190501T072355/Courier0762.lzma
2019-05-07T23:51:24.655Z,1557273084.655 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0762.lzma.bak
2019-05-07T23:51:24.655Z,1557273084.655 [DataOverHttps](INFO): SBD MOMSN=10962007
2019-05-07T23:51:35.186Z,1557273095.186 [DataOverHttps](INFO): Sending 235 bytes from file Logs/20190501T072355/Courier0765.lzma
2019-05-07T23:51:35.991Z,1557273095.991 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0765.lzma.bak
2019-05-07T23:51:35.991Z,1557273095.991 [DataOverHttps](INFO): SBD MOMSN=10962035
2019-05-07T23:51:46.514Z,1557273106.514 [DataOverHttps](INFO): Sending 238 bytes from file Logs/20190501T072355/Courier0768.lzma
2019-05-07T23:51:47.319Z,1557273107.319 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0768.lzma.bak
2019-05-07T23:51:47.319Z,1557273107.319 [DataOverHttps](INFO): SBD MOMSN=10962117
2019-05-07T23:51:57.858Z,1557273117.858 [DataOverHttps](INFO): Sending 232 bytes from file Logs/20190501T072355/Courier0771.lzma
2019-05-07T23:51:58.663Z,1557273118.663 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0771.lzma.bak
2019-05-07T23:51:58.663Z,1557273118.663 [DataOverHttps](INFO): SBD MOMSN=10962145
2019-05-07T23:52:09.186Z,1557273129.186 [DataOverHttps](INFO): Sending 237 bytes from file Logs/20190501T072355/Courier0774.lzma
2019-05-07T23:52:09.448Z,1557273129.448 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-07T23:52:09.449Z,1557273129.449 [NAL9602] No Fault, FailCount= 5
2019-05-07T23:52:09.826Z,1557273129.826 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:52:09.990Z,1557273129.990 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0774.lzma.bak
2019-05-07T23:52:09.991Z,1557273129.991 [DataOverHttps](INFO): SBD MOMSN=10962170
2019-05-07T23:52:15.096Z,1557273135.096 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:52:15.096Z,1557273135.096 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6
2019-05-07T23:52:15.096Z,1557273135.096 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-05-07T23:52:15.106Z,1557273135.106 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-05-07T23:52:15.508Z,1557273135.508 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-05-07T23:52:15.509Z,1557273135.509 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6
2019-05-07T23:52:20.506Z,1557273140.506 [DataOverHttps](INFO): Sending 238 bytes from file Logs/20190501T072355/Courier0777.lzma
2019-05-07T23:52:21.311Z,1557273141.311 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0777.lzma.bak
2019-05-07T23:52:21.311Z,1557273141.311 [DataOverHttps](INFO): SBD MOMSN=10962196
2019-05-07T23:52:30.434Z,1557273150.434 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-07T23:52:30.434Z,1557273150.434 [NAL9602] Communications Fault, FailCount= 1
2019-05-07T23:52:30.434Z,1557273150.434 [NAL9602](ERROR): Communications Fault
2019-05-07T23:52:30.473Z,1557273150.473 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-07T23:52:30.830Z,1557273150.830 [NAL9602](INFO): Powering down
2019-05-07T23:52:31.669Z,1557273151.669 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-07T23:52:31.669Z,1557273151.669 [NAL9602] No Fault, FailCount= 1
2019-05-07T23:52:31.910Z,1557273151.910 [DataOverHttps](INFO): Sending 232 bytes from file Logs/20190501T072355/Courier0780.lzma
2019-05-07T23:52:32.715Z,1557273152.715 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0780.lzma.bak
2019-05-07T23:52:32.715Z,1557273152.715 [DataOverHttps](INFO): SBD MOMSN=10962222
2019-05-07T23:52:43.246Z,1557273163.246 [DataOverHttps](INFO): Sending 239 bytes from file Logs/20190501T072355/Courier0783.lzma
2019-05-07T23:52:44.051Z,1557273164.051 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0783.lzma.bak
2019-05-07T23:52:44.051Z,1557273164.051 [DataOverHttps](INFO): SBD MOMSN=10962247
2019-05-07T23:52:54.566Z,1557273174.566 [DataOverHttps](INFO): Sending 236 bytes from file Logs/20190501T072355/Courier0786.lzma
2019-05-07T23:52:55.371Z,1557273175.371 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0786.lzma.bak
2019-05-07T23:52:55.371Z,1557273175.371 [DataOverHttps](INFO): SBD MOMSN=10962273
2019-05-07T23:53:01.134Z,1557273181.134 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:53:05.886Z,1557273185.886 [DataOverHttps](INFO): Sending 239 bytes from file Logs/20190501T072355/Courier0789.lzma
2019-05-07T23:53:06.691Z,1557273186.691 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0789.lzma.bak
2019-05-07T23:53:06.691Z,1557273186.691 [DataOverHttps](INFO): SBD MOMSN=10962298
2019-05-07T23:53:18.050Z,1557273198.050 [DataOverHttps](INFO): Sending 236 bytes from file Logs/20190501T072355/Courier0792.lzma
2019-05-07T23:53:18.855Z,1557273198.855 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0792.lzma.bak
2019-05-07T23:53:18.855Z,1557273198.855 [DataOverHttps](INFO): SBD MOMSN=10962324
2019-05-07T23:53:21.734Z,1557273201.734 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-07T23:53:21.734Z,1557273201.734 [NAL9602] Communications Fault, FailCount= 2
2019-05-07T23:53:21.734Z,1557273201.734 [NAL9602](ERROR): Communications Fault
2019-05-07T23:53:21.766Z,1557273201.766 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-07T23:53:22.138Z,1557273202.138 [NAL9602](INFO): Powering down
2019-05-07T23:53:22.977Z,1557273202.977 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-07T23:53:22.977Z,1557273202.977 [NAL9602] No Fault, FailCount= 2
2019-05-07T23:53:29.474Z,1557273209.474 [DataOverHttps](INFO): Sending 238 bytes from file Logs/20190501T072355/Courier0795.lzma
2019-05-07T23:53:30.279Z,1557273210.279 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0795.lzma.bak
2019-05-07T23:53:30.279Z,1557273210.279 [DataOverHttps](INFO): SBD MOMSN=10962349
2019-05-07T23:53:40.770Z,1557273220.770 [DataOverHttps](INFO): Sending 232 bytes from file Logs/20190501T072355/Courier0798.lzma
2019-05-07T23:53:41.575Z,1557273221.575 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0798.lzma.bak
2019-05-07T23:53:41.575Z,1557273221.575 [DataOverHttps](INFO): SBD MOMSN=10962375
2019-05-07T23:53:52.170Z,1557273232.170 [DataOverHttps](INFO): Sending 238 bytes from file Logs/20190501T072355/Courier0801.lzma
2019-05-07T23:53:52.442Z,1557273232.442 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:53:52.975Z,1557273232.975 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0801.lzma.bak
2019-05-07T23:53:52.975Z,1557273232.975 [DataOverHttps](INFO): SBD MOMSN=10962400
2019-05-07T23:54:03.498Z,1557273243.498 [DataOverHttps](INFO): Sending 232 bytes from file Logs/20190501T072355/Courier0804.lzma
2019-05-07T23:54:04.303Z,1557273244.303 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0804.lzma.bak
2019-05-07T23:54:04.303Z,1557273244.303 [DataOverHttps](INFO): SBD MOMSN=10962426
2019-05-07T23:54:13.042Z,1557273253.042 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-07T23:54:13.042Z,1557273253.042 [NAL9602] Communications Fault, FailCount= 3
2019-05-07T23:54:13.042Z,1557273253.042 [NAL9602](ERROR): Communications Fault
2019-05-07T23:54:13.077Z,1557273253.077 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-07T23:54:13.446Z,1557273253.446 [NAL9602](INFO): Powering down
2019-05-07T23:54:14.280Z,1557273254.280 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-07T23:54:14.280Z,1557273254.280 [NAL9602] No Fault, FailCount= 3
2019-05-07T23:54:16.296Z,1557273256.296 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:54:16.296Z,1557273256.296 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7
2019-05-07T23:54:16.296Z,1557273256.296 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-05-07T23:54:16.306Z,1557273256.306 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-05-07T23:54:16.705Z,1557273256.705 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-05-07T23:54:16.705Z,1557273256.705 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7
2019-05-07T23:54:19.982Z,1557273259.982 [DataOverHttps](INFO): Sending 237 bytes from file Logs/20190501T072355/Courier0807.lzma
2019-05-07T23:54:20.787Z,1557273260.787 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0807.lzma.bak
2019-05-07T23:54:20.787Z,1557273260.787 [DataOverHttps](INFO): SBD MOMSN=10962455
2019-05-07T23:54:31.310Z,1557273271.310 [DataOverHttps](INFO): Sending 233 bytes from file Logs/20190501T072355/Courier0810.lzma
2019-05-07T23:54:32.115Z,1557273272.115 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0810.lzma.bak
2019-05-07T23:54:32.115Z,1557273272.115 [DataOverHttps](INFO): SBD MOMSN=10962496
2019-05-07T23:54:42.638Z,1557273282.638 [DataOverHttps](INFO): Sending 239 bytes from file Logs/20190501T072355/Courier0813.lzma
2019-05-07T23:54:43.443Z,1557273283.443 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0813.lzma.bak
2019-05-07T23:54:43.443Z,1557273283.443 [DataOverHttps](INFO): SBD MOMSN=10962521
2019-05-07T23:54:43.746Z,1557273283.746 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:54:53.954Z,1557273293.954 [DataOverHttps](INFO): Sending 234 bytes from file Logs/20190501T072355/Courier0816.lzma
2019-05-07T23:54:54.759Z,1557273294.759 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0816.lzma.bak
2019-05-07T23:54:54.759Z,1557273294.759 [DataOverHttps](INFO): SBD MOMSN=10962547
2019-05-07T23:55:04.350Z,1557273304.350 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-07T23:55:04.350Z,1557273304.350 [NAL9602] Communications Fault, FailCount= 4
2019-05-07T23:55:04.350Z,1557273304.350 [NAL9602](ERROR): Communications Fault
2019-05-07T23:55:04.386Z,1557273304.386 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-07T23:55:04.754Z,1557273304.754 [NAL9602](INFO): Powering down
2019-05-07T23:55:05.370Z,1557273305.370 [DataOverHttps](INFO): Sending 238 bytes from file Logs/20190501T072355/Courier0819.lzma
2019-05-07T23:55:05.594Z,1557273305.594 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-07T23:55:05.594Z,1557273305.594 [NAL9602] No Fault, FailCount= 4
2019-05-07T23:55:06.175Z,1557273306.175 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0819.lzma.bak
2019-05-07T23:55:06.175Z,1557273306.175 [DataOverHttps](INFO): SBD MOMSN=10962572
2019-05-07T23:55:16.734Z,1557273316.734 [DataOverHttps](INFO): Sending 240 bytes from file Logs/20190501T072355/Courier0822.lzma
2019-05-07T23:55:17.539Z,1557273317.539 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0822.lzma.bak
2019-05-07T23:55:17.539Z,1557273317.539 [DataOverHttps](INFO): SBD MOMSN=10962598
2019-05-07T23:55:28.042Z,1557273328.042 [DataOverHttps](INFO): Sending 234 bytes from file Logs/20190501T072355/Courier0825.lzma
2019-05-07T23:55:28.847Z,1557273328.847 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0825.lzma.bak
2019-05-07T23:55:28.847Z,1557273328.847 [DataOverHttps](INFO): SBD MOMSN=10962624
2019-05-07T23:55:35.058Z,1557273335.058 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:55:48.558Z,1557273348.558 [DataOverHttps](INFO): Sending 241 bytes from file Logs/20190501T072355/Courier0828.lzma
2019-05-07T23:55:49.363Z,1557273349.363 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0828.lzma.bak
2019-05-07T23:55:49.363Z,1557273349.363 [DataOverHttps](INFO): SBD MOMSN=10962656
2019-05-07T23:55:55.666Z,1557273355.666 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-07T23:55:55.666Z,1557273355.666 [NAL9602] Communications Fault, FailCount= 5
2019-05-07T23:55:55.666Z,1557273355.666 [NAL9602](ERROR): Communications Fault
2019-05-07T23:55:55.694Z,1557273355.694 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-07T23:55:55.695Z,1557273355.695 [CBIT](CRITICAL): Communications Fault in component: NAL9602
2019-05-07T23:55:56.066Z,1557273356.066 [NAL9602](INFO): Powering down
2019-05-07T23:55:56.099Z,1557273356.099 [CBIT](INFO): Critical error at 20190507T235555
2019-05-07T23:55:59.910Z,1557273359.910 [DataOverHttps](INFO): Sending 233 bytes from file Logs/20190501T072355/Courier0831.lzma
2019-05-07T23:56:00.715Z,1557273360.715 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0831.lzma.bak
2019-05-07T23:56:00.715Z,1557273360.715 [DataOverHttps](INFO): SBD MOMSN=10962682
2019-05-07T23:56:11.250Z,1557273371.250 [DataOverHttps](INFO): Sending 239 bytes from file Logs/20190501T072355/Courier0834.lzma
2019-05-07T23:56:12.055Z,1557273372.055 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0834.lzma.bak
2019-05-07T23:56:12.055Z,1557273372.055 [DataOverHttps](INFO): SBD MOMSN=10962707
2019-05-07T23:56:17.499Z,1557273377.499 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:56:17.499Z,1557273377.499 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8
2019-05-07T23:56:17.499Z,1557273377.499 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-05-07T23:56:17.510Z,1557273377.510 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-05-07T23:56:17.907Z,1557273377.907 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-05-07T23:56:17.908Z,1557273377.908 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8
2019-05-07T23:56:22.582Z,1557273382.582 [DataOverHttps](INFO): Sending 234 bytes from file Logs/20190501T072355/Courier0837.lzma
2019-05-07T23:56:23.945Z,1557273383.945 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0837.lzma.bak
2019-05-07T23:56:23.945Z,1557273383.945 [DataOverHttps](INFO): SBD MOMSN=10962733
2019-05-07T23:56:34.160Z,1557273394.160 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20190501T072355/Courier0840.lzma
2019-05-07T23:56:34.967Z,1557273394.967 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Courier0840.lzma.bak
2019-05-07T23:56:34.967Z,1557273394.967 [DataOverHttps](INFO): SBD MOMSN=10962761
2019-05-07T23:56:50.890Z,1557273410.890 [DataOverHttps](INFO): Sending 211 bytes from file Logs/20190506T204813/Courier0000.lzma
2019-05-07T23:56:51.694Z,1557273411.694 [DataOverHttps](INFO): Moved sent file to Logs/20190506T204813/Courier0000.lzma.bak
2019-05-07T23:56:51.694Z,1557273411.694 [DataOverHttps](INFO): SBD MOMSN=10962766
2019-05-07T23:57:02.224Z,1557273422.224 [DataOverHttps](INFO): Sending 248 bytes from file Logs/20190507T233959/Courier0004.lzma
2019-05-07T23:57:03.030Z,1557273423.030 [DataOverHttps](INFO): Moved sent file to Logs/20190507T233959/Courier0004.lzma.bak
2019-05-07T23:57:03.030Z,1557273423.030 [DataOverHttps](INFO): SBD MOMSN=10962772
2019-05-07T23:57:13.730Z,1557273433.730 [DataOverHttps](INFO): Sending 227 bytes from file Logs/20190501T072355/Express0712.lzma
2019-05-07T23:57:14.535Z,1557273434.535 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0712.lzma.bak
2019-05-07T23:57:14.535Z,1557273434.535 [DataOverHttps](INFO): SBD MOMSN=10962776
2019-05-07T23:57:25.511Z,1557273445.511 [DataOverHttps](INFO): Sending 871 bytes from file Logs/20190501T072355/Express0715.lzma
2019-05-07T23:57:26.314Z,1557273446.314 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0715.lzma.bak
2019-05-07T23:57:26.315Z,1557273446.315 [DataOverHttps](INFO): SBD MOMSN=10962791
2019-05-07T23:57:37.326Z,1557273457.326 [DataOverHttps](INFO): Sending 633 bytes from file Logs/20190501T072355/Express0718.lzma
2019-05-07T23:57:38.131Z,1557273458.131 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0718.lzma.bak
2019-05-07T23:57:38.131Z,1557273458.131 [DataOverHttps](INFO): SBD MOMSN=10962914
2019-05-07T23:57:49.123Z,1557273469.123 [DataOverHttps](INFO): Sending 918 bytes from file Logs/20190501T072355/Express0721.lzma
2019-05-07T23:57:49.926Z,1557273469.926 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0721.lzma.bak
2019-05-07T23:57:49.927Z,1557273469.927 [DataOverHttps](INFO): SBD MOMSN=10963047
2019-05-07T23:57:55.685Z,1557273475.685 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-07T23:57:55.685Z,1557273475.685 [NAL9602] No Fault, FailCount= 5
2019-05-07T23:57:56.058Z,1557273476.058 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:58:01.018Z,1557273481.018 [DataOverHttps](INFO): Sending 683 bytes from file Logs/20190501T072355/Express0724.lzma
2019-05-07T23:58:01.823Z,1557273481.823 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0724.lzma.bak
2019-05-07T23:58:01.823Z,1557273481.823 [DataOverHttps](INFO): SBD MOMSN=10963170
2019-05-07T23:58:12.847Z,1557273492.847 [DataOverHttps](INFO): Sending 666 bytes from file Logs/20190501T072355/Express0727.lzma
2019-05-07T23:58:13.651Z,1557273493.651 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0727.lzma.bak
2019-05-07T23:58:13.651Z,1557273493.651 [DataOverHttps](INFO): SBD MOMSN=10963295
2019-05-07T23:58:16.658Z,1557273496.658 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-07T23:58:16.658Z,1557273496.658 [NAL9602] Communications Fault, FailCount= 1
2019-05-07T23:58:16.658Z,1557273496.658 [NAL9602](ERROR): Communications Fault
2019-05-07T23:58:16.721Z,1557273496.721 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-07T23:58:17.062Z,1557273497.062 [NAL9602](INFO): Powering down
2019-05-07T23:58:17.897Z,1557273497.897 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-07T23:58:17.897Z,1557273497.897 [NAL9602] No Fault, FailCount= 1
2019-05-07T23:58:18.696Z,1557273498.696 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-07T23:58:18.696Z,1557273498.696 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9
2019-05-07T23:58:18.696Z,1557273498.696 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-05-07T23:58:18.706Z,1557273498.706 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-05-07T23:58:19.111Z,1557273499.111 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-05-07T23:58:19.112Z,1557273499.112 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9
2019-05-07T23:58:24.711Z,1557273504.711 [DataOverHttps](INFO): Sending 870 bytes from file Logs/20190501T072355/Express0730.lzma
2019-05-07T23:58:25.515Z,1557273505.515 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0730.lzma.bak
2019-05-07T23:58:25.515Z,1557273505.515 [DataOverHttps](INFO): SBD MOMSN=10963425
2019-05-07T23:58:36.546Z,1557273516.546 [DataOverHttps](INFO): Sending 648 bytes from file Logs/20190501T072355/Express0733.lzma
2019-05-07T23:58:37.351Z,1557273517.351 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0733.lzma.bak
2019-05-07T23:58:37.351Z,1557273517.351 [DataOverHttps](INFO): SBD MOMSN=10963548
2019-05-07T23:58:47.362Z,1557273527.362 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:58:48.346Z,1557273528.346 [DataOverHttps](INFO): Sending 693 bytes from file Logs/20190501T072355/Express0736.lzma
2019-05-07T23:58:49.151Z,1557273529.151 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0736.lzma.bak
2019-05-07T23:58:49.151Z,1557273529.151 [DataOverHttps](INFO): SBD MOMSN=10963683
2019-05-07T23:59:00.155Z,1557273540.155 [DataOverHttps](INFO): Sending 883 bytes from file Logs/20190501T072355/Express0739.lzma
2019-05-07T23:59:00.959Z,1557273540.959 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0739.lzma.bak
2019-05-07T23:59:00.959Z,1557273540.959 [DataOverHttps](INFO): SBD MOMSN=10963802
2019-05-07T23:59:07.972Z,1557273547.972 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-07T23:59:07.972Z,1557273547.972 [NAL9602] Communications Fault, FailCount= 2
2019-05-07T23:59:07.972Z,1557273547.972 [NAL9602](ERROR): Communications Fault
2019-05-07T23:59:08.006Z,1557273548.006 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-07T23:59:08.370Z,1557273548.370 [NAL9602](INFO): Powering down
2019-05-07T23:59:09.206Z,1557273549.206 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-07T23:59:09.206Z,1557273549.206 [NAL9602] No Fault, FailCount= 2
2019-05-07T23:59:12.050Z,1557273552.050 [DataOverHttps](INFO): Sending 669 bytes from file Logs/20190501T072355/Express0742.lzma
2019-05-07T23:59:12.855Z,1557273552.855 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0742.lzma.bak
2019-05-07T23:59:12.855Z,1557273552.855 [DataOverHttps](INFO): SBD MOMSN=10963931
2019-05-07T23:59:23.859Z,1557273563.859 [DataOverHttps](INFO): Sending 716 bytes from file Logs/20190501T072355/Express0745.lzma
2019-05-07T23:59:24.663Z,1557273564.663 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0745.lzma.bak
2019-05-07T23:59:24.663Z,1557273564.663 [DataOverHttps](INFO): SBD MOMSN=10964061
2019-05-07T23:59:36.135Z,1557273576.135 [DataOverHttps](INFO): Sending 857 bytes from file Logs/20190501T072355/Express0748.lzma
2019-05-07T23:59:36.939Z,1557273576.939 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0748.lzma.bak
2019-05-07T23:59:36.939Z,1557273576.939 [DataOverHttps](INFO): SBD MOMSN=10964184
2019-05-07T23:59:38.670Z,1557273578.670 [NAL9602](INFO): Powering up NAL9602
2019-05-07T23:59:47.911Z,1557273587.911 [DataOverHttps](INFO): Sending 748 bytes from file Logs/20190501T072355/Express0751.lzma
2019-05-07T23:59:48.714Z,1557273588.714 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0751.lzma.bak
2019-05-07T23:59:48.715Z,1557273588.715 [DataOverHttps](INFO): SBD MOMSN=10964319
2019-05-07T23:59:59.272Z,1557273599.272 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-07T23:59:59.272Z,1557273599.272 [NAL9602] Communications Fault, FailCount= 3
2019-05-07T23:59:59.272Z,1557273599.272 [NAL9602](ERROR): Communications Fault
2019-05-07T23:59:59.302Z,1557273599.302 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-07T23:59:59.678Z,1557273599.678 [NAL9602](INFO): Powering down
2019-05-07T23:59:59.803Z,1557273599.803 [DataOverHttps](INFO): Sending 870 bytes from file Logs/20190501T072355/Express0754.lzma
2019-05-08T00:00:00.533Z,1557273600.533 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-08T00:00:00.533Z,1557273600.533 [NAL9602] No Fault, FailCount= 3
2019-05-08T00:00:00.607Z,1557273600.607 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0754.lzma.bak
2019-05-08T00:00:00.607Z,1557273600.607 [DataOverHttps](INFO): SBD MOMSN=10964440
2019-05-08T00:00:17.258Z,1557273617.258 [DataOverHttps](INFO): Sending 648 bytes from file Logs/20190501T072355/Express0757.lzma
2019-05-08T00:00:18.063Z,1557273618.063 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0757.lzma.bak
2019-05-08T00:00:18.063Z,1557273618.063 [DataOverHttps](INFO): SBD MOMSN=10964572
2019-05-08T00:00:19.899Z,1557273619.899 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-08T00:00:19.900Z,1557273619.900 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10
2019-05-08T00:00:19.900Z,1557273619.900 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-05-08T00:00:19.910Z,1557273619.910 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-05-08T00:00:20.313Z,1557273620.313 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-05-08T00:00:20.313Z,1557273620.313 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10
2019-05-08T00:00:29.043Z,1557273629.043 [DataOverHttps](INFO): Sending 749 bytes from file Logs/20190501T072355/Express0760.lzma
2019-05-08T00:00:29.847Z,1557273629.847 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0760.lzma.bak
2019-05-08T00:00:29.847Z,1557273629.847 [DataOverHttps](INFO): SBD MOMSN=10964729
2019-05-08T00:00:29.976Z,1557273629.976 [NAL9602](INFO): Powering up NAL9602
2019-05-08T00:00:40.851Z,1557273640.851 [DataOverHttps](INFO): Sending 843 bytes from file Logs/20190501T072355/Express0763.lzma
2019-05-08T00:00:41.655Z,1557273641.655 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0763.lzma.bak
2019-05-08T00:00:41.655Z,1557273641.655 [DataOverHttps](INFO): SBD MOMSN=10964850
2019-05-08T00:00:50.594Z,1557273650.594 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-08T00:00:50.594Z,1557273650.594 [NAL9602] Communications Fault, FailCount= 4
2019-05-08T00:00:50.594Z,1557273650.594 [NAL9602](ERROR): Communications Fault
2019-05-08T00:00:50.623Z,1557273650.623 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-08T00:00:50.998Z,1557273650.998 [NAL9602](INFO): Powering down
2019-05-08T00:00:51.848Z,1557273651.848 [CBIT](INFO): Clearing failed state for component NAL9602
2019-05-08T00:00:51.849Z,1557273651.849 [NAL9602] No Fault, FailCount= 4
2019-05-08T00:00:55.194Z,1557273655.194 [DataOverHttps](INFO): Sending 706 bytes from file Logs/20190501T072355/Express0766.lzma
2019-05-08T00:00:55.999Z,1557273655.999 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0766.lzma.bak
2019-05-08T00:00:55.999Z,1557273655.999 [DataOverHttps](INFO): SBD MOMSN=10964987
2019-05-08T00:01:07.274Z,1557273667.274 [DataOverHttps](INFO): Sending 686 bytes from file Logs/20190501T072355/Express0769.lzma
2019-05-08T00:01:08.079Z,1557273668.079 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0769.lzma.bak
2019-05-08T00:01:08.079Z,1557273668.079 [DataOverHttps](INFO): SBD MOMSN=10965108
2019-05-08T00:01:19.087Z,1557273679.087 [DataOverHttps](INFO): Sending 822 bytes from file Logs/20190501T072355/Express0772.lzma
2019-05-08T00:01:19.891Z,1557273679.891 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0772.lzma.bak
2019-05-08T00:01:19.891Z,1557273679.891 [DataOverHttps](INFO): SBD MOMSN=10965242
2019-05-08T00:01:21.294Z,1557273681.294 [NAL9602](INFO): Powering up NAL9602
2019-05-08T00:01:30.878Z,1557273690.878 [DataOverHttps](INFO): Sending 689 bytes from file Logs/20190501T072355/Express0775.lzma
2019-05-08T00:01:31.682Z,1557273691.682 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0775.lzma.bak
2019-05-08T00:01:31.683Z,1557273691.683 [DataOverHttps](INFO): SBD MOMSN=10965374
2019-05-08T00:01:41.898Z,1557273701.898 [NAL9602](ERROR): NAL9602 initialization error.
2019-05-08T00:01:41.898Z,1557273701.898 [NAL9602] Communications Fault, FailCount= 5
2019-05-08T00:01:41.898Z,1557273701.898 [NAL9602](ERROR): Communications Fault
2019-05-08T00:01:41.942Z,1557273701.942 [CBIT](ERROR): Communications Fault in component: NAL9602
2019-05-08T00:01:41.942Z,1557273701.942 [CBIT](CRITICAL): Communications Fault in component: NAL9602
2019-05-08T00:01:42.302Z,1557273702.302 [NAL9602](INFO): Powering down
2019-05-08T00:01:42.343Z,1557273702.343 [CBIT](INFO): Critical error at 20190508T000141
2019-05-08T00:01:42.806Z,1557273702.806 [DataOverHttps](INFO): Sending 643 bytes from file Logs/20190501T072355/Express0778.lzma
2019-05-08T00:01:43.611Z,1557273703.611 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0778.lzma.bak
2019-05-08T00:01:43.611Z,1557273703.611 [DataOverHttps](INFO): SBD MOMSN=10965495
2019-05-08T00:01:54.607Z,1557273714.607 [DataOverHttps](INFO): Sending 912 bytes from file Logs/20190501T072355/Express0781.lzma
2019-05-08T00:01:55.411Z,1557273715.411 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0781.lzma.bak
2019-05-08T00:01:55.411Z,1557273715.411 [DataOverHttps](INFO): SBD MOMSN=10965679
2019-05-08T00:02:06.222Z,1557273726.222 [CommandLine](IMPORTANT): got command show variable PAR
2019-05-08T00:02:06.298Z,1557273726.298 [CommandLine](IMPORTANT): PAR_Licor.loadControl (none)
2019-05-08T00:02:06.298Z,1557273726.298 [CommandLine](IMPORTANT): PAR_Licor.ad (none)
2019-05-08T00:02:06.298Z,1557273726.298 [CommandLine](IMPORTANT): PAR_Licor.adRes (bit)
2019-05-08T00:02:06.299Z,1557273726.299 [CommandLine](IMPORTANT): PAR_Licor.adTimeout (millisecond)
2019-05-08T00:02:06.299Z,1557273726.299 [CommandLine](IMPORTANT): PAR_Licor.adVref (volt)
2019-05-08T00:02:06.308Z,1557273726.308 [CommandLine](IMPORTANT): PAR_Licor.loadAtStartup (bool)
2019-05-08T00:02:06.308Z,1557273726.308 [CommandLine](IMPORTANT): PAR_Licor.simulateHardware (bool)
2019-05-08T00:02:06.309Z,1557273726.309 [CommandLine](IMPORTANT): PAR_Licor.adcCal (microampere_per_count)
2019-05-08T00:02:06.309Z,1557273726.309 [CommandLine](IMPORTANT): PAR_Licor.darkCount (count)
2019-05-08T00:02:06.309Z,1557273726.309 [CommandLine](IMPORTANT): PAR_Licor.maxBound (micromole_per_second_per_square_meter)
2019-05-08T00:02:06.310Z,1557273726.310 [CommandLine](IMPORTANT): PAR_Licor.maxValidPitch (degree)
2019-05-08T00:02:06.310Z,1557273726.310 [CommandLine](IMPORTANT): PAR_Licor.minBound (micromole_per_second_per_square_meter)
2019-05-08T00:02:06.311Z,1557273726.311 [CommandLine](IMPORTANT): PAR_Licor.minValidPitch (degree)
2019-05-08T00:02:06.311Z,1557273726.311 [CommandLine](IMPORTANT): PAR_Licor.multiplier (micromole_per_second_per_square_meter_per_microampere)
2019-05-08T00:02:06.311Z,1557273726.311 [CommandLine](IMPORTANT): PAR_Licor.serial (none)
2019-05-08T00:02:06.595Z,1557273726.595 [DataOverHttps](INFO): Sending 698 bytes from file Logs/20190501T072355/Express0784.lzma
2019-05-08T00:02:07.399Z,1557273727.399 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0784.lzma.bak
2019-05-08T00:02:07.399Z,1557273727.399 [DataOverHttps](INFO): SBD MOMSN=10965802
2019-05-08T00:02:18.447Z,1557273738.447 [DataOverHttps](INFO): Sending 620 bytes from file Logs/20190501T072355/Express0787.lzma
2019-05-08T00:02:19.251Z,1557273739.251 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0787.lzma.bak
2019-05-08T00:02:19.251Z,1557273739.251 [DataOverHttps](INFO): SBD MOMSN=10965933
2019-05-08T00:02:21.109Z,1557273741.109 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-05-08T00:02:21.109Z,1557273741.109 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11
2019-05-08T00:02:21.109Z,1557273741.109 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-05-08T00:02:21.119Z,1557273741.119 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-05-08T00:02:21.528Z,1557273741.528 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-05-08T00:02:21.528Z,1557273741.528 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11
2019-05-08T00:02:21.990Z,1557273741.990 [CommandLine](IMPORTANT): got command run ./Missions/Insert/Science.xml
2019-05-08T00:02:21.990Z,1557273741.990 [MissionManager](INFO): Loading Mission: ./Missions/Insert/Science.xml
2019-05-08T00:02:22.363Z,1557273742.363 [MissionManager](INFO): DefineArg Science.SampleISUS = 0 bool
2019-05-08T00:02:22.378Z,1557273742.378 [MissionManager](INFO): DefineArg Science.SampleISUSmaxPitch = 60.000000 arcdeg
2019-05-08T00:02:22.381Z,1557273742.381 [MissionManager](INFO): DefineArg Science.SampleISUSminPitch = -60.000000 arcdeg
2019-05-08T00:02:22.384Z,1557273742.384 [MissionManager](INFO): DefineArg Science.PeakDetectChlActive = 0 bool
2019-05-08T00:02:22.387Z,1557273742.387 [MissionManager](INFO): DefineArg Science.TimeWindowPeakReport = nan min
2019-05-08T00:02:22.402Z,1557273742.402 [MissionManager](INFO): DefineArg Science.HighestChlPeakReportActive = 0 bool
2019-05-08T00:02:22.405Z,1557273742.405 [MissionManager](INFO): DefineArg Science.PatchTracking = 0 bool
2019-05-08T00:02:22.408Z,1557273742.408 [MissionManager](INFO): DefineArg Science.FilterWidthHorizontal = 3.000000 count
2019-05-08T00:02:22.411Z,1557273742.411 [MissionManager](INFO): DefineArg Science.NumProfilesSlidingwindow = 100.000000 count
2019-05-08T00:02:22.426Z,1557273742.426 [MissionManager](INFO): DefineArg Science.OffPeakFractionHorizontal = 80.000000 %
2019-05-08T00:02:22.429Z,1557273742.429 [MissionManager](INFO): DefineArg Science.PeakDetectNO3Active = 0 bool
2019-05-08T00:02:22.432Z,1557273742.432 [MissionManager](INFO): DefineArg Science.PeakDetectOilActive = 0 bool
2019-05-08T00:02:22.435Z,1557273742.435 [MissionManager](INFO): DefineArg Science.PeakDetectFDOMActive = 0 bool
2019-05-08T00:02:22.484Z,1557273742.484 [MissionManager](INFO): DefineArg Science.UpwardDerivativeOfTemperatureActive = 0 bool
2019-05-08T00:02:22.510Z,1557273742.510 [MissionManager](INFO): DefineArg Science.EnabledAanderaaO2 = 0.000000 bool
2019-05-08T00:02:22.515Z,1557273742.515 [MissionManager](INFO): DefineArg Science.EnabledNeilBrown = 1.000000 bool
2019-05-08T00:02:22.531Z,1557273742.531 [MissionManager](INFO): DefineArg Science.EnabledSeabird = 0.000000 bool
2019-05-08T00:02:22.535Z,1557273742.535 [MissionManager](INFO): DefineArg Science.EnabledTurbulence_NPS = 0.000000 bool
2019-05-08T00:02:22.555Z,1557273742.555 [MissionManager](INFO): DefineArg Science.EnabledWetLabsBB2FL = 1.000000 bool
2019-05-08T00:02:22.558Z,1557273742.558 [MissionManager](INFO): DefineArg Science.EnabledWetLabsSeaOWL_UV_A = 0.000000 bool
2019-05-08T00:02:22.586Z,1557273742.586 [MissionManager](INFO): DefineArg Science.EnabledWetLabsUBAT = 0.000000 bool
2019-05-08T00:02:22.590Z,1557273742.590 [MissionManager](INFO): DefineArg Science.EnabledISUS = 0.000000 bool
2019-05-08T00:02:22.613Z,1557273742.613 [MissionManager](INFO): DefineArg Science.LowPassWindowLength = 20.000000 count
2019-05-08T00:02:22.627Z,1557273742.627 [MissionManager](INFO): DefineArg Science.MedianFilterLen = 5.000000 count
2019-05-08T00:02:22.630Z,1557273742.630 [MissionManager](INFO): DefineArg Science.PeakChlShallowBound = nan m
2019-05-08T00:02:22.634Z,1557273742.634 [MissionManager](INFO): DefineArg Science.PeakChlDeepBound = nan m
2019-05-08T00:02:22.637Z,1557273742.637 [MissionManager](INFO): DefineArg Science.PeakShallowBound = nan m
2019-05-08T00:02:22.640Z,1557273742.640 [MissionManager](INFO): DefineArg Science.PeakDeepBound = nan m
2019-05-08T00:02:22.672Z,1557273742.672 [MissionManager](INFO): DefineOutput Science.PeakChl = 0.000000 ug/l
2019-05-08T00:02:22.675Z,1557273742.675 [MissionManager](INFO): DefineOutput Science.PeakChlDepth = 0.000000 m
2019-05-08T00:02:22.734Z,1557273742.734 [MissionManager](INFO): DefineOutput Science.PeakChlTemperature = 0.000000 degC
2019-05-08T00:02:22.738Z,1557273742.738 [MissionManager](INFO): DefineOutput Science.PeakChlLatitude = nan arcdeg
2019-05-08T00:02:22.760Z,1557273742.760 [MissionManager](INFO): DefineOutput Science.PeakChlLongitude = nan arcdeg
2019-05-08T00:02:22.785Z,1557273742.785 [MissionManager](INFO): DefineOutput Science.PeakNO3 = 0.000000 umol/l
2019-05-08T00:02:22.789Z,1557273742.789 [MissionManager](INFO): DefineOutput Science.PeakNO3Depth = 0.000000 m
2019-05-08T00:02:22.792Z,1557273742.792 [MissionManager](INFO): DefineOutput Science.PeakNO3Latitude = nan arcdeg
2019-05-08T00:02:22.811Z,1557273742.811 [MissionManager](INFO): DefineOutput Science.PeakNO3Longitude = nan arcdeg
2019-05-08T00:02:22.814Z,1557273742.814 [MissionManager](INFO): DefineOutput Science.PatchChl = 0.000000 m
2019-05-08T00:02:22.834Z,1557273742.834 [MissionManager](INFO): DefineOutput Science.PatchChlDepth = 0.000000 m
2019-05-08T00:02:22.837Z,1557273742.837 [MissionManager](INFO): DefineOutput Science.PatchChlLatitude = nan arcdeg
2019-05-08T00:02:22.865Z,1557273742.865 [MissionManager](INFO): DefineOutput Science.PatchChlLongitude = nan arcdeg
2019-05-08T00:02:22.868Z,1557273742.868 [MissionManager](INFO): DefineOutput Science.PatchChlDistance = nan m
2019-05-08T00:02:22.871Z,1557273742.871 [MissionManager](INFO): DefineOutput Science.PeakOil = 0.000000 kg/m3
2019-05-08T00:02:22.887Z,1557273742.887 [MissionManager](INFO): DefineOutput Science.PeakOilDepth = 0.000000 m
2019-05-08T00:02:22.906Z,1557273742.906 [MissionManager](INFO): DefineOutput Science.PeakOilLatitude = nan arcdeg
2019-05-08T00:02:22.910Z,1557273742.910 [MissionManager](INFO): DefineOutput Science.PeakOilLongitude = nan arcdeg
2019-05-08T00:02:22.914Z,1557273742.914 [MissionManager](INFO): DefineOutput Science.PeakFDOM = 0.000000 ppb
2019-05-08T00:02:22.938Z,1557273742.938 [MissionManager](INFO): DefineOutput Science.PeakFDOMDepth = 0.000000 m
2019-05-08T00:02:22.942Z,1557273742.942 [MissionManager](INFO): DefineOutput Science.PeakFDOMLatitude = nan arcdeg
2019-05-08T00:02:22.956Z,1557273742.956 [MissionManager](INFO): DefineOutput Science.PeakFDOMLongitude = nan arcdeg
2019-05-08T00:02:22.963Z,1557273742.963 [MissionManager](INFO): DefineOutput Science.PatchFDOMDistance = nan m
2019-05-08T00:02:23.022Z,1557273743.022 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-05-08T00:02:23.075Z,1557273743.075 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2019-05-08T00:02:23.173Z,1557273743.173 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-05-08T00:02:23.200Z,1557273743.200 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-05-08T00:02:23.244Z,1557273743.244 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-05-08T00:02:23.355Z,1557273743.355 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<!-- ====================
     Generated by TethysL
     ==================== -->
<Aggregate xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
           xmlns="Tethys"
           xmlns:Units="Tethys/Units"
           xmlns:Science="Tethys/Science"
           xmlns:Universal="Tethys/Universal"
           xmlns:Trigger="Tethys/Trigger"
           xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                               Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                               Tethys/Science http://okeanids.mbari.org/tethys/Xml/Science.xsd
                               Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd
                               Tethys/Trigger http://okeanids.mbari.org/tethys/Xml/Trigger.xsd"
       Id="Science">

    <DefineArg Name="SampleISUS"><Description>
        Set either this or PeakDetectNO3Active to True in order to sample
        Nitrate. EnabledISUS must also be true.
    </Description><False/></DefineArg>

    <DefineArg Name="SampleISUSmaxPitch"><Description>
        Maximum pitch to sample ISUS. (EnabledISUS must also be true.)
    </Description><Units:degree/><Value>60.0</Value></DefineArg>

    <DefineArg Name="SampleISUSminPitch"><Description>
        Minimum pitch to sample ISUS. (EnabledISUS must also be true.)
    </Description><Units:degree/><Value>-60.0</Value></DefineArg>

    <DefineArg Name="PeakDetectChlActive"><Description>
        Turns on peak detection of Cholorphyll.
    </Description><False/></DefineArg>

    <DefineArg Name="TimeWindowPeakReport"><Description>
        If greater than zero, report a peak every window. If NaN or zero, this
        variable is ignored.
    </Description><Units:minute/><Value>NaN</Value></DefineArg>

    <DefineArg Name="HighestChlPeakReportActive"><Description>
        Turns on reporting of the highest peak value on yo-yo profiles in a
        horizontal sliding window (of length numProfilesSlidingwindow)
    </Description><False/></DefineArg>

    <DefineArg Name="PatchTracking"><Description>
        If tracking a patch
    </Description><False/></DefineArg>

<!--debug
    </Description><True/></DefineArg>
-->

    <DefineArg Name="FilterWidthHorizontal"><Description>
        Width of boxcar filter applied to yoyo-wise chl peaks to pick out the
        highest peak.
    </Description><Units:count/><Value>3</Value></DefineArg>

    <DefineArg Name="NumProfilesSlidingwindow"><Description>
        Length of horizontal sliding window. The highest yoyo-wise chl peak
        (after low-pass filtering by a filter of length FilterWidthHorizontal)
        within this window.
    </Description><Units:count/><Value>100</Value></DefineArg>

    <DefineArg Name="OffPeakFractionHorizontal"><Description>
        When filtered horizontal value is this fraction of the peak, consider it
        outside the patch.
    </Description><Units:percent/><Value>80</Value></DefineArg>

    <DefineArg Name="PeakDetectNO3Active"><Description>
        Turns on peak detection of Nitrate (and turns on ISUS).
    </Description><False/></DefineArg>

    <DefineArg Name="PeakDetectOilActive"><Description>
        Turns on peak detection of Dissolved Oil.
    </Description><False/></DefineArg>

    <DefineArg Name="PeakDetectFDOMActive"><Description>
        Turns on peak detection of concentration_of_chromophoric_dissolved_organic_matter_in_sea_water from FDOM sensor.
    </Description><False/></DefineArg>
    
    <DefineArg Name="UpwardDerivativeOfTemperatureActive"><Description>
        Turns on seawater temperature derivative.
    </Description><False/></DefineArg>

    <DefineArg Name="EnabledAanderaaO2"><Description>
        Automatically set to True if the Aanderaa O2 sensor is installed. Set to
        false to disable reading Aandera O2.
    </Description><Science:Aanderaa_O2.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledNeilBrown"><Description>
        Automatically set to true if the Neil Brown CTD is enabled. Set to false
        to disable reading from the Neil Brown.
    </Description><Science:CTD_NeilBrown.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledSeabird"><Description>
        Automatically set to true if the CTD is enabled. Set to false to disable
        reading from the CTD.
    </Description><Science:CTD_Seabird.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledTurbulence_NPS"><Description>
        Automatically set to true if the NPS Turbulence sensor is enabled. Set
        to false to disable reading from the NPS Turbulence sensor.
    </Description><Science:Turbulence_NPS.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledWetLabsBB2FL"><Description>
        Automatically set to true if the the WetLabs BB2FL is enabled. Set to
        false to disable the WetLabs BB2FL.
    </Description><Science:WetLabsBB2FL.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledWetLabsSeaOWL_UV_A"><Description>
        Automatically set to true if the the WetLabs SeaOWL UV-A is enabled. Set
        to false to disable the WetLabs SeaOWL UV-A.
    </Description><Science:WetLabsSeaOWL_UV_A.loadAtStartup/></DefineArg>

    <DefineArg Name="EnabledWetLabsUBAT"><Description>
        Automatically set to true if the the WetLabs UBAT is enabled. Set
        to false to disable the WetLabs UBAT.
    </Description><Science:WetLabsUBAT.loadAtStartup/></DefineArg>    

    <DefineArg Name="EnabledISUS"><Description>
        Automatically set to True if ISUS is enabled. Set to false to disable
        ISUS.
    </Description><Science:ISUS.loadAtStartup/></DefineArg>

    <DefineArg Name="LowPassWindowLength"><Description>
        Low-pass window length (based on depth sensor sampling interval 0.4
        second) for low-pass filtering.
    </Description><Units:count/><Value>20</Value></DefineArg>

    <DefineArg Name="MedianFilterLen"><Description>
        Median filter length (only for chlorophyll fluorescence which tends to have spikes)
    </Description><Units:count/><Value>5</Value></DefineArg>

    <DefineArg Name="PeakChlShallowBound"><Description>
        Shallow depth bound for detecting chl peak on each descent or ascent
        profile.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>

<!--debug
    </Description><Units:meter/><Value>10</Value></DefineArg>
-->

    <DefineArg Name="PeakChlDeepBound"><Description>
        Deep depth bound for detecting chl peak on each descent or ascent
        profile.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>

<!--debug
    </Description><Units:meter/><Value>20</Value></DefineArg>
-->

    <DefineArg Name="PeakShallowBound"><Description>
        Shallow depth bound for detecting any peak on each descent or ascent
        profile.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>

    <DefineArg Name="PeakDeepBound"><Description>
        Deep depth bound for detecting any peak on each descent or ascent
        profile.
    </Description><Units:meter/><Value>NaN</Value></DefineArg>

    <DefineOutput Name="PeakChl"><Units:microgram_per_liter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakChlDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakChlTemperature"><Units:celsius/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakChlLatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakChlLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakNO3"><Units:micromole_per_liter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Depth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Latitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakNO3Longitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PatchChl"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PatchChlDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PatchChlLatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PatchChlLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PatchChlDistance"><Units:meter/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakOil"><Units:kilogram_per_cubic_meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakOilDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakOilLatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakOilLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakFDOM"><Units:part_per_billion/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakFDOMDepth"><Units:meter/><Value>0</Value></DefineOutput>

    <DefineOutput Name="PeakFDOMLatitude"><Units:degree/><Value>NaN</Value></DefineOutput>

    <DefineOutput Name="PeakFDOMLongitude"><Units:degree/><Value>NaN</Value></DefineOutput>
    
    <DefineOutput Name="PatchFDOMDistance"><Units:meter/><Value>NaN</Value></DefineOutput>    
    
    <Parallel/>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledAanderaaO2"/>
        </While>
        <Universal:mass_concentration_of_oxygen_in_sea_water/>
    </ReadData>

    <ReadData>
        <While>
            <Arg Name="EnabledISUS"/>
            <And><Universal:platform_pitch_angle/><Lt><Arg Name="SampleISUSmaxPitch"/></Lt><And><Universal:platform_pitch_angle/><Gt><Arg Name="SampleISUSminPitch"/></Gt><And><Arg Name="SampleISUS"/><Or><Arg Name="PeakDetectNO3Active"/></Or></And></And></And>
        </While>
        <Universal:mole_concentration_of_nitrate_in_sea_water/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledNeilBrown"/>
            <Or><Arg Name="EnabledSeabird"/></Or>
        </While>
        <Universal:sea_water_temperature/>
        <Universal:sea_water_salinity/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledSeabird"/>
        </While>
        <Science:CTD_Seabird.sea_water_temperature/>
        <Science:CTD_Seabird.sea_water_salinity/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledNeilBrown"/>
            <Or><Arg Name="EnabledSeabird"/></Or>
            <And><Arg Name="UpwardDerivativeOfTemperatureActive"/></And>
        </While>
        <Universal:upward_derivative_of_sea_water_temperature/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledTurbulence_NPS"/>
        </While>
        <Science:Turbulence_NPS.MicroCond/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledWetLabsBB2FL"/>
            <Or><Arg Name="PeakDetectChlActive"/></Or>
        </While>
        <Universal:mass_concentration_of_chlorophyll_in_sea_water/>
    </ReadData>

    <ReadData Strategy="MinError">
        <While>
            <Arg Name="EnabledWetLabsUBAT"/>
        </While>
        <Science:WetLabsUBAT.biolum_potential/>
    </ReadData>

<!--debug-->

    <ReadData Id="Read_Oil" Strategy="MinError">
        <While>
            <Arg Name="EnabledWetLabsSeaOWL_UV_A"/>
            <Or><Arg Name="PeakDetectOilActive"/></Or>
        </While>
        <Universal:mass_concentration_of_chlorophyll_in_sea_water/>
    </ReadData>

    <Aggregate Id="PeakDetectChl">

        <While>
            <Arg Name="PeakDetectChlActive"/>
        </While>

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mass_concentration_of_chlorophyll_in_sea_water/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.timeWindowPeakReport/><Arg Name="TimeWindowPeakReport"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.medianFilterLength/><Arg Name="MedianFilterLen"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakChlShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakChlDeepBound"/></Setting>
            <OutputArg Name="PeakChl"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakChlDepth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakChlTemperature"><Trigger:PeakDetectVsDepth.peakTemperature/></OutputArg>
            <OutputArg Name="PeakChlLatitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakChlLongitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

<!--debug
        <Syslog Severity="Important">PeakChl, PeakChlLatitude, PeakChlLongitude = <Arg Name="PeakChl"/><Units:microgram_per_liter/>, <Arg Name="PeakChlLatitude"/><Units:degree/>, <Arg Name="PeakChlLongitude"/><Units:degree/></Syslog>
-->

        <SendData Service="Express"><Arg Name="PeakChl"/><Arg Name="PeakChlDepth"/>
        </SendData>

    </Aggregate>

    <Aggregate Id="HighestChlPeakReport">

        <While>
            <Arg Name="HighestChlPeakReportActive"/>
        </While>

        <Trigger:PeakDetectHorizontal>
            <Sequence/>
            <Setting><Trigger:PeakDetectHorizontal.detectFrom/><Arg Name="PeakChl"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.depthFrom/><Arg Name="PeakChlDepth"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.latitudeFrom/><Arg Name="PeakChlLatitude"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.longitudeFrom/><Arg Name="PeakChlLongitude"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.patchTracking/><Arg Name="PatchTracking"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.filterWidth/><Arg Name="FilterWidthHorizontal"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.numProfilesSlidingwindow/><Arg Name="NumProfilesSlidingwindow"/></Setting>
            <Setting><Trigger:PeakDetectHorizontal.offPeakFraction/><Arg Name="OffPeakFractionHorizontal"/></Setting>
            <OutputArg Name="PatchChl"><Trigger:PeakDetectHorizontal.peakDetect/></OutputArg>
            <OutputArg Name="PatchChlDepth"><Trigger:PeakDetectHorizontal.peakDepth/></OutputArg>
            <OutputArg Name="PatchChlLatitude"><Trigger:PeakDetectHorizontal.peakLatitude/></OutputArg>
            <OutputArg Name="PatchChlLongitude"><Trigger:PeakDetectHorizontal.peakLongitude/></OutputArg>
            <OutputArg Name="PatchChlDistance"><Trigger:PeakDetectHorizontal.peakDistance/></OutputArg>
        </Trigger:PeakDetectHorizontal>

    </Aggregate>

    <Aggregate Id="PeakDetectNO3">

        <While>
            <Arg Name="PeakDetectNO3Active"/>
        </While>

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mole_concentration_of_nitrate_in_sea_water/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.timeWindowPeakReport/><Arg Name="TimeWindowPeakReport"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakDeepBound"/></Setting>
            <OutputArg Name="PeakNO3"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakNO3Depth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakNO3Latitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakNO3Longitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakNO3"/><Arg Name="PeakNO3Depth"/>
        </SendData>

    </Aggregate>

    <Aggregate Id="PeakDetectOil">

        <While>
            <Arg Name="PeakDetectOilActive"/>
        </While>

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:mass_concentration_of_petroleum_hydrocarbons_in_sea_water/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.timeWindowPeakReport/><Arg Name="TimeWindowPeakReport"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakDeepBound"/></Setting>
            <OutputArg Name="PeakOil"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakOilDepth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakOilLatitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakOilLongitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakOil"/><Arg Name="PeakOilDepth"/>
        </SendData>

    </Aggregate>

    <Aggregate Id="PeakDetectFDOM">

        <While>
            <Arg Name="PeakDetectFDOMActive"/>
        </While>

        <Trigger:PeakDetectVsDepth>
            <Sequence/>
            <Setting><Trigger:PeakDetectVsDepth.detect/><Universal:concentration_of_chromophoric_dissolved_organic_matter_in_sea_water/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.timeWindowPeakReport/><Arg Name="TimeWindowPeakReport"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.windowLength/><Arg Name="LowPassWindowLength"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.shallowBound/><Arg Name="PeakShallowBound"/></Setting>
            <Setting><Trigger:PeakDetectVsDepth.deepBound/><Arg Name="PeakDeepBound"/></Setting>
            <OutputArg Name="PeakFDOM"><Trigger:PeakDetectVsDepth.peakDetect/></OutputArg>
            <OutputArg Name="PeakFDOMDepth"><Trigger:PeakDetectVsDepth.peakDepth/></OutputArg>
            <OutputArg Name="PeakFDOMTemperature"><Trigger:PeakDetectVsDepth.peakTemperature/></OutputArg>
            <OutputArg Name="PeakFDOMLatitude"><Trigger:PeakDetectVsDepth.peakLatitude/></OutputArg>
            <OutputArg Name="PeakFDOMLongitude"><Trigger:PeakDetectVsDepth.peakLongitude/></OutputArg>
        </Trigger:PeakDetectVsDepth>

        <SendData Service="Express"><Arg Name="PeakFDOM"/><Arg Name="PeakFDOMDepth"/>
        </SendData>

    </Aggregate>

</Aggregate>


2019-05-08T00:02:23.358Z,1557273743.358 [CommandLine](IMPORTANT): Running ./Missions/Insert/Science.xml
2019-05-08T00:02:23.533Z,1557273743.533 [Default] Stopped
2019-05-08T00:02:23.533Z,1557273743.533 [Default](DEBUG): Aggregate::uninitialize Default
2019-05-08T00:02:23.533Z,1557273743.533 [Default:B.GoToSurface] Stopped
2019-05-08T00:02:23.533Z,1557273743.533 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-05-08T00:02:23.533Z,1557273743.533 [Default:CheckIn] Stopped
2019-05-08T00:02:23.533Z,1557273743.533 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-05-08T00:02:23.533Z,1557273743.533 [Default:CheckIn:Read_Iridium] Stopped
2019-05-08T00:02:23.533Z,1557273743.533 [MissionManager](IMPORTANT): Started mission Science
2019-05-08T00:02:23.534Z,1557273743.534 [Science] Running Loop=1
2019-05-08T00:02:23.534Z,1557273743.534 [Science](DEBUG): Aggregate::initialize Science
2019-05-08T00:02:23.534Z,1557273743.534 [Science:A] Running Loop=1
2019-05-08T00:02:23.534Z,1557273743.534 [Science:B] Running Loop=1
2019-05-08T00:02:23.534Z,1557273743.534 [Science:C] Running Loop=1
2019-05-08T00:02:23.534Z,1557273743.534 [Science:D] Running Loop=1
2019-05-08T00:02:23.534Z,1557273743.534 [Science:E] Running Loop=1
2019-05-08T00:02:23.534Z,1557273743.534 [Science:F] Running Loop=1
2019-05-08T00:02:23.534Z,1557273743.534 [Science:G] Running Loop=1
2019-05-08T00:02:23.534Z,1557273743.534 [Science:H] Running Loop=1
2019-05-08T00:02:23.534Z,1557273743.534 [Science:Read_Oil] Running Loop=1
2019-05-08T00:02:23.534Z,1557273743.534 [Science:PeakDetectChl] Running Loop=1
2019-05-08T00:02:23.535Z,1557273743.535 [Science:PeakDetectChl](DEBUG): Aggregate::initialize Science:PeakDetectChl
2019-05-08T00:02:23.535Z,1557273743.535 [Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2019-05-08T00:02:23.535Z,1557273743.535 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-05-08T00:02:23.537Z,1557273743.537 [Science:HighestChlPeakReport] Running Loop=1
2019-05-08T00:02:23.537Z,1557273743.537 [Science:HighestChlPeakReport](DEBUG): Aggregate::initialize Science:HighestChlPeakReport
2019-05-08T00:02:23.537Z,1557273743.537 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2019-05-08T00:02:23.537Z,1557273743.537 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2019-05-08T00:02:23.538Z,1557273743.538 [Science:PeakDetectNO3] Running Loop=1
2019-05-08T00:02:23.538Z,1557273743.538 [Science:PeakDetectNO3](DEBUG): Aggregate::initialize Science:PeakDetectNO3
2019-05-08T00:02:23.538Z,1557273743.538 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2019-05-08T00:02:23.538Z,1557273743.538 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-05-08T00:02:23.540Z,1557273743.540 [Science:PeakDetectOil] Running Loop=1
2019-05-08T00:02:23.540Z,1557273743.540 [Science:PeakDetectOil](DEBUG): Aggregate::initialize Science:PeakDetectOil
2019-05-08T00:02:23.540Z,1557273743.540 [Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2019-05-08T00:02:23.540Z,1557273743.540 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-05-08T00:02:23.553Z,1557273743.553 [Science:PeakDetectFDOM] Running Loop=1
2019-05-08T00:02:23.553Z,1557273743.553 [Science:PeakDetectFDOM](DEBUG): Aggregate::initialize Science:PeakDetectFDOM
2019-05-08T00:02:23.554Z,1557273743.554 [Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1
2019-05-08T00:02:23.554Z,1557273743.554 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-05-08T00:02:23.556Z,1557273743.556 [Science:PeakDetectFDOM] Stopped
2019-05-08T00:02:23.556Z,1557273743.556 [Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize Science:PeakDetectFDOM
2019-05-08T00:02:23.556Z,1557273743.556 [Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped
2019-05-08T00:02:23.556Z,1557273743.556 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-05-08T00:02:23.565Z,1557273743.565 [Science:PeakDetectOil] Stopped
2019-05-08T00:02:23.565Z,1557273743.565 [Science:PeakDetectOil](DEBUG): Aggregate::uninitialize Science:PeakDetectOil
2019-05-08T00:02:23.565Z,1557273743.565 [Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2019-05-08T00:02:23.565Z,1557273743.565 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-05-08T00:02:23.565Z,1557273743.565 [Science:PeakDetectNO3] Stopped
2019-05-08T00:02:23.565Z,1557273743.565 [Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize Science:PeakDetectNO3
2019-05-08T00:02:23.565Z,1557273743.565 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2019-05-08T00:02:23.565Z,1557273743.565 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-05-08T00:02:23.565Z,1557273743.565 [Science:HighestChlPeakReport] Stopped
2019-05-08T00:02:23.566Z,1557273743.566 [Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize Science:HighestChlPeakReport
2019-05-08T00:02:23.566Z,1557273743.566 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2019-05-08T00:02:23.566Z,1557273743.566 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2019-05-08T00:02:23.566Z,1557273743.566 [Science:PeakDetectChl] Stopped
2019-05-08T00:02:23.566Z,1557273743.566 [Science:PeakDetectChl](DEBUG): Aggregate::uninitialize Science:PeakDetectChl
2019-05-08T00:02:23.566Z,1557273743.566 [Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2019-05-08T00:02:23.566Z,1557273743.566 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-05-08T00:02:23.566Z,1557273743.566 [Science:Read_Oil] Stopped
2019-05-08T00:02:23.566Z,1557273743.566 [Science:H] Stopped
2019-05-08T00:02:23.566Z,1557273743.566 [Science:G] Running Loop=1
2019-05-08T00:02:23.567Z,1557273743.567 [Science:G](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2019-05-08T00:02:23.567Z,1557273743.567 [Science:F] Stopped
2019-05-08T00:02:23.567Z,1557273743.567 [Science:E] Stopped
2019-05-08T00:02:23.567Z,1557273743.567 [Science:D] Stopped
2019-05-08T00:02:23.567Z,1557273743.567 [Science:C] Running Loop=1
2019-05-08T00:02:23.568Z,1557273743.568 [Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2019-05-08T00:02:23.568Z,1557273743.568 [Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2019-05-08T00:02:23.568Z,1557273743.568 [Science:B] Stopped
2019-05-08T00:02:23.568Z,1557273743.568 [Science:A] Stopped
2019-05-08T00:02:23.665Z,1557273743.665 [CTD_NeilBrown](DEBUG): Initializing CTD_NeilBrown.
2019-05-08T00:02:23.830Z,1557273743.830 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=2
2019-05-08T00:02:23.830Z,1557273743.830 [WetLabsBB2FL](INFO): Powering up
2019-05-08T00:02:29.121Z,1557273749.121 [WetLabsBB2FL] Communications Fault, FailCount= 1
2019-05-08T00:02:29.121Z,1557273749.121 [WetLabsBB2FL](ERROR): Communications Fault
2019-05-08T00:02:29.228Z,1557273749.228 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2019-05-08T00:02:29.334Z,1557273749.334 [CommandLine](IMPORTANT): got command stop
2019-05-08T00:02:29.334Z,1557273749.334 [CommandLine](IMPORTANT): Scheduling is paused
2019-05-08T00:02:29.334Z,1557273749.334 [Supervisor](INFO): Stop Mission called by CommandLine::commandStop
2019-05-08T00:02:29.594Z,1557273749.594 [MissionManager](INFO): MissionManager is completed.
2019-05-08T00:02:29.595Z,1557273749.595 [MissionManager](INFO): Uninitializing Mission Science
2019-05-08T00:02:29.595Z,1557273749.595 [Science] Stopped
2019-05-08T00:02:29.595Z,1557273749.595 [Science](DEBUG): Aggregate::uninitialize Science
2019-05-08T00:02:29.595Z,1557273749.595 [Science:C] Stopped
2019-05-08T00:02:29.595Z,1557273749.595 [Science:G] Stopped
2019-05-08T00:02:29.621Z,1557273749.621 [WetLabsBB2FL](INFO): Powering down
2019-05-08T00:02:29.993Z,1557273749.993 [MissionManager](IMPORTANT): Started mission Default
2019-05-08T00:02:29.993Z,1557273749.993 [Default] Running Loop=1
2019-05-08T00:02:29.993Z,1557273749.993 [Default](DEBUG): Aggregate::initialize Default
2019-05-08T00:02:29.993Z,1557273749.993 [Default:B.GoToSurface] Running Loop=1
2019-05-08T00:02:29.993Z,1557273749.993 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-05-08T00:02:29.993Z,1557273749.993 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-05-08T00:02:29.994Z,1557273749.994 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-05-08T00:02:29.994Z,1557273749.994 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-05-08T00:02:29.994Z,1557273749.994 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-05-08T00:02:29.995Z,1557273749.995 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-05-08T00:02:29.995Z,1557273749.995 [Default:A.Wait] Running Loop=1
2019-05-08T00:02:29.995Z,1557273749.995 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-05-08T00:02:30.809Z,1557273750.809 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2019-05-08T00:02:30.809Z,1557273750.809 [WetLabsBB2FL] No Fault, FailCount= 1
2019-05-08T00:02:30.841Z,1557273750.841 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=2
2019-05-08T00:02:30.841Z,1557273750.841 [WetLabsBB2FL](INFO): Powering up
2019-05-08T00:02:32.272Z,1557273752.272 [DataOverHttps](INFO): Sending 874 bytes from file Logs/20190501T072355/Express0790.lzma
2019-05-08T00:02:33.075Z,1557273753.075 [DataOverHttps](INFO): Moved sent file to Logs/20190501T072355/Express0790.lzma.bak
2019-05-08T00:02:33.075Z,1557273753.075 [DataOverHttps](INFO): SBD MOMSN=10966077
2019-05-08T00:02:36.147Z,1557273756.147 [WetLabsBB2FL] Communications Fault, FailCount= 2
2019-05-08T00:02:36.147Z,1557273756.147 [WetLabsBB2FL](ERROR): Communications Fault
2019-05-08T00:02:36.474Z,1557273756.474 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2019-05-08T00:02:36.645Z,1557273756.645 [WetLabsBB2FL](INFO): Powering down
2019-05-08T00:02:37.681Z,1557273757.681 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2019-05-08T00:02:37.681Z,1557273757.681 [WetLabsBB2FL] No Fault, FailCount= 2
2019-05-08T00:02:37.858Z,1557273757.858 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=2
2019-05-08T00:02:37.858Z,1557273757.858 [WetLabsBB2FL](INFO): Powering up
2019-05-08T00:02:43.149Z,1557273763.149 [WetLabsBB2FL] Communications Fault, FailCount= 3
2019-05-08T00:02:43.149Z,1557273763.149 [WetLabsBB2FL](ERROR): Communications Fault
2019-05-08T00:02:43.326Z,1557273763.326 [Default:A.Wait](INFO): Done Waiting.
2019-05-08T00:02:43.326Z,1557273763.326 [Default:A.Wait] Stopped
2019-05-08T00:02:43.326Z,1557273763.326 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-05-08T00:02:43.334Z,1557273763.334 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2019-05-08T00:02:43.649Z,1557273763.649 [WetLabsBB2FL](INFO): Powering down
2019-05-08T00:02:43.730Z,1557273763.730 [Default:CheckIn] Running Loop=1
2019-05-08T00:02:43.730Z,1557273763.730 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-05-08T00:02:43.730Z,1557273763.730 [Default:CheckIn:Read_GPS] Running Loop=1
2019-05-08T00:02:44.542Z,1557273764.542 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2019-05-08T00:02:44.542Z,1557273764.542 [WetLabsBB2FL] No Fault, FailCount= 3
2019-05-08T00:02:44.862Z,1557273764.862 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=2
2019-05-08T00:02:44.862Z,1557273764.862 [WetLabsBB2FL](INFO): Powering up
2019-05-08T00:02:48.445Z,1557273768.445 [CommandLine](IMPORTANT): got command get PAR_Licor.loadAtStartup
2019-05-08T00:02:48.446Z,1557273768.446 [CommandLine](IMPORTANT): PAR_Licor.loadAtStartup 0 bool
2019-05-08T00:02:50.165Z,1557273770.165 [WetLabsBB2FL] Communications Fault, FailCount= 4
2019-05-08T00:02:50.165Z,1557273770.165 [WetLabsBB2FL](ERROR): Communications Fault
2019-05-08T00:02:50.219Z,1557273770.219 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2019-05-08T00:02:50.665Z,1557273770.665 [WetLabsBB2FL](INFO): Powering down
2019-05-08T00:02:51.821Z,1557273771.821 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL
2019-05-08T00:02:51.821Z,1557273771.821 [WetLabsBB2FL] No Fault, FailCount= 4
2019-05-08T00:02:51.879Z,1557273771.879 [WetLabsBB2FL](INFO): Opening uart, block timeout 10ths=2
2019-05-08T00:02:51.879Z,1557273771.879 [WetLabsBB2FL](INFO): Powering up
2019-05-08T00:02:57.169Z,1557273777.169 [WetLabsBB2FL] Communications Fault, FailCount= 5
2019-05-08T00:02:57.169Z,1557273777.169 [WetLabsBB2FL](ERROR): Communications Fault
2019-05-08T00:02:57.477Z,1557273777.477 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL
2019-05-08T00:02:57.477Z,1557273777.477 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL
2019-05-08T00:02:57.689Z,1557273777.689 [WetLabsBB2FL](INFO): Powering down
2019-05-08T00:03:10.863Z,1557273790.863 [CommandLine](IMPORTANT): got command configSet PAR_Licor.loadAtStartup 1.000000 bool persist
2019-05-08T00:03:10.863Z,1557273790.863 [CommandLine](IMPORTANT): configSet PAR_Licor.loadAtStartup requires a restart to take effect.
2019-05-08T00:03:15.566Z,1557273795.566 [CommandLine](IMPORTANT): got command restart application
2019-05-08T00:03:16.569Z,1557273796.569 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-05-08T00:03:16.569Z,1557273796.569 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:16.765Z,1557273796.765 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-05-08T00:03:16.765Z,1557273796.765 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:16.765Z,1557273796.765 [CommandLine](INFO): Join timeout helper Thread ID is 3604
2019-05-08T00:03:16.766Z,1557273796.766 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-05-08T00:03:16.766Z,1557273796.766 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:16.766Z,1557273796.766 [NavChartDb](INFO): Join timeout helper Thread ID is 3605
2019-05-08T00:03:17.025Z,1557273797.025 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-05-08T00:03:17.025Z,1557273797.025 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:17.033Z,1557273797.033 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-05-08T00:03:17.033Z,1557273797.033 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:17.033Z,1557273797.033 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3606
2019-05-08T00:03:17.081Z,1557273797.081 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-05-08T00:03:17.081Z,1557273797.081 [WetLabsBB2FL](INFO): Powering down
2019-05-08T00:03:17.082Z,1557273797.082 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:17.093Z,1557273797.093 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2019-05-08T00:03:17.093Z,1557273797.093 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:17.093Z,1557273797.093 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 3607
2019-05-08T00:03:17.197Z,1557273797.197 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2019-05-08T00:03:17.197Z,1557273797.197 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:17.217Z,1557273797.217 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-05-08T00:03:17.217Z,1557273797.217 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:17.217Z,1557273797.217 [Radio_Surface](INFO): Join timeout helper Thread ID is 3608
2019-05-08T00:03:17.569Z,1557273797.569 [Radio_Surface](INFO): Powering down
2019-05-08T00:03:17.570Z,1557273797.570 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-05-08T00:03:17.570Z,1557273797.570 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:17.590Z,1557273797.590 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-05-08T00:03:17.590Z,1557273797.590 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:17.590Z,1557273797.590 [DataOverHttps](INFO): Join timeout helper Thread ID is 3609
2019-05-08T00:03:17.933Z,1557273797.933 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-05-08T00:03:17.933Z,1557273797.933 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:17.949Z,1557273797.949 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-05-08T00:03:17.950Z,1557273797.950 [logger ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:17.950Z,1557273797.950 [logger](INFO): Join timeout helper Thread ID is 3610
2019-05-08T00:03:17.981Z,1557273797.981 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-05-08T00:03:17.981Z,1557273797.981 [logger ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:17.989Z,1557273797.989 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-05-08T00:03:17.990Z,1557273797.990 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:17.990Z,1557273797.990 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-05-08T00:03:17.990Z,1557273797.990 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:17.990Z,1557273797.990 [controlThread](INFO): Join timeout helper Thread ID is 3611
2019-05-08T00:03:18.041Z,1557273798.041 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-05-08T00:03:18.041Z,1557273798.041 [controlThread](DEBUG): Uninitializing ControlThread
2019-05-08T00:03:18.042Z,1557273798.042 [NAL9602](INFO): Powering down
2019-05-08T00:03:18.043Z,1557273798.043 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-05-08T00:03:18.043Z,1557273798.043 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-05-08T00:03:18.044Z,1557273798.044 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-05-08T00:03:18.044Z,1557273798.044 [MissionManager](INFO): Uninitializing Mission Default
2019-05-08T00:03:18.044Z,1557273798.044 [Default] Stopped
2019-05-08T00:03:18.044Z,1557273798.044 [Default](DEBUG): Aggregate::uninitialize Default
2019-05-08T00:03:18.044Z,1557273798.044 [Default:B.GoToSurface] Stopped
2019-05-08T00:03:18.044Z,1557273798.044 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-05-08T00:03:18.045Z,1557273798.045 [Default:CheckIn] Stopped
2019-05-08T00:03:18.045Z,1557273798.045 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-05-08T00:03:18.045Z,1557273798.045 [Default:CheckIn:Read_GPS] Stopped
2019-05-08T00:03:18.047Z,1557273798.047 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-05-08T00:03:18.047Z,1557273798.047 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-05-08T00:03:18.047Z,1557273798.047 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-05-08T00:03:18.048Z,1557273798.048 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-05-08T00:03:18.048Z,1557273798.048 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-05-08T00:03:18.048Z,1557273798.048 [BuoyancyServo](INFO): Powering down
2019-05-08T00:03:18.061Z,1557273798.061 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-05-08T00:03:18.061Z,1557273798.061 [ElevatorServo](INFO): Powering down
2019-05-08T00:03:18.062Z,1557273798.062 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-05-08T00:03:18.062Z,1557273798.062 [MassServo](INFO): Powering down
2019-05-08T00:03:18.063Z,1557273798.063 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-05-08T00:03:18.063Z,1557273798.063 [RudderServo](INFO): Powering down
2019-05-08T00:03:18.064Z,1557273798.064 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-05-08T00:03:18.064Z,1557273798.064 [ThrusterServo](INFO): Powering down
2019-05-08T00:03:18.065Z,1557273798.065 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-05-08T00:03:18.065Z,1557273798.065 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-05-08T00:03:18.065Z,1557273798.065 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-05-08T00:03:18.065Z,1557273798.065 [CBIT](DEBUG): Powering off loads.
2019-05-08T00:03:18.077Z,1557273798.077 [CBIT](DEBUG): Disabling WDT.
2019-05-08T00:03:18.089Z,1557273798.089 [CBIT](DEBUG): Opening all GF detection circuits.
2019-05-08T00:03:18.090Z,1557273798.090 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:18.177Z,1557273798.177 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:18.183Z,1557273798.183 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:18.232Z,1557273798.232 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:18.235Z,1557273798.235 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:18.243Z,1557273798.243 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-05-08T00:03:18.300Z,1557273798.300 [logger ThreadHandler](INFO): Thread cancelled.