2019-01-16T01:00:04.895Z,1547600404.895 [Supervisor](DEBUG): Initializing supervisor.
2019-01-16T01:00:04.897Z,1547600404.897 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-01-16T01:00:04.898Z,1547600404.898 [SyncHandler](INFO): Protected caller Thread ID is 801
2019-01-16T01:00:04.898Z,1547600404.898 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-01-16T01:00:04.899Z,1547600404.899 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-01-16T01:00:04.899Z,1547600404.899 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 802
2019-01-16T01:00:04.902Z,1547600404.902 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-01-16T01:00:04.913Z,1547600404.913 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-01-16T01:00:04.914Z,1547600404.914 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-01-16T01:00:04.914Z,1547600404.914 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 803
2019-01-16T01:00:04.915Z,1547600404.915 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-01-16T01:00:04.916Z,1547600404.916 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-01-16T01:00:04.916Z,1547600404.916 [logger ThreadHandler](INFO): Protected caller Thread ID is 804
2019-01-16T01:00:04.918Z,1547600404.918 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-01-16T01:00:04.918Z,1547600404.918 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-01-16T01:00:04.922Z,1547600404.922 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-01-16T01:00:05.018Z,1547600405.018 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-01-16T01:00:05.020Z,1547600405.020 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-01-16T01:00:05.119Z,1547600405.119 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-01-16T01:00:05.121Z,1547600405.121 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-01-16T01:00:05.299Z,1547600405.299 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-01-16T01:00:05.299Z,1547600405.299 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-01-16T01:00:05.626Z,1547600405.626 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-01-16T01:00:05.627Z,1547600405.627 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-01-16T01:00:05.928Z,1547600405.928 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-01-16T01:00:05.930Z,1547600405.930 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-01-16T01:00:06.358Z,1547600406.358 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-01-16T01:00:06.358Z,1547600406.358 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-01-16T01:00:06.782Z,1547600406.782 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-01-16T01:00:06.784Z,1547600406.784 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-01-16T01:00:07.212Z,1547600407.212 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-01-16T01:00:07.213Z,1547600407.213 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-01-16T01:00:07.294Z,1547600407.294 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-01-16T01:00:07.581Z,1547600407.581 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-01-16T01:00:07.583Z,1547600407.583 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-01-16T01:00:07.724Z,1547600407.724 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-01-16T01:00:07.724Z,1547600407.724 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-01-16T01:00:07.924Z,1547600407.924 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-01-16T01:00:07.924Z,1547600407.924 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-01-16T01:00:08.116Z,1547600408.116 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-01-16T01:00:08.118Z,1547600408.118 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-01-16T01:00:08.213Z,1547600408.213 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-01-16T01:00:08.214Z,1547600408.214 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-01-16T01:00:08.357Z,1547600408.357 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-01-16T01:00:08.359Z,1547600408.359 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2019-01-16T01:00:09.005Z,1547600409.005 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2019-01-16T01:00:09.616Z,1547600409.616 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-01-16T01:00:09.616Z,1547600409.616 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2019-01-16T01:00:09.717Z,1547600409.717 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2019-01-16T01:00:09.860Z,1547600409.860 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2019-01-16T01:00:09.951Z,1547600409.951 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2019-01-16T01:00:10.034Z,1547600410.034 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2019-01-16T01:00:10.183Z,1547600410.183 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2019-01-16T01:00:10.371Z,1547600410.371 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2019-01-16T01:00:10.468Z,1547600410.468 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2019-01-16T01:00:10.560Z,1547600410.560 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2019-01-16T01:00:10.656Z,1547600410.656 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2019-01-16T01:00:10.737Z,1547600410.737 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-01-16T01:00:10.748Z,1547600410.748 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-01-16T01:00:10.874Z,1547600410.874 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-01-16T01:00:10.874Z,1547600410.874 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-01-16T01:00:10.898Z,1547600410.898 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-01-16T01:00:10.898Z,1547600410.898 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-01-16T01:00:10.954Z,1547600410.954 [DepthRateCalculator] Loaded
2019-01-16T01:00:10.954Z,1547600410.954 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-01-16T01:00:10.960Z,1547600410.960 [PitchRateCalculator] Loaded
2019-01-16T01:00:10.960Z,1547600410.960 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-01-16T01:00:10.975Z,1547600410.975 [SpeedCalculator] Loaded
2019-01-16T01:00:10.976Z,1547600410.976 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-01-16T01:00:10.996Z,1547600410.996 [TempGradientCalculator] Loaded
2019-01-16T01:00:10.996Z,1547600410.996 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-01-16T01:00:11.001Z,1547600411.001 [YawRateCalculator] Loaded
2019-01-16T01:00:11.002Z,1547600411.002 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-01-16T01:00:11.040Z,1547600411.040 [ElevatorOffsetCalculator] Loaded
2019-01-16T01:00:11.040Z,1547600411.040 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-01-16T01:00:11.040Z,1547600411.040 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-01-16T01:00:11.041Z,1547600411.041 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-01-16T01:00:11.082Z,1547600411.082 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-01-16T01:00:11.082Z,1547600411.082 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-01-16T01:00:11.595Z,1547600411.595 [AcousticModem_Benthos_ATM900] Loaded
2019-01-16T01:00:11.595Z,1547600411.595 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2019-01-16T01:00:11.732Z,1547600411.732 [DataOverHttps] Loaded
2019-01-16T01:00:11.732Z,1547600411.732 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2019-01-16T01:00:11.745Z,1547600411.745 [Depth_Keller] Loaded
2019-01-16T01:00:11.745Z,1547600411.745 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-01-16T01:00:11.840Z,1547600411.840 [NAL9602] Loaded
2019-01-16T01:00:11.841Z,1547600411.841 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-01-16T01:00:11.856Z,1547600411.856 [Onboard] Loaded
2019-01-16T01:00:11.856Z,1547600411.856 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-01-16T01:00:11.866Z,1547600411.866 [Radio_Surface] Loaded
2019-01-16T01:00:11.866Z,1547600411.866 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-01-16T01:00:11.867Z,1547600411.867 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407D54E0
2019-01-16T01:00:11.867Z,1547600411.867 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 883
2019-01-16T01:00:12.019Z,1547600412.019 [PNI_TCM] Loaded
2019-01-16T01:00:12.019Z,1547600412.019 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2019-01-16T01:00:12.077Z,1547600412.077 [Rowe_600LCM] Loaded
2019-01-16T01:00:12.077Z,1547600412.077 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread.
2019-01-16T01:00:12.078Z,1547600412.078 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 408054E0
2019-01-16T01:00:12.079Z,1547600412.079 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 884
2019-01-16T01:00:14.001Z,1547600414.001 [BPC1] Loaded
2019-01-16T01:00:14.002Z,1547600414.002 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-01-16T01:00:14.002Z,1547600414.002 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-01-16T01:00:14.003Z,1547600414.003 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-01-16T01:00:14.534Z,1547600414.534 [SBIT](DEBUG): Construct Startup Built In Test.
2019-01-16T01:00:14.556Z,1547600414.556 [SBIT] Loaded
2019-01-16T01:00:14.556Z,1547600414.556 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-01-16T01:00:14.557Z,1547600414.557 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-01-16T01:00:14.568Z,1547600414.568 [IBIT] Loaded
2019-01-16T01:00:14.568Z,1547600414.568 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-01-16T01:00:14.571Z,1547600414.571 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-01-16T01:00:14.704Z,1547600414.704 [CBIT] Loaded
2019-01-16T01:00:14.705Z,1547600414.705 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-01-16T01:00:14.705Z,1547600414.705 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-01-16T01:00:14.706Z,1547600414.706 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-01-16T01:00:14.985Z,1547600414.985 [CTD_Seabird](DEBUG): add sea_water_density
2019-01-16T01:00:14.985Z,1547600414.985 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2019-01-16T01:00:14.985Z,1547600414.985 [CTD_Seabird](DEBUG): failed to parse UniversalURI: sea_water_density
2019-01-16T01:00:14.985Z,1547600414.985 [CTD_Seabird] Software Fault, FailCount= 1
2019-01-16T01:00:14.986Z,1547600414.986 [CTD_Seabird](ERROR): Software Fault
2019-01-16T01:00:14.986Z,1547600414.986 [CTD_Seabird](DEBUG): add depth
2019-01-16T01:00:14.986Z,1547600414.986 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2019-01-16T01:00:14.986Z,1547600414.986 [CTD_Seabird](DEBUG): failed to parse UniversalURI: depth
2019-01-16T01:00:14.986Z,1547600414.986 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2019-01-16T01:00:14.986Z,1547600414.986 [CTD_Seabird](DEBUG): failed to parse UniversalURI: sea_water_pressure
2019-01-16T01:00:14.987Z,1547600414.987 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2019-01-16T01:00:14.987Z,1547600414.987 [CTD_Seabird](DEBUG): failed to parse UniversalURI: sea_water_salinity
2019-01-16T01:00:14.987Z,1547600414.987 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2019-01-16T01:00:14.987Z,1547600414.987 [CTD_Seabird](DEBUG): failed to parse UniversalURI: sea_water_temperature
2019-01-16T01:00:14.987Z,1547600414.987 [CTD_Seabird](FAULT): Failed to add SEA_WATER_TEMPERATURE
2019-01-16T01:00:14.987Z,1547600414.987 [CTD_Seabird] Hardware Fault, FailCount= 1
2019-01-16T01:00:14.987Z,1547600414.987 [CTD_Seabird](ERROR): Hardware Fault
2019-01-16T01:00:14.988Z,1547600414.988 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2019-01-16T01:00:14.988Z,1547600414.988 [CTD_Seabird](DEBUG): failed to parse UniversalURI: sea_water_electrical_conductivity
2019-01-16T01:00:14.988Z,1547600414.988 [CTD_Seabird] Software Fault, FailCount= 1
2019-01-16T01:00:14.988Z,1547600414.988 [CTD_Seabird](ERROR): Software Fault
2019-01-16T01:00:14.988Z,1547600414.988 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2019-01-16T01:00:14.988Z,1547600414.988 [CTD_Seabird](DEBUG): failed to parse UniversalURI: speed_of_sound_in_sea_water
2019-01-16T01:00:15.014Z,1547600415.014 [CTD_Seabird] Loaded
2019-01-16T01:00:15.014Z,1547600415.014 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2019-01-16T01:00:15.015Z,1547600415.015 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409054E0
2019-01-16T01:00:15.015Z,1547600415.015 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 886
2019-01-16T01:00:15.032Z,1547600415.032 [ESPComponent] Loaded
2019-01-16T01:00:15.032Z,1547600415.032 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2019-01-16T01:00:15.046Z,1547600415.046 [PAR_Licor] Loaded
2019-01-16T01:00:15.046Z,1547600415.046 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2019-01-16T01:00:15.093Z,1547600415.093 [WetLabsBB2FL] Loaded
2019-01-16T01:00:15.093Z,1547600415.093 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-01-16T01:00:15.094Z,1547600415.094 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 409354E0
2019-01-16T01:00:15.095Z,1547600415.095 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 887
2019-01-16T01:00:15.095Z,1547600415.095 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-01-16T01:00:15.096Z,1547600415.096 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-01-16T01:00:15.367Z,1547600415.367 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-01-16T01:00:15.368Z,1547600415.368 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-01-16T01:00:15.455Z,1547600415.455 [VerticalControl](DEBUG): Construct VerticalControl.
2019-01-16T01:00:15.545Z,1547600415.545 [VerticalControl] Loaded
2019-01-16T01:00:15.545Z,1547600415.545 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-01-16T01:00:15.546Z,1547600415.546 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-01-16T01:00:15.604Z,1547600415.604 [HorizontalControl] Loaded
2019-01-16T01:00:15.605Z,1547600415.605 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-01-16T01:00:15.605Z,1547600415.605 [SpeedControl](DEBUG): Construct SpeedControl.
2019-01-16T01:00:15.610Z,1547600415.610 [SpeedControl] Loaded
2019-01-16T01:00:15.611Z,1547600415.611 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-01-16T01:00:15.611Z,1547600415.611 [LoopControl](DEBUG): Construct LoopControl.
2019-01-16T01:00:15.612Z,1547600415.612 [LoopControl] Loaded
2019-01-16T01:00:15.612Z,1547600415.612 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-01-16T01:00:15.612Z,1547600415.612 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-01-16T01:00:15.613Z,1547600415.613 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-01-16T01:00:15.714Z,1547600415.714 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-01-16T01:00:15.715Z,1547600415.715 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-01-16T01:00:15.832Z,1547600415.832 [BuoyancyServo] Loaded
2019-01-16T01:00:15.833Z,1547600415.833 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-01-16T01:00:15.844Z,1547600415.844 [ElevatorServo] Loaded
2019-01-16T01:00:15.844Z,1547600415.844 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-01-16T01:00:15.855Z,1547600415.855 [MassServo] Loaded
2019-01-16T01:00:15.855Z,1547600415.855 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-01-16T01:00:15.865Z,1547600415.865 [RudderServo] Loaded
2019-01-16T01:00:15.866Z,1547600415.866 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-01-16T01:00:15.876Z,1547600415.876 [ThrusterServo] Loaded
2019-01-16T01:00:15.876Z,1547600415.876 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-01-16T01:00:15.877Z,1547600415.877 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-01-16T01:00:15.877Z,1547600415.877 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-01-16T01:00:15.988Z,1547600415.988 [DeadReckonUsingSpeedCalculator] Loaded
2019-01-16T01:00:15.989Z,1547600415.989 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-01-16T01:00:16.004Z,1547600416.004 [NavChart] Loaded
2019-01-16T01:00:16.004Z,1547600416.004 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-01-16T01:00:16.008Z,1547600416.008 [UniversalFixResidualReporter] Loaded
2019-01-16T01:00:16.008Z,1547600416.008 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-01-16T01:00:16.009Z,1547600416.009 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-01-16T01:00:16.012Z,1547600416.012 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-01-16T01:00:16.013Z,1547600416.013 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-01-16T01:00:16.019Z,1547600416.019 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-01-16T01:00:16.020Z,1547600416.020 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A8F4E0
2019-01-16T01:00:16.021Z,1547600416.021 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 888
2019-01-16T01:00:16.026Z,1547600416.026 [Supervisor](INFO): Main Thread ID is 797
2019-01-16T01:00:16.026Z,1547600416.026 [Supervisor](DEBUG): Running supervisor.
2019-01-16T01:00:16.026Z,1547600416.026 [CommandLine ThreadHandler](INFO): Handler Thread ID is 889
2019-01-16T01:00:16.029Z,1547600416.029 [controlThread ThreadHandler](INFO): Handler Thread ID is 890
2019-01-16T01:00:16.029Z,1547600416.029 [controlThread](DEBUG): Initializing ControlThread
2019-01-16T01:00:16.030Z,1547600416.030 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-01-16T01:00:16.030Z,1547600416.030 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-01-16T01:00:16.031Z,1547600416.031 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-01-16T01:00:16.031Z,1547600416.031 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-01-16T01:00:16.031Z,1547600416.031 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-01-16T01:00:16.032Z,1547600416.032 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-01-16T01:00:16.035Z,1547600416.035 [SBIT](INFO): Initialize SBIT Component.
2019-01-16T01:00:16.035Z,1547600416.035 [SBIT](IMPORTANT): git: 2018-12-19-98-g1b4ec1f
2019-01-16T01:00:16.035Z,1547600416.035 [SBIT](INFO): git hash: 1b4ec1f203770e56bddb33e303a3f414b01f4d27
2019-01-16T01:00:16.036Z,1547600416.036 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-01-16T01:00:16.037Z,1547600416.037 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
2019-01-16T01:00:16.038Z,1547600416.038 [SBIT](INFO): Beginning SBIT in 24.000000 seconds.
2019-01-16T01:00:16.039Z,1547600416.039 [IBIT](INFO): Initialize IBIT Component.
2019-01-16T01:00:16.039Z,1547600416.039 [CBIT](DEBUG): Initialize CBIT Component.
2019-01-16T01:00:16.040Z,1547600416.040 [logger ThreadHandler](INFO): Handler Thread ID is 891
2019-01-16T01:00:16.053Z,1547600416.053 [CBIT](DEBUG): Initialized mux pins.
2019-01-16T01:00:16.054Z,1547600416.054 [CBIT](DEBUG): Initializing the watchdog timer.
2019-01-16T01:00:16.058Z,1547600416.058 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 892
2019-01-16T01:00:16.064Z,1547600416.064 [Radio_Surface](INFO): Powering up
2019-01-16T01:00:16.074Z,1547600416.074 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 893
2019-01-16T01:00:16.074Z,1547600416.074 [Rowe_600LCM](INFO): Initializing
2019-01-16T01:00:16.077Z,1547600416.077 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-01-16T01:00:16.078Z,1547600416.078 [CBIT](DEBUG): Initializing heartbeat.
2019-01-16T01:00:16.149Z,1547600416.149 [CBIT](DEBUG): Deactivating GF circuits.
2019-01-16T01:00:16.149Z,1547600416.149 [CBIT](DEBUG): Deactivating emergency mode.
2019-01-16T01:00:16.175Z,1547600416.175 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 894
2019-01-16T01:00:16.176Z,1547600416.176 [CTD_Seabird](INFO): Powering down
2019-01-16T01:00:16.198Z,1547600416.198 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-01-16T01:00:16.199Z,1547600416.199 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-01-16T01:00:16.200Z,1547600416.200 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-01-16T01:00:16.201Z,1547600416.201 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-01-16T01:00:16.202Z,1547600416.202 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-01-16T01:00:16.203Z,1547600416.203 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2019-01-16T01:00:16.203Z,1547600416.203 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2019-01-16T01:00:16.204Z,1547600416.204 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-01-16T01:00:16.204Z,1547600416.204 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-01-16T01:00:16.208Z,1547600416.208 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-01-16T01:00:16.306Z,1547600416.306 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 895
2019-01-16T01:00:16.308Z,1547600416.308 [WetLabsBB2FL](INFO): Powering down
2019-01-16T01:00:16.328Z,1547600416.328 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-01-16T01:00:16.411Z,1547600416.411 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 896
2019-01-16T01:00:16.417Z,1547600416.417 [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-01-16T01:00:16.420Z,1547600416.420 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-01-16T01:00:16.422Z,1547600416.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-01-16T01:00:16.422Z,1547600416.422 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-01-16T01:00:16.422Z,1547600416.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-01-16T01:00:16.422Z,1547600416.422 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-01-16T01:00:16.422Z,1547600416.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-01-16T01:00:16.423Z,1547600416.423 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-01-16T01:00:16.423Z,1547600416.423 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-01-16T01:00:16.423Z,1547600416.423 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-01-16T01:00:16.423Z,1547600416.423 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-01-16T01:00:16.423Z,1547600416.423 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-01-16T01:00:16.424Z,1547600416.424 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-01-16T01:00:16.424Z,1547600416.424 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-01-16T01:00:16.424Z,1547600416.424 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-01-16T01:00:16.424Z,1547600416.424 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-01-16T01:00:16.424Z,1547600416.424 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-01-16T01:00:16.461Z,1547600416.461 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-01-16T01:00:16.518Z,1547600416.518 [Rowe_600LCM](INFO): Powering up
2019-01-16T01:00:16.563Z,1547600416.563 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-01-16T01:00:16.565Z,1547600416.565 [Default:A.Wait](DEBUG): Construct Wait.
2019-01-16T01:00:16.586Z,1547600416.586 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-01-16T01:00:16.613Z,1547600416.613 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-01-16T01:00:16.615Z,1547600416.615 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-01-16T01:00:16.629Z,1547600416.629 [Default:E.Execute](DEBUG): Construct Execute.
2019-01-16T01:00:16.632Z,1547600416.632 [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-01-16T01:00:16.649Z,1547600416.649 [controlThread](DEBUG): Component order: CycleStarter,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,NAL9602,Onboard,PNI_TCM,BPC1,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2019-01-16T01:00:16.670Z,1547600416.670 [AcousticModem_Benthos_ATM900](INFO): Powering up
2019-01-16T01:00:16.670Z,1547600416.670 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2019-01-16T01:00:16.696Z,1547600416.696 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-01-16T01:00:16.947Z,1547600416.947 [ESPComponent](INFO): powering down ESP
2019-01-16T01:00:17.510Z,1547600417.510 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-01-16T01:00:17.518Z,1547600417.518 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-01-16T01:00:17.540Z,1547600417.540 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-01-16T01:00:17.546Z,1547600417.546 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-01-16T01:00:17.552Z,1547600417.552 [MassServo](DEBUG): Initializing EZServoServo.
2019-01-16T01:00:17.558Z,1547600417.558 [MassServo](DEBUG): Initializing MassServo.
2019-01-16T01:00:17.564Z,1547600417.564 [RudderServo](DEBUG): Initializing EZServoServo.
2019-01-16T01:00:17.570Z,1547600417.570 [RudderServo](DEBUG): Initializing RudderServo.
2019-01-16T01:00:17.591Z,1547600417.591 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-01-16T01:00:17.598Z,1547600417.598 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-01-16T01:00:17.655Z,1547600417.655 [CBIT](ERROR): Software Fault in component: CTD_Seabird
2019-01-16T01:00:17.655Z,1547600417.655 [CBIT](FAULT): Software Fault in component: CTD_Seabird
2019-01-16T01:00:18.553Z,1547600418.553 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2019-01-16T01:00:18.554Z,1547600418.554 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2019-01-16T01:00:18.554Z,1547600418.554 [BuoyancyServo] Communications Fault, FailCount= 1
2019-01-16T01:00:18.554Z,1547600418.554 [BuoyancyServo](ERROR): Communications Fault
2019-01-16T01:00:18.762Z,1547600418.762 [CBIT](ERROR): Communications Fault in component: BuoyancyServo
2019-01-16T01:00:20.393Z,1547600420.393 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2019-01-16T01:00:20.498Z,1547600420.498 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2019-01-16T01:00:20.899Z,1547600420.899 [CBIT](INFO): Clearing failed state for component BuoyancyServo
2019-01-16T01:00:20.899Z,1547600420.899 [BuoyancyServo] No Fault, FailCount= 1
2019-01-16T01:00:21.313Z,1547600421.313 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-01-16T01:00:21.321Z,1547600421.321 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-01-16T01:00:24.370Z,1547600424.370 [AcousticModem_Benthos_ATM900](DEBUG): 
2019-01-16T01:00:25.571Z,1547600425.571 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series OEM w/burn wire
2019-01-16T01:00:25.571Z,1547600425.571 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2019-01-16T01:00:25.572Z,1547600425.572 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.6.3
2019-01-16T01:00:25.572Z,1547600425.572 [AcousticModem_Benthos_ATM900](DEBUG): Jan 10 2019 02:08:38 
2019-01-16T01:00:25.972Z,1547600425.972 [AcousticModem_Benthos_ATM900](DEBUG): WARNING: battery low
2019-01-16T01:00:26.089Z,1547600426.089 [CBIT](CRITICAL): Environmental Failure. Press:14.541981 PSI. Humidity:41%. Temp:24 C. ABORTING MISSION
2019-01-16T01:00:26.089Z,1547600426.089 [Supervisor](INFO): Stop Mission called by CBIT::monitorEnvironmentals
2019-01-16T01:00:26.517Z,1547600426.517 [CommandLine](FAULT): Scheduling is paused
2019-01-16T01:00:26.517Z,1547600426.517 [CBIT](INFO): Critical error at 20190116T010026
2019-01-16T01:00:26.769Z,1547600426.769 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2019-01-16T01:00:27.169Z,1547600427.169 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2019-01-16T01:00:27.170Z,1547600427.170 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 1: user:1>
2019-01-16T01:00:27.170Z,1547600427.170 [AcousticModem_Benthos_ATM900](INFO): command mode acknowledged
2019-01-16T01:00:27.570Z,1547600427.570 [AcousticModem_Benthos_ATM900](INFO): setting local address to 3
2019-01-16T01:00:27.970Z,1547600427.970 [AcousticModem_Benthos_ATM900](DEBUG): checking for local address setting acknowledgment
2019-01-16T01:00:27.972Z,1547600427.972 [AcousticModem_Benthos_ATM900](INFO): set local address to 3
2019-01-16T01:00:28.370Z,1547600428.370 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 2: user:2>
2019-01-16T01:00:40.436Z,1547600440.436 [SBIT](IMPORTANT): Beginning Startup BIT
2019-01-16T01:00:40.458Z,1547600440.458 [CBIT](IMPORTANT): Beginning ground fault scan
2019-01-16T01:00:41.975Z,1547600441.975 [NAL9602](INFO): Powering up NAL9602
2019-01-16T01:00:51.415Z,1547600451.415 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.008942
CHAN A1 (24V): -0.012444
CHAN A2 (12V): -0.005394
CHAN A3 (5V): -0.000668
CHAN B0 (3.3V): -0.000808
CHAN B1 (3.15aV): -0.001141
CHAN B2 (3.15bV): 0.000504
CHAN B3 (GND): 0.000299
OPEN: 0.004220
Full Scale Calc: 4.765 mA, -1.589 mA
2019-01-16T01:00:52.897Z,1547600452.897 [NAL9602](INFO): NAL9602 initialized
2019-01-16T01:01:05.987Z,1547600465.987 [CommandLine](IMPORTANT): got command show stack
2019-01-16T01:01:05.987Z,1547600465.987 [CommandLine](IMPORTANT): Behavior Stack:

2019-01-16T01:01:05.987Z,1547600465.987 [MissionManager](IMPORTANT): Mission loaded, but not running.
2019-01-16T01:01:19.463Z,1547600479.463 [CommandLine](IMPORTANT): got command show stack
2019-01-16T01:01:19.463Z,1547600479.463 [CommandLine](IMPORTANT): Behavior Stack:

2019-01-16T01:01:19.463Z,1547600479.463 [MissionManager](IMPORTANT): Mission loaded, but not running.
2019-01-16T01:01:34.250Z,1547600494.250 [SBIT](IMPORTANT): SBIT PASSED
2019-01-16T01:01:34.283Z,1547600494.283 [CommandLine](IMPORTANT): got command configSet list
2019-01-16T01:01:34.283Z,1547600494.283 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-01-16T01:01:34.284Z,1547600494.284 [CommandLine](IMPORTANT): Aanderaa_O2.loadAtStartup=0 bool;

2019-01-16T01:01:34.284Z,1547600494.284 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2019-01-16T01:01:34.284Z,1547600494.284 [CommandLine](IMPORTANT): PAR_Licor.loadAtStartup=1 bool;

2019-01-16T01:01:34.284Z,1547600494.284 [CommandLine](IMPORTANT): Rowe_600LCM.loadAtStartup=1 bool;

2019-01-16T01:01:34.615Z,1547600494.615 [MissionManager](IMPORTANT): Started mission Startup
2019-01-16T01:01:34.615Z,1547600494.615 [Startup] Running Loop=1
2019-01-16T01:01:34.615Z,1547600494.615 [Startup](DEBUG): Aggregate::initialize Startup
2019-01-16T01:01:34.615Z,1547600494.615 [Startup:A.GoToSurface] Running Loop=1
2019-01-16T01:01:34.615Z,1547600494.615 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-01-16T01:01:34.616Z,1547600494.616 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-01-16T01:01:34.616Z,1547600494.616 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-01-16T01:01:34.616Z,1547600494.616 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-01-16T01:01:34.617Z,1547600494.617 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-01-16T01:01:34.621Z,1547600494.621 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-01-16T01:01:34.630Z,1547600494.630 [Startup:StartupSatComms] Running Loop=1
2019-01-16T01:01:34.630Z,1547600494.630 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-01-16T01:01:34.630Z,1547600494.630 [Startup:StartupSatComms:A] Running Loop=1
2019-01-16T01:01:35.045Z,1547600495.045 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-01-16T01:02:05.938Z,1547600525.938 [CommandLine](IMPORTANT): got command show stack
2019-01-16T01:02:05.938Z,1547600525.938 [CommandLine](IMPORTANT): Behavior Stack:

2019-01-16T01:02:05.938Z,1547600525.938 [Startup](IMPORTANT): Priority 0: Startup:A.GoToSurface
2019-01-16T01:02:05.939Z,1547600525.939 [Startup:StartupSatComms](IMPORTANT): Priority 1: Startup:StartupSatComms:A
2019-01-16T01:02:34.635Z,1547600554.635 [Startup:StartupSatComms:A](INFO): Timed out from 2019-01-16T01:01:34.6Z
2019-01-16T01:02:34.635Z,1547600554.635 [Startup:StartupSatComms:A] Stopped
2019-01-16T01:02:34.635Z,1547600554.635 [Startup:StartupSatComms:B] Running Loop=1
2019-01-16T01:02:34.999Z,1547600554.999 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-01-16T01:02:41.035Z,1547600561.035 [CommandLine](IMPORTANT): got command show stack
2019-01-16T01:02:41.035Z,1547600561.035 [CommandLine](IMPORTANT): Behavior Stack:

2019-01-16T01:02:41.035Z,1547600561.035 [Startup](IMPORTANT): Priority 0: Startup:A.GoToSurface
2019-01-16T01:02:41.036Z,1547600561.036 [Startup:StartupSatComms](IMPORTANT): Priority 1: Startup:StartupSatComms:B
2019-01-16T01:03:16.285Z,1547600596.285 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = 1000174.165498
2019-01-16T01:03:16.285Z,1547600596.285 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-01-16T01:03:16.285Z,1547600596.285 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-01-16T01:03:16.347Z,1547600596.347 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-01-16T01:03:16.719Z,1547600596.719 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-01-16T01:03:16.719Z,1547600596.719 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-01-16T01:03:17.109Z,1547600597.109 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-01-16T01:03:17.126Z,1547600597.126 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2019-01-16T01:03:17.127Z,1547600597.127 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2019-01-16T01:03:35.025Z,1547600615.025 [Startup:StartupSatComms:B](INFO): Timed out from 2019-01-16T01:02:34.6Z
2019-01-16T01:03:35.025Z,1547600615.025 [Startup:StartupSatComms:B] Stopped
2019-01-16T01:03:35.026Z,1547600615.026 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-01-16T01:03:35.026Z,1547600615.026 [Startup:StartupSatComms] Stopped
2019-01-16T01:03:35.026Z,1547600615.026 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-01-16T01:03:35.027Z,1547600615.027 [Startup](INFO): Completed Startup
2019-01-16T01:03:35.027Z,1547600615.027 [MissionManager](INFO): Startup is completed.
2019-01-16T01:03:35.027Z,1547600615.027 [MissionManager](INFO): Uninitializing Mission Startup
2019-01-16T01:03:35.027Z,1547600615.027 [Startup] Stopped
2019-01-16T01:03:35.027Z,1547600615.027 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-01-16T01:03:35.027Z,1547600615.027 [Startup:A.GoToSurface] Stopped
2019-01-16T01:03:35.027Z,1547600615.027 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-01-16T01:03:35.526Z,1547600615.526 [MissionManager](IMPORTANT): Started mission Default
2019-01-16T01:03:35.526Z,1547600615.526 [Default] Running Loop=1
2019-01-16T01:03:35.527Z,1547600615.527 [Default](DEBUG): Aggregate::initialize Default
2019-01-16T01:03:35.527Z,1547600615.527 [Default:B.GoToSurface] Running Loop=1
2019-01-16T01:03:35.527Z,1547600615.527 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-01-16T01:03:35.527Z,1547600615.527 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-01-16T01:03:35.527Z,1547600615.527 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-01-16T01:03:35.528Z,1547600615.528 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-01-16T01:03:35.528Z,1547600615.528 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-01-16T01:03:35.528Z,1547600615.528 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-01-16T01:03:35.528Z,1547600615.528 [Default:A.Wait] Running Loop=1
2019-01-16T01:03:35.529Z,1547600615.529 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-01-16T01:03:42.871Z,1547600622.871 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004505
2019-01-16T01:03:48.451Z,1547600628.451 [CommandLine](IMPORTANT): got command show stack
2019-01-16T01:03:48.451Z,1547600628.451 [CommandLine](IMPORTANT): Behavior Stack:

2019-01-16T01:03:48.451Z,1547600628.451 [Default](IMPORTANT): Priority 0: Default:A.Wait
2019-01-16T01:03:48.452Z,1547600628.452 [Default](IMPORTANT): Priority 1: Default:B.GoToSurface
2019-01-16T01:03:48.546Z,1547600628.546 [Default:A.Wait](INFO): Done Waiting.
2019-01-16T01:03:48.546Z,1547600628.546 [Default:A.Wait] Stopped
2019-01-16T01:03:48.546Z,1547600628.546 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-01-16T01:03:48.913Z,1547600628.913 [Default:CheckIn] Running Loop=1
2019-01-16T01:03:48.913Z,1547600628.913 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-01-16T01:03:48.913Z,1547600628.913 [Default:CheckIn:Read_GPS] Running Loop=1
2019-01-16T01:03:49.328Z,1547600629.328 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-01-16T01:03:56.919Z,1547600636.919 [CommandLine](IMPORTANT): got command show stack
2019-01-16T01:03:56.919Z,1547600636.919 [CommandLine](IMPORTANT): Behavior Stack:

2019-01-16T01:03:56.920Z,1547600636.920 [Default](IMPORTANT): Priority 0: Default:B.GoToSurface
2019-01-16T01:03:56.920Z,1547600636.920 [Default:CheckIn](IMPORTANT): Priority 1: Default:CheckIn:Read_GPS
2019-01-16T01:04:07.675Z,1547600647.675 [CommandLine](IMPORTANT): got command run ./Missions/Insert/Science.xml
2019-01-16T01:04:07.676Z,1547600647.676 [MissionManager](INFO): Loading Mission: ./Missions/Insert/Science.xml
2019-01-16T01:04:07.943Z,1547600647.943 [MissionManager](INFO): DefineArg Science.SampleISUS = 0 bool
2019-01-16T01:04:07.946Z,1547600647.946 [MissionManager](INFO): DefineArg Science.SampleISUSmaxPitch = 60.000000 arcdeg
2019-01-16T01:04:07.950Z,1547600647.950 [MissionManager](INFO): DefineArg Science.SampleISUSminPitch = -60.000000 arcdeg
2019-01-16T01:04:07.952Z,1547600647.952 [MissionManager](INFO): DefineArg Science.PeakDetectChlActive = 0 bool
2019-01-16T01:04:07.955Z,1547600647.955 [MissionManager](INFO): DefineArg Science.TimeWindowPeakReport = nan min
2019-01-16T01:04:07.958Z,1547600647.958 [MissionManager](INFO): DefineArg Science.HighestChlPeakReportActive = 0 bool
2019-01-16T01:04:07.961Z,1547600647.961 [MissionManager](INFO): DefineArg Science.PatchTracking = 0 bool
2019-01-16T01:04:07.964Z,1547600647.964 [MissionManager](INFO): DefineArg Science.FilterWidthHorizontal = 3.000000 count
2019-01-16T01:04:07.967Z,1547600647.967 [MissionManager](INFO): DefineArg Science.NumProfilesSlidingwindow = 100.000000 count
2019-01-16T01:04:07.971Z,1547600647.971 [MissionManager](INFO): DefineArg Science.OffPeakFractionHorizontal = 80.000000 %
2019-01-16T01:04:07.973Z,1547600647.973 [MissionManager](INFO): DefineArg Science.PeakDetectNO3Active = 0 bool
2019-01-16T01:04:07.976Z,1547600647.976 [MissionManager](INFO): DefineArg Science.PeakDetectOilActive = 0 bool
2019-01-16T01:04:07.979Z,1547600647.979 [MissionManager](INFO): DefineArg Science.PeakDetectFDOMActive = 0 bool
2019-01-16T01:04:07.982Z,1547600647.982 [MissionManager](INFO): DefineArg Science.UpwardDerivativeOfTemperatureActive = 0 bool
2019-01-16T01:04:08.006Z,1547600648.006 [MissionManager](INFO): DefineArg Science.EnabledAanderaaO2 = 0.000000 bool
2019-01-16T01:04:08.015Z,1547600648.015 [MissionManager](INFO): DefineArg Science.EnabledNeilBrown = 0.000000 bool
2019-01-16T01:04:08.038Z,1547600648.038 [MissionManager](INFO): DefineArg Science.EnabledSeabird = 1.000000 bool
2019-01-16T01:04:08.041Z,1547600648.041 [MissionManager](INFO): DefineArg Science.EnabledTurbulence_NPS = 0.000000 bool
2019-01-16T01:04:08.049Z,1547600648.049 [MissionManager](INFO): DefineArg Science.EnabledWetLabsBB2FL = 1.000000 bool
2019-01-16T01:04:08.052Z,1547600648.052 [MissionManager](INFO): DefineArg Science.EnabledWetLabsSeaOWL_UV_A = 0.000000 bool
2019-01-16T01:04:08.056Z,1547600648.056 [MissionManager](INFO): DefineArg Science.EnabledWetLabsUBAT = 0.000000 bool
2019-01-16T01:04:08.114Z,1547600648.114 [MissionManager](INFO): DefineArg Science.EnabledISUS = 0.000000 bool
2019-01-16T01:04:08.117Z,1547600648.117 [MissionManager](INFO): DefineArg Science.LowPassWindowLength = 20.000000 count
2019-01-16T01:04:08.120Z,1547600648.120 [MissionManager](INFO): DefineArg Science.PeakChlShallowBound = nan m
2019-01-16T01:04:08.176Z,1547600648.176 [MissionManager](INFO): DefineArg Science.PeakChlDeepBound = nan m
2019-01-16T01:04:08.180Z,1547600648.180 [MissionManager](INFO): DefineArg Science.PeakShallowBound = nan m
2019-01-16T01:04:08.234Z,1547600648.234 [MissionManager](INFO): DefineArg Science.PeakDeepBound = nan m
2019-01-16T01:04:08.238Z,1547600648.238 [MissionManager](INFO): DefineOutput Science.PeakChl = 0.000000 ug/l
2019-01-16T01:04:08.270Z,1547600648.270 [MissionManager](INFO): DefineOutput Science.PeakChlDepth = 0.000000 m
2019-01-16T01:04:08.295Z,1547600648.295 [MissionManager](INFO): DefineOutput Science.PeakChlTemperature = 0.000000 degC
2019-01-16T01:04:08.299Z,1547600648.299 [MissionManager](INFO): DefineOutput Science.PeakChlLatitude = nan arcdeg
2019-01-16T01:04:08.347Z,1547600648.347 [MissionManager](INFO): DefineOutput Science.PeakChlLongitude = nan arcdeg
2019-01-16T01:04:08.351Z,1547600648.351 [MissionManager](INFO): DefineOutput Science.PeakNO3 = 0.000000 umol/l
2019-01-16T01:04:08.374Z,1547600648.374 [MissionManager](INFO): DefineOutput Science.PeakNO3Depth = 0.000000 m
2019-01-16T01:04:08.412Z,1547600648.412 [MissionManager](INFO): DefineOutput Science.PeakNO3Latitude = nan arcdeg
2019-01-16T01:04:08.425Z,1547600648.425 [MissionManager](INFO): DefineOutput Science.PeakNO3Longitude = nan arcdeg
2019-01-16T01:04:08.444Z,1547600648.444 [MissionManager](INFO): DefineOutput Science.PatchChl = 0.000000 m
2019-01-16T01:04:08.451Z,1547600648.451 [MissionManager](INFO): DefineOutput Science.PatchChlDepth = 0.000000 m
2019-01-16T01:04:08.471Z,1547600648.471 [MissionManager](INFO): DefineOutput Science.PatchChlLatitude = nan arcdeg
2019-01-16T01:04:08.478Z,1547600648.478 [MissionManager](INFO): DefineOutput Science.PatchChlLongitude = nan arcdeg
2019-01-16T01:04:08.493Z,1547600648.493 [MissionManager](INFO): DefineOutput Science.PatchChlDistance = nan m
2019-01-16T01:04:08.518Z,1547600648.518 [MissionManager](INFO): DefineOutput Science.PeakOil = 0.000000 kg/m3
2019-01-16T01:04:08.533Z,1547600648.533 [MissionManager](INFO): DefineOutput Science.PeakOilDepth = 0.000000 m
2019-01-16T01:04:08.544Z,1547600648.544 [MissionManager](INFO): DefineOutput Science.PeakOilLatitude = nan arcdeg
2019-01-16T01:04:08.556Z,1547600648.556 [MissionManager](INFO): DefineOutput Science.PeakOilLongitude = nan arcdeg
2019-01-16T01:04:08.564Z,1547600648.564 [MissionManager](INFO): DefineOutput Science.PeakFDOM = 0.000000 ppb
2019-01-16T01:04:08.587Z,1547600648.587 [MissionManager](INFO): DefineOutput Science.PeakFDOMDepth = 0.000000 m
2019-01-16T01:04:08.599Z,1547600648.599 [MissionManager](INFO): DefineOutput Science.PeakFDOMLatitude = nan arcdeg
2019-01-16T01:04:08.611Z,1547600648.611 [MissionManager](INFO): DefineOutput Science.PeakFDOMLongitude = nan arcdeg
2019-01-16T01:04:08.619Z,1547600648.619 [MissionManager](INFO): DefineOutput Science.PatchFDOMDistance = nan m
2019-01-16T01:04:08.698Z,1547600648.698 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-01-16T01:04:08.726Z,1547600648.726 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal.
2019-01-16T01:04:08.762Z,1547600648.762 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-01-16T01:04:08.787Z,1547600648.787 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-01-16T01:04:08.822Z,1547600648.822 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth.
2019-01-16T01:04:08.929Z,1547600648.929 [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_colored_dissolved_organic_matter_in_sea_water_expressed_as_equivalent_mass_fraction_of_quinine_sulfate_dihydrate 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="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.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_colored_dissolved_organic_matter_in_sea_water_expressed_as_equivalent_mass_fraction_of_quinine_sulfate_dihydrate/></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-01-16T01:04:08.944Z,1547600648.944 [CommandLine](IMPORTANT): Running ./Missions/Insert/Science.xml
2019-01-16T01:04:08.956Z,1547600648.956 [Default] Stopped
2019-01-16T01:04:08.956Z,1547600648.956 [Default](DEBUG): Aggregate::uninitialize Default
2019-01-16T01:04:08.956Z,1547600648.956 [Default:B.GoToSurface] Stopped
2019-01-16T01:04:08.956Z,1547600648.956 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-01-16T01:04:08.956Z,1547600648.956 [Default:CheckIn] Stopped
2019-01-16T01:04:08.956Z,1547600648.956 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-01-16T01:04:08.956Z,1547600648.956 [Default:CheckIn:Read_GPS] Stopped
2019-01-16T01:04:08.956Z,1547600648.956 [MissionManager](IMPORTANT): Started mission Science
2019-01-16T01:04:08.957Z,1547600648.957 [Science] Running Loop=1
2019-01-16T01:04:08.957Z,1547600648.957 [Science](DEBUG): Aggregate::initialize Science
2019-01-16T01:04:08.957Z,1547600648.957 [Science:A] Running Loop=1
2019-01-16T01:04:08.957Z,1547600648.957 [Science:B] Running Loop=1
2019-01-16T01:04:08.957Z,1547600648.957 [Science:C] Running Loop=1
2019-01-16T01:04:08.969Z,1547600648.969 [Science:D] Running Loop=1
2019-01-16T01:04:08.969Z,1547600648.969 [Science:E] Running Loop=1
2019-01-16T01:04:08.969Z,1547600648.969 [Science:F] Running Loop=1
2019-01-16T01:04:08.970Z,1547600648.970 [Science:G] Running Loop=1
2019-01-16T01:04:08.970Z,1547600648.970 [Science:H] Running Loop=1
2019-01-16T01:04:08.970Z,1547600648.970 [Science:Read_Oil] Running Loop=1
2019-01-16T01:04:08.970Z,1547600648.970 [Science:PeakDetectChl] Running Loop=1
2019-01-16T01:04:08.970Z,1547600648.970 [Science:PeakDetectChl](DEBUG): Aggregate::initialize Science:PeakDetectChl
2019-01-16T01:04:08.970Z,1547600648.970 [Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1
2019-01-16T01:04:08.970Z,1547600648.970 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-01-16T01:04:08.972Z,1547600648.972 [Science:HighestChlPeakReport] Running Loop=1
2019-01-16T01:04:08.972Z,1547600648.972 [Science:HighestChlPeakReport](DEBUG): Aggregate::initialize Science:HighestChlPeakReport
2019-01-16T01:04:08.972Z,1547600648.972 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1
2019-01-16T01:04:08.972Z,1547600648.972 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize.
2019-01-16T01:04:08.973Z,1547600648.973 [Science:PeakDetectNO3] Running Loop=1
2019-01-16T01:04:08.973Z,1547600648.973 [Science:PeakDetectNO3](DEBUG): Aggregate::initialize Science:PeakDetectNO3
2019-01-16T01:04:08.973Z,1547600648.973 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1
2019-01-16T01:04:08.973Z,1547600648.973 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-01-16T01:04:08.979Z,1547600648.979 [Science:PeakDetectOil] Running Loop=1
2019-01-16T01:04:08.979Z,1547600648.979 [Science:PeakDetectOil](DEBUG): Aggregate::initialize Science:PeakDetectOil
2019-01-16T01:04:08.980Z,1547600648.980 [Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1
2019-01-16T01:04:08.980Z,1547600648.980 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-01-16T01:04:08.983Z,1547600648.983 [Science:PeakDetectFDOM] Running Loop=1
2019-01-16T01:04:08.983Z,1547600648.983 [Science:PeakDetectFDOM](DEBUG): Aggregate::initialize Science:PeakDetectFDOM
2019-01-16T01:04:08.983Z,1547600648.983 [Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1
2019-01-16T01:04:08.983Z,1547600648.983 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize.
2019-01-16T01:04:08.990Z,1547600648.990 [Science:PeakDetectFDOM] Stopped
2019-01-16T01:04:08.990Z,1547600648.990 [Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize Science:PeakDetectFDOM
2019-01-16T01:04:08.990Z,1547600648.990 [Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped
2019-01-16T01:04:08.990Z,1547600648.990 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-01-16T01:04:08.990Z,1547600648.990 [Science:PeakDetectOil] Stopped
2019-01-16T01:04:08.991Z,1547600648.991 [Science:PeakDetectOil](DEBUG): Aggregate::uninitialize Science:PeakDetectOil
2019-01-16T01:04:08.991Z,1547600648.991 [Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped
2019-01-16T01:04:08.991Z,1547600648.991 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-01-16T01:04:08.991Z,1547600648.991 [Science:PeakDetectNO3] Stopped
2019-01-16T01:04:08.991Z,1547600648.991 [Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize Science:PeakDetectNO3
2019-01-16T01:04:08.991Z,1547600648.991 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped
2019-01-16T01:04:08.991Z,1547600648.991 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-01-16T01:04:08.991Z,1547600648.991 [Science:HighestChlPeakReport] Stopped
2019-01-16T01:04:08.991Z,1547600648.991 [Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize Science:HighestChlPeakReport
2019-01-16T01:04:08.991Z,1547600648.991 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped
2019-01-16T01:04:08.991Z,1547600648.991 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize.
2019-01-16T01:04:08.991Z,1547600648.991 [Science:PeakDetectChl] Stopped
2019-01-16T01:04:08.991Z,1547600648.991 [Science:PeakDetectChl](DEBUG): Aggregate::uninitialize Science:PeakDetectChl
2019-01-16T01:04:08.992Z,1547600648.992 [Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped
2019-01-16T01:04:08.992Z,1547600648.992 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize.
2019-01-16T01:04:08.992Z,1547600648.992 [Science:Read_Oil] Stopped
2019-01-16T01:04:08.992Z,1547600648.992 [Science:H] Stopped
2019-01-16T01:04:08.992Z,1547600648.992 [Science:G] Running Loop=1
2019-01-16T01:04:08.993Z,1547600648.993 [Science:G](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water
2019-01-16T01:04:08.000Z,1547600649.000 [Science:F] Stopped
2019-01-16T01:04:08.000Z,1547600649.000 [Science:E] Stopped
2019-01-16T01:04:08.000Z,1547600649.000 [Science:D] Running Loop=1
2019-01-16T01:04:09.000Z,1547600649.000 [Science:D](CRITICAL): Unable to read non-existent URI:CTD_Seabird.sea_water_temperature
2019-01-16T01:04:09.000Z,1547600649.000 [Science:D](CRITICAL): Unable to read non-existent data element: CTD_Seabird.sea_water_temperature
2019-01-16T01:04:09.001Z,1547600649.001 [Science:D](CRITICAL): Unable to read non-existent URI:CTD_Seabird.sea_water_salinity
2019-01-16T01:04:09.001Z,1547600649.001 [Science:D](CRITICAL): Unable to read non-existent data element: CTD_Seabird.sea_water_salinity
2019-01-16T01:04:09.017Z,1547600649.017 [Science:C] Running Loop=1
2019-01-16T01:04:09.020Z,1547600649.020 [Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature
2019-01-16T01:04:09.020Z,1547600649.020 [Science:C](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity
2019-01-16T01:04:09.030Z,1547600649.030 [Science:B] Stopped
2019-01-16T01:04:09.030Z,1547600649.030 [Science:A] Stopped
2019-01-16T01:04:09.046Z,1547600649.046 [CBIT](INFO): Critical error at 20190116T010409
2019-01-16T01:04:09.047Z,1547600649.047 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-01-16T01:04:09.362Z,1547600649.362 [Science:D](CRITICAL): Unable to read non-existent URI:CTD_Seabird.sea_water_temperature
2019-01-16T01:04:09.362Z,1547600649.362 [Science:D](CRITICAL): Unable to read non-existent data element: CTD_Seabird.sea_water_temperature
2019-01-16T01:04:09.362Z,1547600649.362 [Science:D](CRITICAL): Unable to read non-existent URI:CTD_Seabird.sea_water_salinity
2019-01-16T01:04:09.362Z,1547600649.362 [Science:D](CRITICAL): Unable to read non-existent data element: CTD_Seabird.sea_water_salinity
2019-01-16T01:04:09.363Z,1547600649.363 [MissionManager](INFO): MissionManager is completed.
2019-01-16T01:04:09.363Z,1547600649.363 [MissionManager](INFO): Uninitializing Mission Science
2019-01-16T01:04:09.363Z,1547600649.363 [Science] Stopped
2019-01-16T01:04:09.363Z,1547600649.363 [Science](DEBUG): Aggregate::uninitialize Science
2019-01-16T01:04:09.363Z,1547600649.363 [Science:C] Stopped
2019-01-16T01:04:09.363Z,1547600649.363 [Science:D] Stopped
2019-01-16T01:04:09.363Z,1547600649.363 [Science:G] Stopped
2019-01-16T01:04:09.450Z,1547600649.450 [CBIT](INFO): Critical error at 20190116T010409
2019-01-16T01:04:09.721Z,1547600649.721 [MissionManager](IMPORTANT): Started mission Default
2019-01-16T01:04:09.721Z,1547600649.721 [Default] Running Loop=1
2019-01-16T01:04:09.721Z,1547600649.721 [Default](DEBUG): Aggregate::initialize Default
2019-01-16T01:04:09.729Z,1547600649.729 [Default:B.GoToSurface] Running Loop=1
2019-01-16T01:04:09.729Z,1547600649.729 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-01-16T01:04:09.730Z,1547600649.730 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-01-16T01:04:09.730Z,1547600649.730 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-01-16T01:04:09.730Z,1547600649.730 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-01-16T01:04:09.731Z,1547600649.731 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-01-16T01:04:09.731Z,1547600649.731 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-01-16T01:04:09.731Z,1547600649.731 [Default:A.Wait] Running Loop=1
2019-01-16T01:04:09.731Z,1547600649.731 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-01-16T01:04:22.934Z,1547600662.934 [Default:A.Wait](INFO): Done Waiting.
2019-01-16T01:04:22.934Z,1547600662.934 [Default:A.Wait] Stopped
2019-01-16T01:04:22.934Z,1547600662.934 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-01-16T01:04:23.379Z,1547600663.379 [Default:CheckIn] Running Loop=1
2019-01-16T01:04:23.379Z,1547600663.379 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-01-16T01:04:23.380Z,1547600663.380 [Default:CheckIn:Read_GPS] Running Loop=1
2019-01-16T01:05:56.408Z,1547600756.408 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-01-16T01:06:17.258Z,1547600777.258 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = 1000355.138257
2019-01-16T01:06:17.258Z,1547600777.258 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2019-01-16T01:06:17.258Z,1547600777.258 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-01-16T01:06:17.271Z,1547600777.271 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-01-16T01:06:17.664Z,1547600777.664 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-01-16T01:06:17.664Z,1547600777.664 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2019-01-16T01:06:18.046Z,1547600778.046 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-01-16T01:06:18.047Z,1547600778.047 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2019-01-16T01:06:18.047Z,1547600778.047 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2019-01-16T01:06:39.976Z,1547600799.976 [BPC1](ERROR): BPC1A: No match for serial number 1717 in BPC1A's battery stick inventory (sticks 1-32 in onboard configuration file).
2019-01-16T01:09:18.382Z,1547600958.382 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = 1000536.263079
2019-01-16T01:09:18.383Z,1547600958.383 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2019-01-16T01:09:18.383Z,1547600958.383 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-01-16T01:09:18.424Z,1547600958.424 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-01-16T01:09:18.852Z,1547600958.852 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-01-16T01:09:18.852Z,1547600958.852 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2019-01-16T01:09:19.207Z,1547600959.207 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-01-16T01:09:19.208Z,1547600959.208 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2019-01-16T01:09:19.208Z,1547600959.208 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2019-01-16T01:09:23.632Z,1547600963.632 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-01-16T01:04:23.4Z
2019-01-16T01:09:23.632Z,1547600963.632 [Default:CheckIn:Read_GPS] Stopped
2019-01-16T01:09:23.636Z,1547600963.636 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-01-16T01:09:23.999Z,1547600963.999 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-01-16T01:09:30.020Z,1547600970.020 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190116T004009/Courier0007.lzma
2019-01-16T01:09:30.828Z,1547600970.828 [DataOverHttps](INFO): Moved sent file to Logs/20190116T004009/Courier0007.lzma.bak
2019-01-16T01:09:30.828Z,1547600970.828 [DataOverHttps](INFO): SBD MOMSN=9177546
2019-01-16T01:09:42.244Z,1547600982.244 [DataOverHttps](INFO): Sending 143 bytes from file Logs/20190116T010004/Courier0000.lzma
2019-01-16T01:09:43.043Z,1547600983.043 [DataOverHttps](INFO): Moved sent file to Logs/20190116T010004/Courier0000.lzma.bak
2019-01-16T01:09:43.043Z,1547600983.043 [DataOverHttps](INFO): SBD MOMSN=9177548
2019-01-16T01:09:54.441Z,1547600994.441 [DataOverHttps](INFO): Sending 183 bytes from file Logs/20190116T010004/Courier0004.lzma
2019-01-16T01:09:55.239Z,1547600995.239 [DataOverHttps](INFO): Moved sent file to Logs/20190116T010004/Courier0004.lzma.bak
2019-01-16T01:09:55.239Z,1547600995.239 [DataOverHttps](INFO): SBD MOMSN=9177552
2019-01-16T01:10:08.249Z,1547601008.249 [DataOverHttps](INFO): Sending 248 bytes from file Logs/20190116T004009/Express0008.lzma
2019-01-16T01:10:09.019Z,1547601009.019 [DataOverHttps](INFO): Moved sent file to Logs/20190116T004009/Express0008.lzma.bak
2019-01-16T01:10:09.019Z,1547601009.019 [DataOverHttps](INFO): SBD MOMSN=9177562
2019-01-16T01:10:21.884Z,1547601021.884 [DataOverHttps](INFO): Sending 923 bytes from file Logs/20190116T010004/Express0001.lzma
2019-01-16T01:10:22.671Z,1547601022.671 [DataOverHttps](INFO): Moved sent file to Logs/20190116T010004/Express0001.lzma.bak
2019-01-16T01:10:22.671Z,1547601022.671 [DataOverHttps](INFO): SBD MOMSN=9177568
2019-01-16T01:10:35.558Z,1547601035.558 [DataOverHttps](INFO): Sending 424 bytes from file Logs/20190116T010004/Express0005.lzma
2019-01-16T01:10:36.351Z,1547601036.351 [DataOverHttps](INFO): Moved sent file to Logs/20190116T010004/Express0005.lzma.bak
2019-01-16T01:10:36.351Z,1547601036.351 [DataOverHttps](INFO): SBD MOMSN=9177598
2019-01-16T01:10:40.094Z,1547601040.094 [Default:CheckIn:Read_Iridium] Stopped
2019-01-16T01:10:40.094Z,1547601040.094 [Default:CheckIn:C.Wait] Running Loop=1
2019-01-16T01:10:40.094Z,1547601040.094 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2019-01-16T01:10:44.197Z,1547601044.197 [BPC1](FAULT): Failed to parse data from all battery packs.
2019-01-16T01:10:44.197Z,1547601044.197 [BPC1] Data Fault, FailCount= 1
2019-01-16T01:10:44.197Z,1547601044.197 [BPC1](ERROR): Data Fault
2019-01-16T01:10:44.224Z,1547601044.224 [CBIT](ERROR): Data Fault in component: BPC1
2019-01-16T01:10:56.487Z,1547601056.487 [NAL9602](FAULT): GPS failed to acquire within timeout.
2019-01-16T01:10:56.487Z,1547601056.487 [NAL9602] Data Fault, FailCount= 1
2019-01-16T01:10:56.487Z,1547601056.487 [NAL9602](ERROR): Data Fault
2019-01-16T01:10:56.529Z,1547601056.529 [CBIT](ERROR): Data Fault in component: NAL9602
2019-01-16T01:10:56.903Z,1547601056.903 [NAL9602](INFO): Powering down
2019-01-16T01:10:57.732Z,1547601057.732 [CBIT](INFO): Clearing failed state for component NAL9602
2019-01-16T01:10:57.732Z,1547601057.732 [NAL9602] No Fault, FailCount= 1
2019-01-16T01:11:27.283Z,1547601087.283 [NAL9602](INFO): Powering up NAL9602
2019-01-16T01:11:38.483Z,1547601098.483 [NAL9602](INFO): NAL9602 initialized
2019-01-16T01:12:19.508Z,1547601139.508 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = 1000717.388641
2019-01-16T01:12:19.508Z,1547601139.508 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2019-01-16T01:12:19.508Z,1547601139.508 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-01-16T01:12:19.521Z,1547601139.521 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-01-16T01:12:20.030Z,1547601140.030 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-01-16T01:12:20.030Z,1547601140.030 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2019-01-16T01:12:20.352Z,1547601140.352 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-01-16T01:12:20.353Z,1547601140.353 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2019-01-16T01:12:20.354Z,1547601140.354 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2019-01-16T01:15:15.146Z,1547601315.146 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-01-16T01:15:15.146Z,1547601315.146 [CTD_Seabird] No Fault, FailCount= 1
2019-01-16T01:15:15.314Z,1547601315.314 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-01-16T01:15:15.317Z,1547601315.317 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-01-16T01:15:20.720Z,1547601320.720 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = 1000898.600858
2019-01-16T01:15:20.720Z,1547601320.720 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2019-01-16T01:15:20.720Z,1547601320.720 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-01-16T01:15:20.765Z,1547601320.765 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-01-16T01:15:21.163Z,1547601321.163 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-01-16T01:15:21.164Z,1547601321.164 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2019-01-16T01:15:21.527Z,1547601321.527 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-01-16T01:15:21.528Z,1547601321.528 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2019-01-16T01:15:21.528Z,1547601321.528 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2019-01-16T01:15:40.379Z,1547601340.379 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2019-01-16T01:15:40.379Z,1547601340.379 [Default:CheckIn:C.Wait] Stopped
2019-01-16T01:15:40.379Z,1547601340.379 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2019-01-16T01:15:40.380Z,1547601340.380 [Default:CheckIn:D] Running Loop=1
2019-01-16T01:15:40.738Z,1547601340.738 [Default:CheckIn:D] Stopped
2019-01-16T01:15:40.738Z,1547601340.738 [Default:CheckIn:E] Running Loop=1
2019-01-16T01:15:41.109Z,1547601341.109 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.516461 min 
2019-01-16T01:15:41.127Z,1547601341.127 [Default:CheckIn:E] Stopped
2019-01-16T01:15:41.127Z,1547601341.127 [Default:CheckIn](INFO): Completed Default:CheckIn
2019-01-16T01:15:41.127Z,1547601341.127 [Default:CheckIn] Stopped
2019-01-16T01:15:41.127Z,1547601341.127 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-01-16T01:15:41.128Z,1547601341.128 [Default:CheckIn](INFO): Running loop #2
2019-01-16T01:15:41.128Z,1547601341.128 [Default:CheckIn] Running Loop=2
2019-01-16T01:15:41.128Z,1547601341.128 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-01-16T01:15:41.128Z,1547601341.128 [Default:CheckIn:Read_GPS] Running Loop=1
2019-01-16T01:18:21.687Z,1547601501.687 [DeadReckonUsingSpeedCalculator](ERROR): Will not write estimated position: latitudeAccuracy_ = nan, longitudeAccuracy_ = nan, depthAccuracy_ = 1001079.567998
2019-01-16T01:18:21.687Z,1547601501.687 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2019-01-16T01:18:21.687Z,1547601501.687 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-01-16T01:18:21.700Z,1547601501.700 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-01-16T01:18:22.067Z,1547601502.067 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-01-16T01:18:22.067Z,1547601502.067 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2019-01-16T01:18:22.450Z,1547601502.450 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-01-16T01:18:22.451Z,1547601502.451 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2019-01-16T01:18:22.451Z,1547601502.451 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2019-01-16T01:18:32.914Z,1547601512.914 [CommandLine](IMPORTANT): got command restart system
2019-01-16T01:18:35.332Z,1547601515.332 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-01-16T01:18:35.333Z,1547601515.333 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:35.365Z,1547601515.365 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-01-16T01:18:35.366Z,1547601515.366 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:35.366Z,1547601515.366 [CommandLine](INFO): Join timeout helper Thread ID is 951
2019-01-16T01:18:35.377Z,1547601515.377 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-01-16T01:18:35.377Z,1547601515.377 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:35.378Z,1547601515.378 [NavChartDb](INFO): Join timeout helper Thread ID is 952
2019-01-16T01:18:35.458Z,1547601515.458 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-01-16T01:18:35.458Z,1547601515.458 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:35.478Z,1547601515.478 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-01-16T01:18:35.479Z,1547601515.479 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:35.479Z,1547601515.479 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 953
2019-01-16T01:18:35.806Z,1547601515.806 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-01-16T01:18:35.806Z,1547601515.806 [WetLabsBB2FL](INFO): Powering down
2019-01-16T01:18:35.807Z,1547601515.807 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:35.826Z,1547601515.826 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2019-01-16T01:18:35.826Z,1547601515.826 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:35.826Z,1547601515.826 [CTD_Seabird](INFO): Join timeout helper Thread ID is 954
2019-01-16T01:18:36.310Z,1547601516.310 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2019-01-16T01:18:36.310Z,1547601516.310 [CTD_Seabird](INFO): Powering down
2019-01-16T01:18:36.322Z,1547601516.322 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:36.342Z,1547601516.342 [ComponentRegistry](INFO): Shutting down Rowe_600LCM ThreadHandler
2019-01-16T01:18:36.342Z,1547601516.342 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:36.342Z,1547601516.342 [Rowe_600LCM](INFO): Join timeout helper Thread ID is 955
2019-01-16T01:18:36.626Z,1547601516.626 [Rowe_600LCM ThreadHandler](INFO): Uninitializing protected caller thread.
2019-01-16T01:18:36.626Z,1547601516.626 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2019-01-16T01:18:37.043Z,1547601517.043 [Rowe_600LCM](INFO): Powering down
2019-01-16T01:18:37.044Z,1547601517.044 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:37.051Z,1547601517.051 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-01-16T01:18:37.051Z,1547601517.051 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:37.051Z,1547601517.051 [Radio_Surface](INFO): Join timeout helper Thread ID is 957
2019-01-16T01:18:37.362Z,1547601517.362 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-01-16T01:18:37.362Z,1547601517.362 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:37.378Z,1547601517.378 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-01-16T01:18:37.379Z,1547601517.379 [logger ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:37.379Z,1547601517.379 [logger](INFO): Join timeout helper Thread ID is 958
2019-01-16T01:18:37.394Z,1547601517.394 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-01-16T01:18:37.394Z,1547601517.394 [logger ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:37.398Z,1547601517.398 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-01-16T01:18:37.398Z,1547601517.398 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:37.399Z,1547601517.399 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-01-16T01:18:37.399Z,1547601517.399 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:37.399Z,1547601517.399 [controlThread](INFO): Join timeout helper Thread ID is 959
2019-01-16T01:18:37.602Z,1547601517.602 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-01-16T01:18:37.602Z,1547601517.602 [controlThread](DEBUG): Uninitializing ControlThread
2019-01-16T01:18:37.602Z,1547601517.602 [AcousticModem_Benthos_ATM900](INFO): Powering down
2019-01-16T01:18:37.722Z,1547601517.722 [NAL9602](INFO): Powering down
2019-01-16T01:18:37.724Z,1547601517.724 [PNI_TCM](INFO): Powering down
2019-01-16T01:18:37.812Z,1547601517.812 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-01-16T01:18:37.813Z,1547601517.813 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-01-16T01:18:37.814Z,1547601517.814 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-01-16T01:18:37.814Z,1547601517.814 [MissionManager](INFO): Uninitializing Mission Default
2019-01-16T01:18:37.814Z,1547601517.814 [Default] Stopped
2019-01-16T01:18:37.814Z,1547601517.814 [Default](DEBUG): Aggregate::uninitialize Default
2019-01-16T01:18:37.815Z,1547601517.815 [Default:B.GoToSurface] Stopped
2019-01-16T01:18:37.815Z,1547601517.815 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-01-16T01:18:37.815Z,1547601517.815 [Default:CheckIn] Stopped
2019-01-16T01:18:37.815Z,1547601517.815 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-01-16T01:18:37.815Z,1547601517.815 [Default:CheckIn:Read_GPS] Stopped
2019-01-16T01:18:37.818Z,1547601517.818 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-01-16T01:18:37.819Z,1547601517.819 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-01-16T01:18:37.819Z,1547601517.819 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-01-16T01:18:37.819Z,1547601517.819 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-01-16T01:18:37.820Z,1547601517.820 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-01-16T01:18:37.820Z,1547601517.820 [BuoyancyServo](INFO): Powering down
2019-01-16T01:18:37.834Z,1547601517.834 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-01-16T01:18:37.834Z,1547601517.834 [ElevatorServo](INFO): Powering down
2019-01-16T01:18:37.835Z,1547601517.835 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-01-16T01:18:37.835Z,1547601517.835 [MassServo](INFO): Powering down
2019-01-16T01:18:37.836Z,1547601517.836 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-01-16T01:18:37.836Z,1547601517.836 [RudderServo](INFO): Powering down
2019-01-16T01:18:37.837Z,1547601517.837 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-01-16T01:18:37.837Z,1547601517.837 [ThrusterServo](INFO): Powering down
2019-01-16T01:18:37.838Z,1547601517.838 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-01-16T01:18:37.838Z,1547601517.838 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-01-16T01:18:37.839Z,1547601517.839 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-01-16T01:18:37.839Z,1547601517.839 [CBIT](DEBUG): Powering off loads.
2019-01-16T01:18:37.850Z,1547601517.850 [CBIT](DEBUG): Disabling WDT.
2019-01-16T01:18:37.861Z,1547601517.861 [CBIT](DEBUG): Opening all GF detection circuits.
2019-01-16T01:18:37.863Z,1547601517.863 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:38.007Z,1547601518.007 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:38.012Z,1547601518.012 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:38.057Z,1547601518.057 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:38.061Z,1547601518.061 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:38.110Z,1547601518.110 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-01-16T01:18:38.165Z,1547601518.165 [logger ThreadHandler](INFO): Thread cancelled.