2019-06-13T21:21:23.321Z,1560460883.321 [Supervisor](DEBUG): Initializing supervisor.
2019-06-13T21:21:23.324Z,1560460883.324 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2019-06-13T21:21:23.325Z,1560460883.325 [SyncHandler](INFO): Protected caller Thread ID is 7859
2019-06-13T21:21:23.325Z,1560460883.325 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2019-06-13T21:21:23.326Z,1560460883.326 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2019-06-13T21:21:23.326Z,1560460883.326 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7860
2019-06-13T21:21:23.329Z,1560460883.329 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2019-06-13T21:21:23.341Z,1560460883.341 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2019-06-13T21:21:23.342Z,1560460883.342 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2019-06-13T21:21:23.342Z,1560460883.342 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7861
2019-06-13T21:21:23.343Z,1560460883.343 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2019-06-13T21:21:23.344Z,1560460883.344 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2019-06-13T21:21:23.344Z,1560460883.344 [logger ThreadHandler](INFO): Protected caller Thread ID is 7862
2019-06-13T21:21:23.346Z,1560460883.346 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2019-06-13T21:21:23.347Z,1560460883.347 [Supervisor](INFO): Looking for Config files in directory: Config/
2019-06-13T21:21:23.348Z,1560460883.348 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2019-06-13T21:21:23.780Z,1560460883.780 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2019-06-13T21:21:23.780Z,1560460883.780 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2019-06-13T21:21:23.980Z,1560460883.980 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2019-06-13T21:21:23.980Z,1560460883.980 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2019-06-13T21:21:24.120Z,1560460884.120 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2019-06-13T21:21:24.121Z,1560460884.121 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2019-06-13T21:21:24.424Z,1560460884.424 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2019-06-13T21:21:24.424Z,1560460884.424 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2019-06-13T21:21:24.762Z,1560460884.762 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2019-06-13T21:21:24.763Z,1560460884.763 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2019-06-13T21:21:24.859Z,1560460884.859 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2019-06-13T21:21:24.860Z,1560460884.860 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2019-06-13T21:21:25.009Z,1560460885.009 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2019-06-13T21:21:25.010Z,1560460885.010 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2019-06-13T21:21:25.485Z,1560460885.485 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2019-06-13T21:21:25.485Z,1560460885.485 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2019-06-13T21:21:25.873Z,1560460885.873 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2019-06-13T21:21:25.874Z,1560460885.874 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2019-06-13T21:21:26.024Z,1560460886.024 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2019-06-13T21:21:26.232Z,1560460886.232 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2019-06-13T21:21:26.233Z,1560460886.233 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2019-06-13T21:21:26.337Z,1560460886.337 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2019-06-13T21:21:26.338Z,1560460886.338 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2019-06-13T21:21:26.951Z,1560460886.951 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2019-06-13T21:21:26.952Z,1560460886.952 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2019-06-13T21:21:27.053Z,1560460887.053 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2019-06-13T21:21:27.054Z,1560460887.054 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2019-06-13T21:21:27.277Z,1560460887.277 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2019-06-13T21:21:27.279Z,1560460887.279 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/
2019-06-13T21:21:27.280Z,1560460887.280 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg
2019-06-13T21:21:27.456Z,1560460887.456 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg
2019-06-13T21:21:27.553Z,1560460887.553 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg
2019-06-13T21:21:27.664Z,1560460887.664 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg
2019-06-13T21:21:27.766Z,1560460887.766 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg
2019-06-13T21:21:27.850Z,1560460887.850 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg
2019-06-13T21:21:27.935Z,1560460887.935 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg
2019-06-13T21:21:28.069Z,1560460888.069 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg
2019-06-13T21:21:28.241Z,1560460888.241 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg
2019-06-13T21:21:28.466Z,1560460888.466 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg
2019-06-13T21:21:29.024Z,1560460889.024 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2019-06-13T21:21:29.024Z,1560460889.024 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg
2019-06-13T21:21:29.123Z,1560460889.123 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/
2019-06-13T21:21:29.123Z,1560460889.123 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2019-06-13T21:21:29.126Z,1560460889.126 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2019-06-13T21:21:29.418Z,1560460889.418 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2019-06-13T21:21:29.418Z,1560460889.418 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2019-06-13T21:21:29.526Z,1560460889.526 [DeadReckonUsingMultipleVelocitySources] Loaded
2019-06-13T21:21:29.527Z,1560460889.527 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2019-06-13T21:21:29.585Z,1560460889.585 [DeadReckonUsingSpeedCalculator] Loaded
2019-06-13T21:21:29.585Z,1560460889.585 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2019-06-13T21:21:29.605Z,1560460889.605 [NavChart] Loaded
2019-06-13T21:21:29.606Z,1560460889.606 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2019-06-13T21:21:29.609Z,1560460889.609 [UniversalFixResidualReporter] Loaded
2019-06-13T21:21:29.610Z,1560460889.610 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2019-06-13T21:21:29.610Z,1560460889.610 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2019-06-13T21:21:29.611Z,1560460889.611 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2019-06-13T21:21:29.624Z,1560460889.624 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2019-06-13T21:21:29.624Z,1560460889.624 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2019-06-13T21:21:29.874Z,1560460889.874 [CTD_NeilBrown] Loaded
2019-06-13T21:21:29.874Z,1560460889.874 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2019-06-13T21:21:29.875Z,1560460889.875 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 406684E0
2019-06-13T21:21:29.875Z,1560460889.875 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 7942
2019-06-13T21:21:29.885Z,1560460889.885 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_density
2019-06-13T21:21:29.890Z,1560460889.890 [CTD_Seabird](INFO): created writer for : sea_water_density
2019-06-13T21:21:29.892Z,1560460889.892 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): depth
2019-06-13T21:21:29.896Z,1560460889.896 [CTD_Seabird](INFO): created writer for : depth
2019-06-13T21:21:29.897Z,1560460889.897 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_pressure
2019-06-13T21:21:29.902Z,1560460889.902 [CTD_Seabird](INFO): created writer for : sea_water_pressure
2019-06-13T21:21:29.902Z,1560460889.902 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_salinity
2019-06-13T21:21:29.907Z,1560460889.907 [CTD_Seabird](INFO): created writer for : sea_water_salinity
2019-06-13T21:21:29.908Z,1560460889.908 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_temperature
2019-06-13T21:21:29.913Z,1560460889.913 [CTD_Seabird](INFO): created writer for : sea_water_temperature
2019-06-13T21:21:29.913Z,1560460889.913 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): sea_water_electrical_conductivity
2019-06-13T21:21:29.918Z,1560460889.918 [CTD_Seabird](INFO): created writer for : sea_water_electrical_conductivity
2019-06-13T21:21:29.919Z,1560460889.919 [CTD_Seabird](DEBUG): LcmSlateWriter::add(): speed_of_sound_in_sea_water
2019-06-13T21:21:29.923Z,1560460889.923 [CTD_Seabird](INFO): created writer for : speed_of_sound_in_sea_water
2019-06-13T21:21:29.950Z,1560460889.950 [CTD_Seabird] Loaded
2019-06-13T21:21:29.950Z,1560460889.950 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2019-06-13T21:21:29.951Z,1560460889.951 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406984E0
2019-06-13T21:21:29.952Z,1560460889.952 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7943
2019-06-13T21:21:30.000Z,1560460890.000 [WetLabsBB2FL] Loaded
2019-06-13T21:21:30.000Z,1560460890.000 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2019-06-13T21:21:30.001Z,1560460890.001 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406C84E0
2019-06-13T21:21:30.002Z,1560460890.002 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7944
2019-06-13T21:21:30.003Z,1560460890.003 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2019-06-13T21:21:30.003Z,1560460890.003 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2019-06-13T21:21:30.070Z,1560460890.070 [VerticalControl](DEBUG): Construct VerticalControl.
2019-06-13T21:21:30.184Z,1560460890.184 [VerticalControl] Loaded
2019-06-13T21:21:30.184Z,1560460890.184 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2019-06-13T21:21:30.185Z,1560460890.185 [HorizontalControl](DEBUG): Construct HorizontalControl.
2019-06-13T21:21:30.254Z,1560460890.254 [HorizontalControl] Loaded
2019-06-13T21:21:30.254Z,1560460890.254 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2019-06-13T21:21:30.255Z,1560460890.255 [SpeedControl](DEBUG): Construct SpeedControl.
2019-06-13T21:21:30.261Z,1560460890.261 [SpeedControl] Loaded
2019-06-13T21:21:30.261Z,1560460890.261 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2019-06-13T21:21:30.261Z,1560460890.261 [LoopControl](DEBUG): Construct LoopControl.
2019-06-13T21:21:30.262Z,1560460890.262 [LoopControl] Loaded
2019-06-13T21:21:30.262Z,1560460890.262 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2019-06-13T21:21:30.263Z,1560460890.263 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2019-06-13T21:21:30.263Z,1560460890.263 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2019-06-13T21:21:30.303Z,1560460890.303 [DepthRateCalculator] Loaded
2019-06-13T21:21:30.303Z,1560460890.303 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2019-06-13T21:21:30.309Z,1560460890.309 [PitchRateCalculator] Loaded
2019-06-13T21:21:30.309Z,1560460890.309 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2019-06-13T21:21:30.322Z,1560460890.322 [SpeedCalculator] Loaded
2019-06-13T21:21:30.322Z,1560460890.322 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2019-06-13T21:21:30.343Z,1560460890.343 [TempGradientCalculator] Loaded
2019-06-13T21:21:30.343Z,1560460890.343 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2019-06-13T21:21:30.348Z,1560460890.348 [YawRateCalculator] Loaded
2019-06-13T21:21:30.349Z,1560460890.349 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2019-06-13T21:21:30.378Z,1560460890.378 [ElevatorOffsetCalculator] Loaded
2019-06-13T21:21:30.378Z,1560460890.378 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2019-06-13T21:21:30.379Z,1560460890.379 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2019-06-13T21:21:30.379Z,1560460890.379 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2019-06-13T21:21:30.449Z,1560460890.449 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2019-06-13T21:21:30.450Z,1560460890.450 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2019-06-13T21:21:30.553Z,1560460890.553 [BuoyancyServo] Loaded
2019-06-13T21:21:30.554Z,1560460890.554 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2019-06-13T21:21:30.565Z,1560460890.565 [ElevatorServo] Loaded
2019-06-13T21:21:30.565Z,1560460890.565 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2019-06-13T21:21:30.576Z,1560460890.576 [MassServo] Loaded
2019-06-13T21:21:30.576Z,1560460890.576 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2019-06-13T21:21:30.588Z,1560460890.588 [RudderServo] Loaded
2019-06-13T21:21:30.588Z,1560460890.588 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2019-06-13T21:21:30.599Z,1560460890.599 [ThrusterServo] Loaded
2019-06-13T21:21:30.599Z,1560460890.599 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2019-06-13T21:21:30.599Z,1560460890.599 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2019-06-13T21:21:30.600Z,1560460890.600 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2019-06-13T21:21:30.699Z,1560460890.699 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2019-06-13T21:21:30.699Z,1560460890.699 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2019-06-13T21:21:31.049Z,1560460891.049 [AHRS_M2] Loaded
2019-06-13T21:21:31.050Z,1560460891.050 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2019-06-13T21:21:31.123Z,1560460891.123 [DataOverHttps] Loaded
2019-06-13T21:21:31.123Z,1560460891.123 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2019-06-13T21:21:31.124Z,1560460891.124 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A4A4E0
2019-06-13T21:21:31.125Z,1560460891.125 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 7945
2019-06-13T21:21:31.138Z,1560460891.138 [Depth_Keller] Loaded
2019-06-13T21:21:31.138Z,1560460891.138 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2019-06-13T21:21:31.143Z,1560460891.143 [DropWeight] Loaded
2019-06-13T21:21:31.143Z,1560460891.143 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2019-06-13T21:21:31.240Z,1560460891.240 [NAL9602] Loaded
2019-06-13T21:21:31.241Z,1560460891.241 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2019-06-13T21:21:31.257Z,1560460891.257 [Onboard] Loaded
2019-06-13T21:21:31.257Z,1560460891.257 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2019-06-13T21:21:31.260Z,1560460891.260 [Radio_Surface] Loaded
2019-06-13T21:21:31.261Z,1560460891.261 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2019-06-13T21:21:31.262Z,1560460891.262 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40A7A4E0
2019-06-13T21:21:31.262Z,1560460891.262 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7946
2019-06-13T21:21:32.778Z,1560460892.778 [BPC1] Loaded
2019-06-13T21:21:32.778Z,1560460892.778 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2019-06-13T21:21:32.778Z,1560460892.778 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2019-06-13T21:21:32.779Z,1560460892.779 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2019-06-13T21:21:32.913Z,1560460892.913 [SBIT](DEBUG): Construct Startup Built In Test.
2019-06-13T21:21:32.925Z,1560460892.925 [SBIT] Loaded
2019-06-13T21:21:32.925Z,1560460892.925 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2019-06-13T21:21:32.926Z,1560460892.926 [IBIT](DEBUG): Construct Initiated Built In Test.
2019-06-13T21:21:32.938Z,1560460892.938 [IBIT] Loaded
2019-06-13T21:21:32.938Z,1560460892.938 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2019-06-13T21:21:32.941Z,1560460892.941 [CBIT](DEBUG): Construct Continuous Built In Test.
2019-06-13T21:21:33.079Z,1560460893.079 [CBIT] Loaded
2019-06-13T21:21:33.080Z,1560460893.080 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2019-06-13T21:21:33.080Z,1560460893.080 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2019-06-13T21:21:33.081Z,1560460893.081 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2019-06-13T21:21:33.157Z,1560460893.157 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2019-06-13T21:21:33.165Z,1560460893.165 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2019-06-13T21:21:33.166Z,1560460893.166 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2019-06-13T21:21:33.177Z,1560460893.177 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2019-06-13T21:21:33.178Z,1560460893.178 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B034E0
2019-06-13T21:21:33.178Z,1560460893.178 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7947
2019-06-13T21:21:33.183Z,1560460893.183 [Supervisor](INFO): Main Thread ID is 7858
2019-06-13T21:21:33.183Z,1560460893.183 [Supervisor](DEBUG): Running supervisor.
2019-06-13T21:21:33.184Z,1560460893.184 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7948
2019-06-13T21:21:33.187Z,1560460893.187 [controlThread ThreadHandler](INFO): Handler Thread ID is 7949
2019-06-13T21:21:33.187Z,1560460893.187 [controlThread](DEBUG): Initializing ControlThread
2019-06-13T21:21:33.188Z,1560460893.188 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-06-13T21:21:33.189Z,1560460893.189 [NavChart](DEBUG): Initialize NavChart Navigation.
2019-06-13T21:21:33.189Z,1560460893.189 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2019-06-13T21:21:33.190Z,1560460893.190 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2019-06-13T21:21:33.191Z,1560460893.191 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2019-06-13T21:21:33.192Z,1560460893.192 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2019-06-13T21:21:33.192Z,1560460893.192 [LoopControl](DEBUG): Initialize LoopControlComponent.
2019-06-13T21:21:33.193Z,1560460893.193 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2019-06-13T21:21:33.193Z,1560460893.193 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2019-06-13T21:21:33.194Z,1560460893.194 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2019-06-13T21:21:33.194Z,1560460893.194 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2019-06-13T21:21:33.195Z,1560460893.195 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2019-06-13T21:21:33.195Z,1560460893.195 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2019-06-13T21:21:33.203Z,1560460893.203 [SBIT](INFO): Initialize SBIT Component.
2019-06-13T21:21:33.203Z,1560460893.203 [SBIT](IMPORTANT): git: 2019-05-01-10-gcab12ce
2019-06-13T21:21:33.204Z,1560460893.204 [SBIT](INFO): git hash: cab12ce958be6da2bb158d8a74bde728d70637cd
2019-06-13T21:21:33.204Z,1560460893.204 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2019-06-13T21:21:33.205Z,1560460893.205 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019
2019-06-13T21:21:33.206Z,1560460893.206 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2019-06-13T21:21:33.207Z,1560460893.207 [IBIT](INFO): Initialize IBIT Component.
2019-06-13T21:21:33.208Z,1560460893.208 [CBIT](DEBUG): Initialize CBIT Component.
2019-06-13T21:21:33.209Z,1560460893.209 [logger ThreadHandler](INFO): Handler Thread ID is 7950
2019-06-13T21:21:33.221Z,1560460893.221 [CBIT](DEBUG): Initialized mux pins.
2019-06-13T21:21:33.221Z,1560460893.221 [CBIT](DEBUG): Initializing the watchdog timer.
2019-06-13T21:21:33.229Z,1560460893.229 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 7951
2019-06-13T21:21:33.241Z,1560460893.241 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7952
2019-06-13T21:21:33.242Z,1560460893.242 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-06-13T21:21:33.245Z,1560460893.245 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2019-06-13T21:21:33.245Z,1560460893.245 [CBIT](DEBUG): Initializing heartbeat.
2019-06-13T21:21:33.246Z,1560460893.246 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-06-13T21:21:33.247Z,1560460893.247 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7954
2019-06-13T21:21:33.248Z,1560460893.248 [WetLabsBB2FL](INFO): Powering down
2019-06-13T21:21:33.276Z,1560460893.276 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 7955
2019-06-13T21:21:33.277Z,1560460893.277 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2019-06-13T21:21:33.297Z,1560460893.297 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7956
2019-06-13T21:21:33.309Z,1560460893.309 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7957
2019-06-13T21:21:33.312Z,1560460893.312 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2019-06-13T21:21:33.313Z,1560460893.313 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2019-06-13T21:21:33.313Z,1560460893.313 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2019-06-13T21:21:33.313Z,1560460893.313 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2019-06-13T21:21:33.313Z,1560460893.313 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2019-06-13T21:21:33.313Z,1560460893.313 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2019-06-13T21:21:33.314Z,1560460893.314 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2019-06-13T21:21:33.314Z,1560460893.314 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2019-06-13T21:21:33.314Z,1560460893.314 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2019-06-13T21:21:33.314Z,1560460893.314 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2019-06-13T21:21:33.314Z,1560460893.314 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2019-06-13T21:21:33.314Z,1560460893.314 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2019-06-13T21:21:33.315Z,1560460893.315 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2019-06-13T21:21:33.315Z,1560460893.315 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2019-06-13T21:21:33.315Z,1560460893.315 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2019-06-13T21:21:33.315Z,1560460893.315 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2019-06-13T21:21:33.317Z,1560460893.317 [CBIT](DEBUG): Deactivating GF circuits.
2019-06-13T21:21:33.317Z,1560460893.317 [CBIT](DEBUG): Deactivating emergency mode.
2019-06-13T21:21:33.353Z,1560460893.353 [CBIT](DEBUG): Backplane powered.
2019-06-13T21:21:33.354Z,1560460893.354 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2019-06-13T21:21:33.363Z,1560460893.363 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2019-06-13T21:21:33.374Z,1560460893.374 [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-06-13T21:21:33.375Z,1560460893.375 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2019-06-13T21:21:33.439Z,1560460893.439 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2019-06-13T21:21:33.440Z,1560460893.440 [Default:A.Wait](DEBUG): Construct Wait.
2019-06-13T21:21:33.477Z,1560460893.477 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2019-06-13T21:21:33.488Z,1560460893.488 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2019-06-13T21:21:33.490Z,1560460893.490 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2019-06-13T21:21:33.505Z,1560460893.505 [Default:E.Execute](DEBUG): Construct Execute.
2019-06-13T21:21:33.508Z,1560460893.508 [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-06-13T21:21:33.534Z,1560460893.534 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,Depth_Keller,DropWeight,NAL9602,Onboard,BPC1,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2019-06-13T21:21:33.543Z,1560460893.543 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-06-13T21:21:33.579Z,1560460893.579 [Depth_Keller](ERROR): Pressure reading out of range: 1628.471313 decibar
2019-06-13T21:21:33.639Z,1560460893.639 [DepthRateCalculator](ERROR): Depth measurement is not active
2019-06-13T21:21:33.652Z,1560460893.652 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2019-06-13T21:21:33.661Z,1560460893.661 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2019-06-13T21:21:33.662Z,1560460893.662 [ElevatorServo](DEBUG): Initializing EZServoServo.
2019-06-13T21:21:33.669Z,1560460893.669 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2019-06-13T21:21:33.670Z,1560460893.670 [MassServo](DEBUG): Initializing EZServoServo.
2019-06-13T21:21:33.690Z,1560460893.690 [MassServo](DEBUG): Initializing MassServo.
2019-06-13T21:21:33.691Z,1560460893.691 [RudderServo](DEBUG): Initializing EZServoServo.
2019-06-13T21:21:33.697Z,1560460893.697 [RudderServo](DEBUG): Initializing RudderServo.
2019-06-13T21:21:33.698Z,1560460893.698 [ThrusterServo](DEBUG): Initializing EZServoServo.
2019-06-13T21:21:33.701Z,1560460893.701 [Radio_Surface](INFO): Powering up
2019-06-13T21:21:33.705Z,1560460893.705 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2019-06-13T21:21:33.959Z,1560460893.959 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2019-06-13T21:21:33.959Z,1560460893.959 [DropWeight] Hardware Fault, FailCount= 1
2019-06-13T21:21:33.959Z,1560460893.959 [DropWeight](ERROR): Hardware Fault
2019-06-13T21:21:33.986Z,1560460893.986 [CommandLine](FAULT): Scheduling is paused
2019-06-13T21:21:33.987Z,1560460893.987 [CBIT](INFO): Critical error at 20190613T212133
2019-06-13T21:21:33.987Z,1560460893.987 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2019-06-13T21:21:33.998Z,1560460893.998 [CBIT](ERROR): Hardware Fault in component: DropWeight
2019-06-13T21:21:33.998Z,1560460893.998 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2019-06-13T21:21:34.638Z,1560460894.638 [CBIT](INFO): Critical error at 20190613T212133
2019-06-13T21:21:36.013Z,1560460896.013 [RudderServo](INFO): EZ Servo: @
2019-06-13T21:21:36.413Z,1560460896.413 [BuoyancyServo](INFO): EZ Servo: @
2019-06-13T21:21:36.441Z,1560460896.441 [ElevatorServo](INFO): EZ Servo: @
2019-06-13T21:21:36.489Z,1560460896.489 [MassServo](INFO): EZ Servo: @
2019-06-13T21:21:36.866Z,1560460896.866 [RudderServo](INFO): EZ Servo: `8162
2019-06-13T21:21:36.902Z,1560460896.902 [RudderServo](INFO): EZ Servo: @
2019-06-13T21:21:37.245Z,1560460897.245 [BuoyancyServo](INFO): EZ Servo: `8734
2019-06-13T21:21:37.293Z,1560460897.293 [BuoyancyServo](INFO): EZ Servo: @
2019-06-13T21:21:37.321Z,1560460897.321 [MassServo](INFO): EZ Servo: @11
2019-06-13T21:21:37.901Z,1560460897.901 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:37.981Z,1560460897.981 [BuoyancyServo](INFO): EZ Servo: @8735
2019-06-13T21:21:38.009Z,1560460898.009 [MassServo](INFO): EZ Servo: @1
2019-06-13T21:21:38.501Z,1560460898.501 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:38.553Z,1560460898.553 [BuoyancyServo](INFO): EZ Servo: @8687
2019-06-13T21:21:38.581Z,1560460898.581 [MassServo](INFO): EZ Servo: @1
2019-06-13T21:21:38.917Z,1560460898.917 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:38.969Z,1560460898.969 [BuoyancyServo](INFO): EZ Servo: @8687
2019-06-13T21:21:38.997Z,1560460898.997 [MassServo](INFO): EZ Servo: @1
2019-06-13T21:21:39.333Z,1560460899.333 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:39.437Z,1560460899.437 [BuoyancyServo](INFO): EZ Servo: @8686
2019-06-13T21:21:39.465Z,1560460899.465 [MassServo](INFO): EZ Servo: `25
2019-06-13T21:21:39.501Z,1560460899.501 [MassServo](INFO): EZ Servo: `25
2019-06-13T21:21:39.537Z,1560460899.537 [MassServo](INFO): EZ Servo: @
2019-06-13T21:21:39.873Z,1560460899.873 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:39.925Z,1560460899.925 [BuoyancyServo](INFO): EZ Servo: @8674
2019-06-13T21:21:39.965Z,1560460899.965 [MassServo](INFO): EZ Servo: @2164
2019-06-13T21:21:40.293Z,1560460900.293 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:40.405Z,1560460900.405 [MassServo](INFO): EZ Servo: @5925
2019-06-13T21:21:40.733Z,1560460900.733 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:40.797Z,1560460900.797 [MassServo](INFO): EZ Servo: @9274
2019-06-13T21:21:41.145Z,1560460901.145 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:41.209Z,1560460901.209 [MassServo](INFO): EZ Servo: @12795
2019-06-13T21:21:41.549Z,1560460901.549 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:41.641Z,1560460901.641 [MassServo](INFO): EZ Servo: @16481
2019-06-13T21:21:41.977Z,1560460901.977 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:42.217Z,1560460902.217 [MassServo](INFO): EZ Servo: @214
2019-06-13T21:21:42.553Z,1560460902.553 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:43.053Z,1560460903.053 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:43.453Z,1560460903.453 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:43.857Z,1560460903.857 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:44.249Z,1560460904.249 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:44.665Z,1560460904.665 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:44.803Z,1560460904.803 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004773
2019-06-13T21:21:45.069Z,1560460905.069 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:45.473Z,1560460905.473 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:45.877Z,1560460905.877 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:46.281Z,1560460906.281 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:46.293Z,1560460906.293 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-06-13T21:21:46.293Z,1560460906.293 [CTD_Seabird] Communications Fault, FailCount= 1
2019-06-13T21:21:46.293Z,1560460906.293 [CTD_Seabird](ERROR): Communications Fault
2019-06-13T21:21:46.321Z,1560460906.321 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-06-13T21:21:46.685Z,1560460906.685 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:46.685Z,1560460906.685 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-06-13T21:21:46.685Z,1560460906.685 [AHRS_M2] Communications Fault, FailCount= 1
2019-06-13T21:21:46.685Z,1560460906.685 [AHRS_M2](ERROR): Communications Fault
2019-06-13T21:21:46.697Z,1560460906.697 [CTD_Seabird](INFO): Powering down
2019-06-13T21:21:46.758Z,1560460906.758 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-06-13T21:21:46.771Z,1560460906.771 [AHRS_M2](INFO): Powering down
2019-06-13T21:21:47.605Z,1560460907.605 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-06-13T21:21:47.605Z,1560460907.605 [AHRS_M2] No Fault, FailCount= 1
2019-06-13T21:21:47.973Z,1560460907.973 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-06-13T21:21:48.033Z,1560460908.033 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-06-13T21:21:48.034Z,1560460908.034 [CTD_Seabird] No Fault, FailCount= 1
2019-06-13T21:21:48.057Z,1560460908.057 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-06-13T21:21:48.058Z,1560460908.058 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-06-13T21:21:51.517Z,1560460911.517 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:51.933Z,1560460911.933 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:52.337Z,1560460912.337 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:52.729Z,1560460912.729 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:53.145Z,1560460913.145 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:53.549Z,1560460913.549 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:53.941Z,1560460913.941 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:54.365Z,1560460914.365 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:54.781Z,1560460914.781 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:55.185Z,1560460915.185 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:55.589Z,1560460915.589 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:55.993Z,1560460915.993 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:56.401Z,1560460916.401 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:56.805Z,1560460916.805 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:57.209Z,1560460917.209 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:57.613Z,1560460917.613 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:58.017Z,1560460918.017 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:58.413Z,1560460918.413 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:58.825Z,1560460918.825 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:59.229Z,1560460919.229 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:21:59.633Z,1560460919.633 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:00.025Z,1560460920.025 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:00.457Z,1560460920.457 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:00.865Z,1560460920.865 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:00.865Z,1560460920.865 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-06-13T21:22:00.865Z,1560460920.865 [AHRS_M2] Communications Fault, FailCount= 2
2019-06-13T21:22:00.865Z,1560460920.865 [AHRS_M2](ERROR): Communications Fault
2019-06-13T21:22:00.897Z,1560460920.897 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-06-13T21:22:00.925Z,1560460920.925 [AHRS_M2](INFO): Powering down
2019-06-13T21:22:01.133Z,1560460921.133 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-06-13T21:22:01.133Z,1560460921.133 [CTD_Seabird] Communications Fault, FailCount= 2
2019-06-13T21:22:01.133Z,1560460921.133 [CTD_Seabird](ERROR): Communications Fault
2019-06-13T21:22:01.334Z,1560460921.334 [NAL9602](INFO): Powering up NAL9602
2019-06-13T21:22:01.383Z,1560460921.383 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-06-13T21:22:01.537Z,1560460921.537 [CTD_Seabird](INFO): Powering down
2019-06-13T21:22:01.781Z,1560460921.781 [SBIT](IMPORTANT): Beginning Startup BIT
2019-06-13T21:22:01.785Z,1560460921.785 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-06-13T21:22:01.785Z,1560460921.785 [AHRS_M2] No Fault, FailCount= 2
2019-06-13T21:22:01.786Z,1560460921.786 [CBIT](IMPORTANT): Beginning ground fault scan
2019-06-13T21:22:02.137Z,1560460922.137 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-06-13T21:22:02.205Z,1560460922.205 [ElevatorServo](INFO): EZ Servo: `8191
2019-06-13T21:22:02.241Z,1560460922.241 [ElevatorServo](INFO): EZ Servo: @
2019-06-13T21:22:02.593Z,1560460922.593 [ElevatorServo](INFO): EZ Servo: @8561
2019-06-13T21:22:02.633Z,1560460922.633 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-06-13T21:22:02.633Z,1560460922.633 [CTD_Seabird] No Fault, FailCount= 2
2019-06-13T21:22:02.881Z,1560460922.881 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-06-13T21:22:02.889Z,1560460922.889 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-06-13T21:22:03.013Z,1560460923.013 [ElevatorServo](INFO): EZ Servo: @976
2019-06-13T21:22:03.401Z,1560460923.401 [ElevatorServo](INFO): EZ Servo: @1
2019-06-13T21:22:03.477Z,1560460923.477 [RudderServo](INFO): EZ Servo: `8176
2019-06-13T21:22:03.513Z,1560460923.513 [RudderServo](INFO): EZ Servo: @
2019-06-13T21:22:03.813Z,1560460923.813 [ElevatorServo](INFO): EZ Servo: @12178
2019-06-13T21:22:04.161Z,1560460924.161 [MassServo](INFO): EZ Servo: `214
2019-06-13T21:22:04.197Z,1560460924.197 [MassServo](INFO): EZ Servo: @
2019-06-13T21:22:04.225Z,1560460924.225 [RudderServo](INFO): EZ Servo: @9537
2019-06-13T21:22:04.345Z,1560460924.345 [ElevatorServo](INFO): EZ Servo: @1382
2019-06-13T21:22:04.385Z,1560460924.385 [MassServo](INFO): EZ Servo: @22768
2019-06-13T21:22:04.409Z,1560460924.409 [RudderServo](INFO): EZ Servo: @1
2019-06-13T21:22:04.729Z,1560460924.729 [ElevatorServo](INFO): EZ Servo: @14831
2019-06-13T21:22:04.765Z,1560460924.765 [MassServo](INFO): EZ Servo: @26
2019-06-13T21:22:04.793Z,1560460924.793 [RudderServo](INFO): EZ Servo: @11264
2019-06-13T21:22:05.105Z,1560460925.105 [ElevatorServo](INFO): EZ Servo: `15
2019-06-13T21:22:05.141Z,1560460925.141 [ElevatorServo](INFO): EZ Servo: @
2019-06-13T21:22:05.177Z,1560460925.177 [MassServo](INFO): EZ Servo: @29562
2019-06-13T21:22:05.201Z,1560460925.201 [RudderServo](INFO): EZ Servo: @12524
2019-06-13T21:22:05.769Z,1560460925.769 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:05.953Z,1560460925.953 [MassServo](INFO): EZ Servo: @36192
2019-06-13T21:22:05.981Z,1560460925.981 [RudderServo](INFO): EZ Servo: @1476
2019-06-13T21:22:06.397Z,1560460926.397 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:06.474Z,1560460926.474 [MassServo](INFO): EZ Servo: @4
2019-06-13T21:22:06.501Z,1560460926.501 [RudderServo](INFO): EZ Servo: `15
2019-06-13T21:22:06.537Z,1560460926.537 [RudderServo](INFO): EZ Servo: @
2019-06-13T21:22:06.881Z,1560460926.881 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:06.949Z,1560460926.949 [MassServo](INFO): EZ Servo: @447
2019-06-13T21:22:07.485Z,1560460927.485 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:07.565Z,1560460927.565 [MassServo](INFO): EZ Servo: @49967
2019-06-13T21:22:07.893Z,1560460927.893 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:07.969Z,1560460927.969 [MassServo](INFO): EZ Servo: @53419
2019-06-13T21:22:08.297Z,1560460928.297 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:08.381Z,1560460928.381 [MassServo](INFO): EZ Servo: @56938
2019-06-13T21:22:08.717Z,1560460928.717 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:08.809Z,1560460928.809 [MassServo](INFO): EZ Servo: @6
2019-06-13T21:22:09.245Z,1560460929.245 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:09.321Z,1560460929.321 [MassServo](INFO): EZ Servo: @64971
2019-06-13T21:22:09.649Z,1560460929.649 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:09.745Z,1560460929.745 [MassServo](INFO): EZ Servo: @68597
2019-06-13T21:22:10.073Z,1560460930.073 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:10.157Z,1560460930.157 [MassServo](INFO): EZ Servo: @72115
2019-06-13T21:22:10.585Z,1560460930.585 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:10.669Z,1560460930.669 [MassServo](INFO): EZ Servo: @7649
2019-06-13T21:22:11.005Z,1560460931.005 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:11.097Z,1560460931.097 [MassServo](INFO): EZ Servo: @8
2019-06-13T21:22:11.429Z,1560460931.429 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:11.505Z,1560460931.505 [MassServo](INFO): EZ Servo: @83633
2019-06-13T21:22:11.921Z,1560460931.921 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:12.013Z,1560460932.013 [MassServo](INFO): EZ Servo: @87971
2019-06-13T21:22:12.349Z,1560460932.349 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:12.354Z,1560460932.354 [NAL9602](INFO): NAL9602 initialized
2019-06-13T21:22:12.453Z,1560460932.453 [MassServo](INFO): EZ Servo: @91734
2019-06-13T21:22:12.785Z,1560460932.785 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:12.909Z,1560460932.909 [MassServo](INFO): EZ Servo: @9563
2019-06-13T21:22:13.333Z,1560460933.333 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:13.349Z,1560460933.349 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:22:13.445Z,1560460933.445 [MassServo](INFO): EZ Servo: @1
2019-06-13T21:22:13.465Z,1560460933.465 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.008088
CHAN A1 (24V): 0.001959
CHAN A2 (12V): -0.005314
CHAN A3 (5V): -0.002867
CHAN B0 (3.3V): -0.001551
CHAN B1 (3.15aV): -0.001532
CHAN B2 (3.15bV): -0.001482
CHAN B3 (GND): -0.000645
OPEN: -0.001463
Full Scale Calc: 4.765 mA, -1.589 mA
2019-06-13T21:22:13.805Z,1560460933.805 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:13.901Z,1560460933.901 [MassServo](INFO): EZ Servo: @1
2019-06-13T21:22:14.229Z,1560460934.229 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:14.353Z,1560460934.353 [MassServo](INFO): EZ Servo: @1
2019-06-13T21:22:14.689Z,1560460934.689 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:14.765Z,1560460934.765 [MassServo](INFO): EZ Servo: `1
2019-06-13T21:22:15.133Z,1560460935.133 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:15.133Z,1560460935.133 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-06-13T21:22:15.133Z,1560460935.133 [AHRS_M2] Communications Fault, FailCount= 3
2019-06-13T21:22:15.133Z,1560460935.133 [AHRS_M2](ERROR): Communications Fault
2019-06-13T21:22:15.290Z,1560460935.290 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-06-13T21:22:15.310Z,1560460935.310 [AHRS_M2](INFO): Powering down
2019-06-13T21:22:15.933Z,1560460935.933 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-06-13T21:22:15.933Z,1560460935.933 [CTD_Seabird] Communications Fault, FailCount= 3
2019-06-13T21:22:15.933Z,1560460935.933 [CTD_Seabird](ERROR): Communications Fault
2019-06-13T21:22:16.174Z,1560460936.174 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-06-13T21:22:16.174Z,1560460936.174 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-06-13T21:22:16.174Z,1560460936.174 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-06-13T21:22:16.174Z,1560460936.174 [AHRS_M2] No Fault, FailCount= 3
2019-06-13T21:22:16.337Z,1560460936.337 [CTD_Seabird](INFO): Powering down
2019-06-13T21:22:16.505Z,1560460936.505 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-06-13T21:22:16.970Z,1560460936.970 [ElevatorServo](INFO): EZ Servo: `14993
2019-06-13T21:22:17.005Z,1560460937.005 [ElevatorServo](INFO): EZ Servo: @
2019-06-13T21:22:17.345Z,1560460937.345 [MassServo](INFO): EZ Servo: `1
2019-06-13T21:22:17.393Z,1560460937.393 [MassServo](INFO): EZ Servo: @
2019-06-13T21:22:17.417Z,1560460937.417 [RudderServo](INFO): EZ Servo: `15
2019-06-13T21:22:17.453Z,1560460937.453 [RudderServo](INFO): EZ Servo: @
2019-06-13T21:22:17.573Z,1560460937.573 [ElevatorServo](INFO): EZ Servo: @14
2019-06-13T21:22:17.613Z,1560460937.613 [MassServo](INFO): EZ Servo: @1
2019-06-13T21:22:17.641Z,1560460937.641 [RudderServo](INFO): EZ Servo: @1491
2019-06-13T21:22:17.929Z,1560460937.929 [ElevatorServo](INFO): EZ Servo: @12959
2019-06-13T21:22:17.965Z,1560460937.965 [MassServo](INFO): EZ Servo: @1
2019-06-13T21:22:17.993Z,1560460937.993 [RudderServo](INFO): EZ Servo: @14167
2019-06-13T21:22:18.329Z,1560460938.329 [ElevatorServo](INFO): EZ Servo: @11737
2019-06-13T21:22:18.365Z,1560460938.365 [MassServo](INFO): EZ Servo: @1
2019-06-13T21:22:18.393Z,1560460938.393 [RudderServo](INFO): EZ Servo: @12943
2019-06-13T21:22:18.738Z,1560460938.738 [ElevatorServo](INFO): EZ Servo: @1
2019-06-13T21:22:18.777Z,1560460938.777 [MassServo](INFO): EZ Servo: @9734
2019-06-13T21:22:18.801Z,1560460938.801 [RudderServo](INFO): EZ Servo: @11685
2019-06-13T21:22:19.137Z,1560460939.137 [ElevatorServo](INFO): EZ Servo: @928
2019-06-13T21:22:19.173Z,1560460939.173 [MassServo](INFO): EZ Servo: @93956
2019-06-13T21:22:19.197Z,1560460939.197 [RudderServo](INFO): EZ Servo: @1
2019-06-13T21:22:19.537Z,1560460939.537 [ElevatorServo](INFO): EZ Servo: @8
2019-06-13T21:22:19.577Z,1560460939.577 [MassServo](INFO): EZ Servo: @9
2019-06-13T21:22:19.602Z,1560460939.602 [RudderServo](INFO): EZ Servo: @9248
2019-06-13T21:22:20.209Z,1560460940.209 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:20.273Z,1560460940.273 [ElevatorServo](INFO): EZ Servo: @58
2019-06-13T21:22:20.309Z,1560460940.309 [MassServo](INFO): EZ Servo: @8425
2019-06-13T21:22:20.334Z,1560460940.334 [RudderServo](INFO): EZ Servo: @7
2019-06-13T21:22:20.669Z,1560460940.669 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:20.745Z,1560460940.745 [ElevatorServo](INFO): EZ Servo: @4369
2019-06-13T21:22:20.781Z,1560460940.781 [MassServo](INFO): EZ Servo: @8
2019-06-13T21:22:20.805Z,1560460940.805 [RudderServo](INFO): EZ Servo: @5584
2019-06-13T21:22:21.169Z,1560460941.169 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:21.241Z,1560460941.241 [ElevatorServo](INFO): EZ Servo: @2848
2019-06-13T21:22:21.281Z,1560460941.281 [MassServo](INFO): EZ Servo: @75966
2019-06-13T21:22:21.305Z,1560460941.305 [RudderServo](INFO): EZ Servo: @4
2019-06-13T21:22:21.641Z,1560460941.641 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:21.705Z,1560460941.705 [ElevatorServo](INFO): EZ Servo: @1599
2019-06-13T21:22:21.741Z,1560460941.741 [MassServo](INFO): EZ Servo: @72
2019-06-13T21:22:21.765Z,1560460941.765 [RudderServo](INFO): EZ Servo: @264
2019-06-13T21:22:22.093Z,1560460942.093 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:22.157Z,1560460942.157 [ElevatorServo](INFO): EZ Servo: `1344
2019-06-13T21:22:22.201Z,1560460942.201 [ElevatorServo](INFO): EZ Servo: @
2019-06-13T21:22:22.237Z,1560460942.237 [MassServo](INFO): EZ Servo: @67773
2019-06-13T21:22:22.261Z,1560460942.261 [RudderServo](INFO): EZ Servo: @1455
2019-06-13T21:22:22.617Z,1560460942.617 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:22.805Z,1560460942.805 [MassServo](INFO): EZ Servo: @62921
2019-06-13T21:22:22.833Z,1560460942.833 [RudderServo](INFO): EZ Servo: `1359
2019-06-13T21:22:22.869Z,1560460942.869 [RudderServo](INFO): EZ Servo: @
2019-06-13T21:22:23.201Z,1560460943.201 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:23.277Z,1560460943.277 [MassServo](INFO): EZ Servo: @58887
2019-06-13T21:22:23.733Z,1560460943.733 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:23.801Z,1560460943.801 [MassServo](INFO): EZ Servo: @54411
2019-06-13T21:22:24.129Z,1560460944.129 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:24.209Z,1560460944.209 [MassServo](INFO): EZ Servo: @5
2019-06-13T21:22:24.541Z,1560460944.541 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:24.617Z,1560460944.617 [MassServo](INFO): EZ Servo: @47436
2019-06-13T21:22:24.945Z,1560460944.945 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:25.029Z,1560460945.029 [MassServo](INFO): EZ Servo: @43918
2019-06-13T21:22:25.365Z,1560460945.365 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:25.453Z,1560460945.453 [MassServo](INFO): EZ Servo: @4
2019-06-13T21:22:25.789Z,1560460945.789 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:25.885Z,1560460945.885 [MassServo](INFO): EZ Servo: @366
2019-06-13T21:22:26.233Z,1560460946.233 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:26.313Z,1560460946.313 [MassServo](INFO): EZ Servo: @32947
2019-06-13T21:22:26.649Z,1560460946.649 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:26.729Z,1560460946.729 [MassServo](INFO): EZ Servo: @2939
2019-06-13T21:22:27.065Z,1560460947.065 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:27.141Z,1560460947.141 [MassServo](INFO): EZ Servo: @25869
2019-06-13T21:22:27.481Z,1560460947.481 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:27.549Z,1560460947.549 [MassServo](INFO): EZ Servo: @22385
2019-06-13T21:22:27.917Z,1560460947.917 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:28.006Z,1560460948.006 [MassServo](INFO): EZ Servo: @18623
2019-06-13T21:22:28.341Z,1560460948.341 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:28.421Z,1560460948.421 [MassServo](INFO): EZ Servo: @15
2019-06-13T21:22:28.761Z,1560460948.761 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:28.837Z,1560460948.837 [MassServo](INFO): EZ Servo: @11448
2019-06-13T21:22:29.169Z,1560460949.169 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:29.237Z,1560460949.237 [MassServo](INFO): EZ Servo: @7961
2019-06-13T21:22:29.589Z,1560460949.589 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:29.589Z,1560460949.589 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-06-13T21:22:29.589Z,1560460949.589 [AHRS_M2] Communications Fault, FailCount= 4
2019-06-13T21:22:29.589Z,1560460949.589 [AHRS_M2](ERROR): Communications Fault
2019-06-13T21:22:29.667Z,1560460949.667 [MassServo](INFO): EZ Servo: @4373
2019-06-13T21:22:29.679Z,1560460949.679 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-06-13T21:22:29.693Z,1560460949.693 [AHRS_M2](INFO): Powering down
2019-06-13T21:22:29.825Z,1560460949.825 [MassServo](INFO): EZ Servo: @2937
2019-06-13T21:22:30.149Z,1560460950.149 [MassServo](INFO): EZ Servo: @171
2019-06-13T21:22:30.573Z,1560460950.573 [MassServo](INFO): EZ Servo: @-3422
2019-06-13T21:22:30.578Z,1560460950.578 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-06-13T21:22:30.578Z,1560460950.578 [AHRS_M2] No Fault, FailCount= 4
2019-06-13T21:22:30.893Z,1560460950.893 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-06-13T21:22:30.977Z,1560460950.977 [MassServo](INFO): EZ Servo: @-69
2019-06-13T21:22:31.381Z,1560460951.381 [MassServo](INFO): EZ Servo: @-1
2019-06-13T21:22:31.785Z,1560460951.785 [MassServo](INFO): EZ Servo: @-1381
2019-06-13T21:22:32.193Z,1560460952.193 [MassServo](INFO): EZ Servo: @-17265
2019-06-13T21:22:32.577Z,1560460952.577 [MassServo](INFO): EZ Servo: @-2
2019-06-13T21:22:32.998Z,1560460952.998 [MassServo](INFO): EZ Servo: `-218
2019-06-13T21:22:34.449Z,1560460954.449 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:34.845Z,1560460954.845 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:35.249Z,1560460955.249 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:35.653Z,1560460955.653 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:36.057Z,1560460956.057 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:36.469Z,1560460956.469 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:36.877Z,1560460956.877 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:37.281Z,1560460957.281 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:37.693Z,1560460957.693 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:38.077Z,1560460958.077 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:38.481Z,1560460958.481 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:38.885Z,1560460958.885 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:39.289Z,1560460959.289 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:39.701Z,1560460959.701 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:40.105Z,1560460960.105 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:40.509Z,1560460960.509 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:40.937Z,1560460960.937 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:41.349Z,1560460961.349 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:41.757Z,1560460961.757 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:42.185Z,1560460962.185 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:42.589Z,1560460962.589 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:43.009Z,1560460963.009 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:43.381Z,1560460963.381 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:43.785Z,1560460963.785 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:22:43.785Z,1560460963.785 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-06-13T21:22:43.785Z,1560460963.785 [AHRS_M2] Communications Fault, FailCount= 5
2019-06-13T21:22:43.785Z,1560460963.785 [AHRS_M2](ERROR): Communications Fault
2019-06-13T21:22:43.873Z,1560460963.873 [ElevatorServo](INFO): EZ Servo: `1375
2019-06-13T21:22:43.922Z,1560460963.922 [ElevatorServo](INFO): EZ Servo: @
2019-06-13T21:22:43.985Z,1560460963.985 [RudderServo](INFO): EZ Servo: `136
2019-06-13T21:22:44.025Z,1560460964.025 [RudderServo](INFO): EZ Servo: @
2019-06-13T21:22:44.030Z,1560460964.030 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-06-13T21:22:44.031Z,1560460964.031 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2
2019-06-13T21:22:44.037Z,1560460964.037 [AHRS_M2](INFO): Powering down
2019-06-13T21:22:44.213Z,1560460964.213 [ElevatorServo](INFO): EZ Servo: @1647
2019-06-13T21:22:44.553Z,1560460964.553 [MassServo](INFO): EZ Servo: `-218
2019-06-13T21:22:44.589Z,1560460964.589 [MassServo](INFO): EZ Servo: @
2019-06-13T21:22:44.617Z,1560460964.617 [RudderServo](INFO): EZ Servo: @2384
2019-06-13T21:22:44.619Z,1560460964.619 [CBIT](INFO): Critical error at 20190613T212244
2019-06-13T21:22:44.761Z,1560460964.761 [ElevatorServo](INFO): EZ Servo: @3184
2019-06-13T21:22:44.797Z,1560460964.797 [MassServo](INFO): EZ Servo: @-2
2019-06-13T21:22:44.825Z,1560460964.825 [RudderServo](INFO): EZ Servo: @3
2019-06-13T21:22:45.129Z,1560460965.129 [ElevatorServo](INFO): EZ Servo: @4336
2019-06-13T21:22:45.165Z,1560460965.165 [MassServo](INFO): EZ Servo: @-17
2019-06-13T21:22:45.189Z,1560460965.189 [RudderServo](INFO): EZ Servo: @4116
2019-06-13T21:22:45.529Z,1560460965.529 [ElevatorServo](INFO): EZ Servo: @553
2019-06-13T21:22:45.565Z,1560460965.565 [MassServo](INFO): EZ Servo: @-13666
2019-06-13T21:22:45.593Z,1560460965.593 [RudderServo](INFO): EZ Servo: @5363
2019-06-13T21:22:45.945Z,1560460965.945 [ElevatorServo](INFO): EZ Servo: @68
2019-06-13T21:22:45.981Z,1560460965.981 [MassServo](INFO): EZ Servo: @-1
2019-06-13T21:22:46.009Z,1560460966.009 [RudderServo](INFO): EZ Servo: @6623
2019-06-13T21:22:46.361Z,1560460966.361 [ElevatorServo](INFO): EZ Servo: @7935
2019-06-13T21:22:46.397Z,1560460966.397 [MassServo](INFO): EZ Servo: @-6558
2019-06-13T21:22:46.425Z,1560460966.425 [RudderServo](INFO): EZ Servo: @7824
2019-06-13T21:22:46.757Z,1560460966.757 [ElevatorServo](INFO): EZ Servo: `8192
2019-06-13T21:22:46.793Z,1560460966.793 [ElevatorServo](INFO): EZ Servo: @
2019-06-13T21:22:46.829Z,1560460966.829 [MassServo](INFO): EZ Servo: @-2866
2019-06-13T21:22:46.877Z,1560460966.877 [RudderServo](INFO): EZ Servo: @8192
2019-06-13T21:22:47.285Z,1560460967.285 [MassServo](INFO): EZ Servo: @1
2019-06-13T21:22:47.573Z,1560460967.573 [MassServo](INFO): EZ Servo: @3421
2019-06-13T21:22:47.980Z,1560460967.980 [MassServo](INFO): EZ Servo: @6943
2019-06-13T21:22:48.365Z,1560460968.365 [MassServo](INFO): EZ Servo: @1
2019-06-13T21:22:48.773Z,1560460968.773 [MassServo](INFO): EZ Servo: @13739
2019-06-13T21:22:49.177Z,1560460969.177 [MassServo](INFO): EZ Servo: @17195
2019-06-13T21:22:49.585Z,1560460969.585 [MassServo](INFO): EZ Servo: @2
2019-06-13T21:22:49.993Z,1560460969.993 [MassServo](INFO): EZ Servo: `218
2019-06-13T21:22:56.012Z,1560460976.012 [SBIT](IMPORTANT): SBIT PASSED
2019-06-13T21:22:56.070Z,1560460976.070 [CommandLine](IMPORTANT): got command configSet list
2019-06-13T21:22:56.070Z,1560460976.070 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2019-06-13T21:22:56.071Z,1560460976.071 [CommandLine](IMPORTANT): 

2019-06-13T21:22:56.426Z,1560460976.426 [MissionManager](IMPORTANT): Started mission Startup
2019-06-13T21:22:56.426Z,1560460976.426 [Startup] Running Loop=1
2019-06-13T21:22:56.427Z,1560460976.427 [Startup](DEBUG): Aggregate::initialize Startup
2019-06-13T21:22:56.427Z,1560460976.427 [Startup:A.GoToSurface] Running Loop=1
2019-06-13T21:22:56.427Z,1560460976.427 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-06-13T21:22:56.427Z,1560460976.427 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-06-13T21:22:56.428Z,1560460976.428 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-06-13T21:22:56.428Z,1560460976.428 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-06-13T21:22:56.428Z,1560460976.428 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-06-13T21:22:56.429Z,1560460976.429 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-06-13T21:22:56.430Z,1560460976.430 [Startup:StartupSatComms] Running Loop=1
2019-06-13T21:22:56.430Z,1560460976.430 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2019-06-13T21:22:56.431Z,1560460976.431 [Startup:StartupSatComms:A] Running Loop=1
2019-06-13T21:22:56.826Z,1560460976.826 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2019-06-13T21:23:33.588Z,1560461013.588 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-06-13T21:23:33.588Z,1560461013.588 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1
2019-06-13T21:23:33.588Z,1560461013.588 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-06-13T21:23:33.589Z,1560461013.589 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-06-13T21:23:33.589Z,1560461013.589 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2019-06-13T21:23:33.589Z,1560461013.589 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-06-13T21:23:33.600Z,1560461013.600 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-06-13T21:23:33.600Z,1560461013.600 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-06-13T21:23:34.009Z,1560461014.009 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-06-13T21:23:34.009Z,1560461014.009 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1
2019-06-13T21:23:34.010Z,1560461014.010 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-06-13T21:23:34.010Z,1560461014.010 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2019-06-13T21:23:34.511Z,1560461014.511 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-06-13T21:23:56.602Z,1560461036.602 [Startup:StartupSatComms:A](INFO): Timed out from 2019-06-13T21:22:56.4Z
2019-06-13T21:23:56.602Z,1560461036.602 [Startup:StartupSatComms:A] Stopped
2019-06-13T21:23:56.602Z,1560461036.602 [Startup:StartupSatComms:B] Running Loop=1
2019-06-13T21:23:57.034Z,1560461037.034 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-06-13T21:24:46.276Z,1560461086.276 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-06-13T21:24:46.276Z,1560461086.276 [CTD_Seabird] No Fault, FailCount= 3
2019-06-13T21:24:46.413Z,1560461086.413 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-06-13T21:24:46.415Z,1560461086.415 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-06-13T21:24:46.642Z,1560461086.642 [DataOverHttps](INFO): Sending 162 bytes from file Logs/20190613T204703/Courier0000.lzma
2019-06-13T21:24:47.442Z,1560461087.442 [DataOverHttps](INFO): Moved sent file to Logs/20190613T204703/Courier0000.lzma.bak
2019-06-13T21:24:47.443Z,1560461087.443 [DataOverHttps](INFO): SBD MOMSN=11376189
2019-06-13T21:24:56.786Z,1560461096.786 [Startup:StartupSatComms:B](INFO): Timed out from 2019-06-13T21:23:56.6Z
2019-06-13T21:24:56.786Z,1560461096.786 [Startup:StartupSatComms:B] Stopped
2019-06-13T21:24:56.786Z,1560461096.786 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2019-06-13T21:24:56.786Z,1560461096.786 [Startup:StartupSatComms] Stopped
2019-06-13T21:24:56.786Z,1560461096.786 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2019-06-13T21:24:56.787Z,1560461096.787 [Startup](INFO): Completed Startup
2019-06-13T21:24:56.787Z,1560461096.787 [MissionManager](INFO): Startup is completed.
2019-06-13T21:24:56.787Z,1560461096.787 [MissionManager](INFO): Uninitializing Mission Startup
2019-06-13T21:24:56.787Z,1560461096.787 [Startup] Stopped
2019-06-13T21:24:56.788Z,1560461096.788 [Startup](DEBUG): Aggregate::uninitialize Startup
2019-06-13T21:24:56.788Z,1560461096.788 [Startup:A.GoToSurface] Stopped
2019-06-13T21:24:56.788Z,1560461096.788 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-06-13T21:24:57.202Z,1560461097.202 [MissionManager](IMPORTANT): Started mission Default
2019-06-13T21:24:57.202Z,1560461097.202 [Default] Running Loop=1
2019-06-13T21:24:57.202Z,1560461097.202 [Default](DEBUG): Aggregate::initialize Default
2019-06-13T21:24:57.202Z,1560461097.202 [Default:B.GoToSurface] Running Loop=1
2019-06-13T21:24:57.202Z,1560461097.202 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2019-06-13T21:24:57.202Z,1560461097.202 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2019-06-13T21:24:57.203Z,1560461097.203 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2019-06-13T21:24:57.203Z,1560461097.203 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2019-06-13T21:24:57.203Z,1560461097.203 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2019-06-13T21:24:57.204Z,1560461097.204 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2019-06-13T21:24:57.204Z,1560461097.204 [Default:A.Wait] Running Loop=1
2019-06-13T21:24:57.204Z,1560461097.204 [Default:A.Wait](DEBUG): Initialize Wait Component.
2019-06-13T21:24:59.465Z,1560461099.465 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-06-13T21:24:59.465Z,1560461099.465 [CTD_Seabird] Communications Fault, FailCount= 1
2019-06-13T21:24:59.465Z,1560461099.465 [CTD_Seabird](ERROR): Communications Fault
2019-06-13T21:24:59.622Z,1560461099.622 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-06-13T21:24:59.869Z,1560461099.869 [CTD_Seabird](INFO): Powering down
2019-06-13T21:25:00.831Z,1560461100.831 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-06-13T21:25:00.831Z,1560461100.831 [CTD_Seabird] No Fault, FailCount= 1
2019-06-13T21:25:01.217Z,1560461101.217 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-06-13T21:25:01.219Z,1560461101.219 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-06-13T21:25:10.516Z,1560461110.516 [Default:A.Wait](INFO): Done Waiting.
2019-06-13T21:25:10.516Z,1560461110.516 [Default:A.Wait] Stopped
2019-06-13T21:25:10.516Z,1560461110.516 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2019-06-13T21:25:10.930Z,1560461110.930 [Default:CheckIn] Running Loop=1
2019-06-13T21:25:10.930Z,1560461110.930 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2019-06-13T21:25:10.930Z,1560461110.930 [Default:CheckIn:Read_GPS] Running Loop=1
2019-06-13T21:25:11.310Z,1560461111.310 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2019-06-13T21:25:14.269Z,1560461114.269 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-06-13T21:25:14.269Z,1560461114.269 [CTD_Seabird] Communications Fault, FailCount= 2
2019-06-13T21:25:14.269Z,1560461114.269 [CTD_Seabird](ERROR): Communications Fault
2019-06-13T21:25:14.554Z,1560461114.554 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-06-13T21:25:14.673Z,1560461114.673 [CTD_Seabird](INFO): Powering down
2019-06-13T21:25:15.839Z,1560461115.839 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-06-13T21:25:15.840Z,1560461115.840 [CTD_Seabird] No Fault, FailCount= 2
2019-06-13T21:25:16.021Z,1560461116.021 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-06-13T21:25:16.023Z,1560461116.023 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-06-13T21:25:29.073Z,1560461129.073 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-06-13T21:25:29.073Z,1560461129.073 [CTD_Seabird] Communications Fault, FailCount= 3
2019-06-13T21:25:29.073Z,1560461129.073 [CTD_Seabird](ERROR): Communications Fault
2019-06-13T21:25:29.109Z,1560461129.109 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-06-13T21:25:29.109Z,1560461129.109 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-06-13T21:25:29.477Z,1560461129.477 [CTD_Seabird](INFO): Powering down
2019-06-13T21:25:34.819Z,1560461134.819 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-06-13T21:25:34.819Z,1560461134.819 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2
2019-06-13T21:25:34.819Z,1560461134.819 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-06-13T21:25:34.820Z,1560461134.820 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-06-13T21:25:34.820Z,1560461134.820 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2019-06-13T21:25:34.820Z,1560461134.820 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-06-13T21:25:34.831Z,1560461134.831 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-06-13T21:25:34.832Z,1560461134.832 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-06-13T21:25:35.190Z,1560461135.190 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-06-13T21:25:35.190Z,1560461135.190 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2
2019-06-13T21:25:35.190Z,1560461135.190 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-06-13T21:25:35.190Z,1560461135.190 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2019-06-13T21:25:35.572Z,1560461135.572 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-06-13T21:27:15.726Z,1560461235.726 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2019-06-13T21:27:16.545Z,1560461236.545 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:27:20.989Z,1560461240.989 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:27:23.821Z,1560461243.821 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:27:27.049Z,1560461247.049 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:27:29.877Z,1560461249.877 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:27:32.705Z,1560461252.705 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:27:34.725Z,1560461254.725 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:27:35.960Z,1560461255.960 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-06-13T21:27:35.960Z,1560461255.960 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3
2019-06-13T21:27:35.960Z,1560461255.960 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-06-13T21:27:35.962Z,1560461255.962 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-06-13T21:27:35.962Z,1560461255.962 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2019-06-13T21:27:35.962Z,1560461255.962 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-06-13T21:27:35.973Z,1560461255.973 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-06-13T21:27:35.973Z,1560461255.973 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-06-13T21:27:36.373Z,1560461256.373 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-06-13T21:27:36.374Z,1560461256.374 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3
2019-06-13T21:27:36.374Z,1560461256.374 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-06-13T21:27:36.374Z,1560461256.374 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2019-06-13T21:27:36.745Z,1560461256.745 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:27:36.763Z,1560461256.763 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-06-13T21:27:39.977Z,1560461259.977 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:27:42.801Z,1560461262.801 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:27:44.035Z,1560461264.035 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-06-13T21:27:44.035Z,1560461264.035 [AHRS_M2] No Fault, FailCount= 5
2019-06-13T21:27:44.401Z,1560461264.401 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-06-13T21:27:46.037Z,1560461266.037 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:27:47.961Z,1560461267.961 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:48.353Z,1560461268.353 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:48.793Z,1560461268.793 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:48.813Z,1560461268.813 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:27:49.189Z,1560461269.189 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:49.589Z,1560461269.589 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:49.989Z,1560461269.989 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:50.397Z,1560461270.397 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:50.801Z,1560461270.801 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:51.205Z,1560461271.205 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:51.641Z,1560461271.641 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:52.053Z,1560461272.053 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:52.073Z,1560461272.073 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:27:52.453Z,1560461272.453 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:52.873Z,1560461272.873 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:53.285Z,1560461273.285 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:53.677Z,1560461273.677 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:54.073Z,1560461274.073 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:54.477Z,1560461274.477 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:54.881Z,1560461274.881 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:54.905Z,1560461274.905 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:27:55.285Z,1560461275.285 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:55.685Z,1560461275.685 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:56.097Z,1560461276.097 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:56.509Z,1560461276.509 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:56.897Z,1560461276.897 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:57.301Z,1560461277.301 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:27:57.301Z,1560461277.301 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-06-13T21:27:57.301Z,1560461277.301 [AHRS_M2] Communications Fault, FailCount= 1
2019-06-13T21:27:57.301Z,1560461277.301 [AHRS_M2](ERROR): Communications Fault
2019-06-13T21:27:57.372Z,1560461277.372 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-06-13T21:27:57.397Z,1560461277.397 [AHRS_M2](INFO): Powering down
2019-06-13T21:27:57.481Z,1560461277.481 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:27:58.247Z,1560461278.247 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-06-13T21:27:58.247Z,1560461278.247 [AHRS_M2] No Fault, FailCount= 1
2019-06-13T21:27:58.593Z,1560461278.593 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-06-13T21:27:59.451Z,1560461279.451 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-06-13T21:27:59.451Z,1560461279.451 [CTD_Seabird] No Fault, FailCount= 3
2019-06-13T21:27:59.509Z,1560461279.509 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-06-13T21:27:59.511Z,1560461279.511 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-06-13T21:27:59.829Z,1560461279.829 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:02.149Z,1560461282.149 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:02.581Z,1560461282.581 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:02.993Z,1560461282.993 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:03.013Z,1560461283.013 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:03.389Z,1560461283.389 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:03.801Z,1560461283.801 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:04.213Z,1560461284.213 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:04.633Z,1560461284.633 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:05.065Z,1560461285.065 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:05.477Z,1560461285.477 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:05.881Z,1560461285.881 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:05.901Z,1560461285.901 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:06.297Z,1560461286.297 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:06.709Z,1560461286.709 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:07.125Z,1560461287.125 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:07.501Z,1560461287.501 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:07.905Z,1560461287.905 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:08.317Z,1560461288.317 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:08.721Z,1560461288.721 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:08.741Z,1560461288.741 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:09.121Z,1560461289.121 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:09.521Z,1560461289.521 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:09.933Z,1560461289.933 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:10.357Z,1560461290.357 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:10.753Z,1560461290.753 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:10.773Z,1560461290.773 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:11.145Z,1560461291.145 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:11.545Z,1560461291.545 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:11.545Z,1560461291.545 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-06-13T21:28:11.545Z,1560461291.545 [AHRS_M2] Communications Fault, FailCount= 2
2019-06-13T21:28:11.545Z,1560461291.545 [AHRS_M2](ERROR): Communications Fault
2019-06-13T21:28:11.622Z,1560461291.622 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-06-13T21:28:11.627Z,1560461291.627 [AHRS_M2](INFO): Powering down
2019-06-13T21:28:12.474Z,1560461292.474 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-06-13T21:28:12.474Z,1560461292.474 [AHRS_M2] No Fault, FailCount= 2
2019-06-13T21:28:12.561Z,1560461292.561 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-06-13T21:28:12.561Z,1560461292.561 [CTD_Seabird] Communications Fault, FailCount= 1
2019-06-13T21:28:12.561Z,1560461292.561 [CTD_Seabird](ERROR): Communications Fault
2019-06-13T21:28:12.837Z,1560461292.837 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-06-13T21:28:12.876Z,1560461292.876 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-06-13T21:28:12.965Z,1560461292.965 [CTD_Seabird](INFO): Powering down
2019-06-13T21:28:14.069Z,1560461294.069 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:14.102Z,1560461294.102 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-06-13T21:28:14.102Z,1560461294.102 [CTD_Seabird] No Fault, FailCount= 1
2019-06-13T21:28:14.309Z,1560461294.309 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-06-13T21:28:14.311Z,1560461294.311 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-06-13T21:28:16.393Z,1560461296.393 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:16.809Z,1560461296.809 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:17.225Z,1560461297.225 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:17.245Z,1560461297.245 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:17.597Z,1560461297.597 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:17.997Z,1560461297.997 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:18.449Z,1560461298.449 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:18.837Z,1560461298.837 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:19.245Z,1560461299.245 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:19.649Z,1560461299.649 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:20.057Z,1560461300.057 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:20.077Z,1560461300.077 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:20.449Z,1560461300.449 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:20.869Z,1560461300.869 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:21.285Z,1560461301.285 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:21.673Z,1560461301.673 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:22.065Z,1560461302.065 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:22.477Z,1560461302.477 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:22.873Z,1560461302.873 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:22.889Z,1560461302.889 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:23.277Z,1560461303.277 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:23.689Z,1560461303.689 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:24.093Z,1560461304.093 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:24.497Z,1560461304.497 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:24.921Z,1560461304.921 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:25.305Z,1560461305.305 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:25.701Z,1560461305.701 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:25.701Z,1560461305.701 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-06-13T21:28:25.701Z,1560461305.701 [AHRS_M2] Communications Fault, FailCount= 3
2019-06-13T21:28:25.701Z,1560461305.701 [AHRS_M2](ERROR): Communications Fault
2019-06-13T21:28:25.721Z,1560461305.721 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:25.766Z,1560461305.766 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-06-13T21:28:25.789Z,1560461305.789 [AHRS_M2](INFO): Powering down
2019-06-13T21:28:26.635Z,1560461306.635 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-06-13T21:28:26.635Z,1560461306.635 [AHRS_M2] No Fault, FailCount= 3
2019-06-13T21:28:27.001Z,1560461307.001 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-06-13T21:28:27.361Z,1560461307.361 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-06-13T21:28:27.361Z,1560461307.361 [CTD_Seabird] Communications Fault, FailCount= 2
2019-06-13T21:28:27.361Z,1560461307.361 [CTD_Seabird](ERROR): Communications Fault
2019-06-13T21:28:27.447Z,1560461307.447 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-06-13T21:28:27.765Z,1560461307.765 [CTD_Seabird](INFO): Powering down
2019-06-13T21:28:27.829Z,1560461307.829 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:29.121Z,1560461309.121 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2019-06-13T21:28:29.121Z,1560461309.121 [CTD_Seabird] No Fault, FailCount= 2
2019-06-13T21:28:29.509Z,1560461309.509 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2019-06-13T21:28:29.510Z,1560461309.510 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2019-06-13T21:28:30.557Z,1560461310.557 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:30.961Z,1560461310.961 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:31.373Z,1560461311.373 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:31.393Z,1560461311.393 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:31.821Z,1560461311.821 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:32.229Z,1560461312.229 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:32.625Z,1560461312.625 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:33.041Z,1560461313.041 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:33.453Z,1560461313.453 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:33.849Z,1560461313.849 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:33.865Z,1560461313.865 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:34.237Z,1560461314.237 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:34.649Z,1560461314.649 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:35.049Z,1560461315.049 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:35.457Z,1560461315.457 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:35.861Z,1560461315.861 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:36.265Z,1560461316.265 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:36.677Z,1560461316.677 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:37.097Z,1560461317.097 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:37.117Z,1560461317.117 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:37.497Z,1560461317.497 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:37.877Z,1560461317.877 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:38.277Z,1560461318.277 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:38.685Z,1560461318.685 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:39.085Z,1560461319.085 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:39.501Z,1560461319.501 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:39.901Z,1560461319.901 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:39.901Z,1560461319.901 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-06-13T21:28:39.901Z,1560461319.901 [AHRS_M2] Communications Fault, FailCount= 4
2019-06-13T21:28:39.901Z,1560461319.901 [AHRS_M2](ERROR): Communications Fault
2019-06-13T21:28:39.921Z,1560461319.921 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:39.950Z,1560461319.950 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-06-13T21:28:39.994Z,1560461319.994 [AHRS_M2](INFO): Powering down
2019-06-13T21:28:40.838Z,1560461320.838 [CBIT](INFO): Clearing failed state for component AHRS_M2
2019-06-13T21:28:40.838Z,1560461320.838 [AHRS_M2] No Fault, FailCount= 4
2019-06-13T21:28:41.193Z,1560461321.193 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2019-06-13T21:28:42.025Z,1560461322.025 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:42.561Z,1560461322.561 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2019-06-13T21:28:42.561Z,1560461322.561 [CTD_Seabird] Communications Fault, FailCount= 3
2019-06-13T21:28:42.561Z,1560461322.561 [CTD_Seabird](ERROR): Communications Fault
2019-06-13T21:28:42.863Z,1560461322.863 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2019-06-13T21:28:42.863Z,1560461322.863 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2019-06-13T21:28:42.965Z,1560461322.965 [CTD_Seabird](INFO): Powering down
2019-06-13T21:28:44.741Z,1560461324.741 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:45.145Z,1560461325.145 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:45.165Z,1560461325.165 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:45.597Z,1560461325.597 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:45.997Z,1560461325.997 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:46.393Z,1560461326.393 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:46.805Z,1560461326.805 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:47.209Z,1560461327.209 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:47.613Z,1560461327.613 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:48.017Z,1560461328.017 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:48.037Z,1560461328.037 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:48.441Z,1560461328.441 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:48.873Z,1560461328.873 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:49.285Z,1560461329.285 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:49.693Z,1560461329.693 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:50.113Z,1560461330.113 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:50.525Z,1560461330.525 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:50.929Z,1560461330.929 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:50.945Z,1560461330.945 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:51.342Z,1560461331.342 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:51.761Z,1560461331.761 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:52.165Z,1560461332.165 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:52.553Z,1560461332.553 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:52.949Z,1560461332.949 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:53.345Z,1560461333.345 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:53.761Z,1560461333.761 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:53.781Z,1560461333.781 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:54.169Z,1560461334.169 [AHRS_M2](ERROR): Set Trigger UART error: serial timeout
2019-06-13T21:28:54.169Z,1560461334.169 [AHRS_M2](FAULT): Failed to initialize within timeout.
2019-06-13T21:28:54.169Z,1560461334.169 [AHRS_M2] Communications Fault, FailCount= 5
2019-06-13T21:28:54.169Z,1560461334.169 [AHRS_M2](ERROR): Communications Fault
2019-06-13T21:28:54.263Z,1560461334.263 [CBIT](ERROR): Communications Fault in component: AHRS_M2
2019-06-13T21:28:54.263Z,1560461334.263 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2
2019-06-13T21:28:54.277Z,1560461334.277 [AHRS_M2](INFO): Powering down
2019-06-13T21:28:54.409Z,1560461334.409 [CBIT](INFO): Critical error at 20190613T212854
2019-06-13T21:28:55.913Z,1560461335.913 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:28:58.729Z,1560461338.729 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:01.961Z,1560461341.961 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:02.402Z,1560461342.402 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2019-06-13T21:29:02.405Z,1560461342.405 [BPC1](INFO): Received data from all battery sticks.
2019-06-13T21:29:04.793Z,1560461344.793 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:08.021Z,1560461348.021 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:10.849Z,1560461350.849 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:14.085Z,1560461354.085 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:16.913Z,1560461356.913 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:19.737Z,1560461359.737 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:22.973Z,1560461362.973 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:25.797Z,1560461365.797 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:29.029Z,1560461369.029 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:31.857Z,1560461371.857 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:34.689Z,1560461374.689 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:36.705Z,1560461376.705 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:37.136Z,1560461377.136 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-06-13T21:29:37.136Z,1560461377.136 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4
2019-06-13T21:29:37.136Z,1560461377.136 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault
2019-06-13T21:29:37.138Z,1560461377.138 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2019-06-13T21:29:37.138Z,1560461377.138 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2019-06-13T21:29:37.138Z,1560461377.138 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2019-06-13T21:29:37.149Z,1560461377.149 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources
2019-06-13T21:29:37.149Z,1560461377.149 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2019-06-13T21:29:37.547Z,1560461377.547 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources
2019-06-13T21:29:37.547Z,1560461377.547 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4
2019-06-13T21:29:37.548Z,1560461377.548 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2019-06-13T21:29:37.548Z,1560461377.548 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2019-06-13T21:29:37.932Z,1560461377.932 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2019-06-13T21:29:38.725Z,1560461378.725 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:40.749Z,1560461380.749 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:43.977Z,1560461383.977 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:45.960Z,1560461385.960 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190613T204703/Courier0004.lzma
2019-06-13T21:29:46.766Z,1560461386.766 [DataOverHttps](INFO): Moved sent file to Logs/20190613T204703/Courier0004.lzma.bak
2019-06-13T21:29:46.766Z,1560461386.766 [DataOverHttps](INFO): SBD MOMSN=11376223
2019-06-13T21:29:46.825Z,1560461386.825 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:50.041Z,1560461390.041 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:52.869Z,1560461392.869 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:55.697Z,1560461395.697 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:57.721Z,1560461397.721 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:29:59.733Z,1560461399.733 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:30:02.969Z,1560461402.969 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:30:05.793Z,1560461405.793 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:30:09.029Z,1560461409.029 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:30:11.066Z,1560461411.066 [Default:CheckIn:Read_GPS](INFO): Timed out from 2019-06-13T21:25:10.9Z
2019-06-13T21:30:11.066Z,1560461411.066 [Default:CheckIn:Read_GPS] Stopped
2019-06-13T21:30:11.066Z,1560461411.066 [Default:CheckIn:Read_Iridium] Running Loop=1
2019-06-13T21:30:11.466Z,1560461411.466 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2019-06-13T21:30:11.873Z,1560461411.873 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:30:15.085Z,1560461415.085 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:30:17.913Z,1560461417.913 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:30:20.741Z,1560461420.741 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:30:23.973Z,1560461423.973 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:30:26.801Z,1560461426.801 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:30:29.689Z,1560461429.689 [CommandLine](IMPORTANT): got command quit
2019-06-13T21:30:30.037Z,1560461430.037 [NAL9602](DEBUG): Fix Requested
2019-06-13T21:30:30.693Z,1560461430.693 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2019-06-13T21:30:30.693Z,1560461430.693 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:30.705Z,1560461430.705 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2019-06-13T21:30:30.705Z,1560461430.705 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:30.706Z,1560461430.706 [CommandLine](INFO): Join timeout helper Thread ID is 7999
2019-06-13T21:30:30.706Z,1560461430.706 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2019-06-13T21:30:30.706Z,1560461430.706 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:30.707Z,1560461430.707 [NavChartDb](INFO): Join timeout helper Thread ID is 8000
2019-06-13T21:30:31.013Z,1560461431.013 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2019-06-13T21:30:31.013Z,1560461431.013 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:31.017Z,1560461431.017 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2019-06-13T21:30:31.017Z,1560461431.017 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:31.017Z,1560461431.017 [Radio_Surface](INFO): Join timeout helper Thread ID is 8001
2019-06-13T21:30:31.089Z,1560461431.089 [Radio_Surface](INFO): Powering down
2019-06-13T21:30:31.090Z,1560461431.090 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2019-06-13T21:30:31.090Z,1560461431.090 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:31.097Z,1560461431.097 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2019-06-13T21:30:31.097Z,1560461431.097 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:31.097Z,1560461431.097 [DataOverHttps](INFO): Join timeout helper Thread ID is 8002
2019-06-13T21:30:31.221Z,1560461431.221 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2019-06-13T21:30:31.222Z,1560461431.222 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:31.235Z,1560461431.235 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2019-06-13T21:30:31.235Z,1560461431.235 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:31.239Z,1560461431.239 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 8003
2019-06-13T21:30:31.646Z,1560461431.646 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2019-06-13T21:30:31.646Z,1560461431.646 [WetLabsBB2FL](INFO): Powering down
2019-06-13T21:30:31.647Z,1560461431.647 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:31.662Z,1560461431.662 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2019-06-13T21:30:31.662Z,1560461431.662 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:31.662Z,1560461431.662 [CTD_Seabird](INFO): Join timeout helper Thread ID is 8004
2019-06-13T21:30:31.785Z,1560461431.785 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2019-06-13T21:30:31.785Z,1560461431.785 [CTD_Seabird](INFO): Powering down
2019-06-13T21:30:31.797Z,1560461431.797 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:31.798Z,1560461431.798 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2019-06-13T21:30:31.798Z,1560461431.798 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:31.799Z,1560461431.799 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 8005
2019-06-13T21:30:31.993Z,1560461431.993 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2019-06-13T21:30:31.993Z,1560461431.993 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:31.998Z,1560461431.998 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2019-06-13T21:30:31.998Z,1560461431.998 [logger ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:31.998Z,1560461431.998 [logger](INFO): Join timeout helper Thread ID is 8006
2019-06-13T21:30:32.050Z,1560461432.050 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2019-06-13T21:30:32.050Z,1560461432.050 [logger ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:32.058Z,1560461432.058 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2019-06-13T21:30:32.058Z,1560461432.058 [CommandLine ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:32.058Z,1560461432.058 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2019-06-13T21:30:32.058Z,1560461432.058 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:32.059Z,1560461432.059 [controlThread](INFO): Join timeout helper Thread ID is 8007
2019-06-13T21:30:32.075Z,1560461432.075 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2019-06-13T21:30:32.075Z,1560461432.075 [controlThread](DEBUG): Uninitializing ControlThread
2019-06-13T21:30:32.076Z,1560461432.076 [AHRS_M2](INFO): Powering down
2019-06-13T21:30:32.077Z,1560461432.077 [NAL9602](INFO): Powering down
2019-06-13T21:30:32.079Z,1560461432.079 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2019-06-13T21:30:32.080Z,1560461432.080 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2019-06-13T21:30:32.080Z,1560461432.080 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2019-06-13T21:30:32.081Z,1560461432.081 [MissionManager](INFO): Uninitializing Mission Default
2019-06-13T21:30:32.081Z,1560461432.081 [Default] Stopped
2019-06-13T21:30:32.081Z,1560461432.081 [Default](DEBUG): Aggregate::uninitialize Default
2019-06-13T21:30:32.081Z,1560461432.081 [Default:B.GoToSurface] Stopped
2019-06-13T21:30:32.081Z,1560461432.081 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2019-06-13T21:30:32.081Z,1560461432.081 [Default:CheckIn] Stopped
2019-06-13T21:30:32.082Z,1560461432.082 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2019-06-13T21:30:32.082Z,1560461432.082 [Default:CheckIn:Read_Iridium] Stopped
2019-06-13T21:30:32.084Z,1560461432.084 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2019-06-13T21:30:32.084Z,1560461432.084 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2019-06-13T21:30:32.084Z,1560461432.084 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2019-06-13T21:30:32.085Z,1560461432.085 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2019-06-13T21:30:32.085Z,1560461432.085 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2019-06-13T21:30:32.085Z,1560461432.085 [BuoyancyServo](INFO): Powering down
2019-06-13T21:30:32.097Z,1560461432.097 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2019-06-13T21:30:32.097Z,1560461432.097 [ElevatorServo](INFO): Powering down
2019-06-13T21:30:32.098Z,1560461432.098 [MassServo](DEBUG): Uninitialize Mass Servo.
2019-06-13T21:30:32.098Z,1560461432.098 [MassServo](INFO): Powering down
2019-06-13T21:30:32.099Z,1560461432.099 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2019-06-13T21:30:32.099Z,1560461432.099 [RudderServo](INFO): Powering down
2019-06-13T21:30:32.099Z,1560461432.099 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2019-06-13T21:30:32.099Z,1560461432.099 [ThrusterServo](INFO): Powering down
2019-06-13T21:30:32.100Z,1560461432.100 [SBIT](DEBUG): Uninitialize SBIT Component.
2019-06-13T21:30:32.100Z,1560461432.100 [IBIT](DEBUG): Uninitialize IBIT Component.
2019-06-13T21:30:32.101Z,1560461432.101 [CBIT](DEBUG): Uninitialize CBIT Component.
2019-06-13T21:30:32.101Z,1560461432.101 [CBIT](DEBUG): Powering off loads.
2019-06-13T21:30:32.113Z,1560461432.113 [CBIT](DEBUG): Disabling WDT.
2019-06-13T21:30:32.125Z,1560461432.125 [CBIT](DEBUG): Opening all GF detection circuits.
2019-06-13T21:30:32.126Z,1560461432.126 [controlThread ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:32.159Z,1560461432.159 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:32.162Z,1560461432.162 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:32.166Z,1560461432.166 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:32.241Z,1560461432.241 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:32.245Z,1560461432.245 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:32.284Z,1560461432.284 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2019-06-13T21:30:32.339Z,1560461432.339 [logger ThreadHandler](INFO): Thread cancelled.