2019-07-22T21:53:19.578Z,1563832399.578 [Supervisor](DEBUG): Initializing supervisor. 2019-07-22T21:53:19.581Z,1563832399.581 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2019-07-22T21:53:19.582Z,1563832399.582 [SyncHandler](INFO): Protected caller Thread ID is 5097 2019-07-22T21:53:19.582Z,1563832399.582 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2019-07-22T21:53:19.583Z,1563832399.583 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2019-07-22T21:53:19.583Z,1563832399.583 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 5098 2019-07-22T21:53:19.586Z,1563832399.586 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2019-07-22T21:53:19.598Z,1563832399.598 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2019-07-22T21:53:19.599Z,1563832399.599 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2019-07-22T21:53:19.600Z,1563832399.600 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 5099 2019-07-22T21:53:19.600Z,1563832399.600 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2019-07-22T21:53:19.601Z,1563832399.601 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2019-07-22T21:53:19.602Z,1563832399.602 [logger ThreadHandler](INFO): Protected caller Thread ID is 5100 2019-07-22T21:53:19.604Z,1563832399.604 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2019-07-22T21:53:19.604Z,1563832399.604 [Supervisor](INFO): Looking for Config files in directory: Config/ 2019-07-22T21:53:19.606Z,1563832399.606 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2019-07-22T21:53:19.765Z,1563832399.765 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2019-07-22T21:53:19.766Z,1563832399.766 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2019-07-22T21:53:19.968Z,1563832399.968 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2019-07-22T21:53:19.968Z,1563832399.968 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2019-07-22T21:53:20.106Z,1563832400.106 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2019-07-22T21:53:20.107Z,1563832400.107 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2019-07-22T21:53:20.668Z,1563832400.668 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2019-07-22T21:53:20.669Z,1563832400.669 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2019-07-22T21:53:21.112Z,1563832401.112 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2019-07-22T21:53:21.113Z,1563832401.113 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2019-07-22T21:53:21.666Z,1563832401.666 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2019-07-22T21:53:21.667Z,1563832401.667 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2019-07-22T21:53:21.972Z,1563832401.972 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2019-07-22T21:53:21.973Z,1563832401.973 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2019-07-22T21:53:22.305Z,1563832402.305 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2019-07-22T21:53:22.305Z,1563832402.305 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2019-07-22T21:53:22.693Z,1563832402.693 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2019-07-22T21:53:22.693Z,1563832402.693 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2019-07-22T21:53:22.848Z,1563832402.848 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2019-07-22T21:53:22.848Z,1563832402.848 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2019-07-22T21:53:22.954Z,1563832402.954 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2019-07-22T21:53:22.955Z,1563832402.955 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2019-07-22T21:53:23.038Z,1563832403.038 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2019-07-22T21:53:23.141Z,1563832403.141 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2019-07-22T21:53:23.141Z,1563832403.141 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2019-07-22T21:53:23.341Z,1563832403.341 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2019-07-22T21:53:23.341Z,1563832403.341 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2019-07-22T21:53:23.557Z,1563832403.557 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2019-07-22T21:53:23.559Z,1563832403.559 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2019-07-22T21:53:23.560Z,1563832403.560 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2019-07-22T21:53:23.647Z,1563832403.647 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2019-07-22T21:53:23.878Z,1563832403.878 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2019-07-22T21:53:23.879Z,1563832403.879 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2019-07-22T21:53:23.976Z,1563832403.976 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2019-07-22T21:53:24.143Z,1563832404.143 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2019-07-22T21:53:24.422Z,1563832404.422 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2019-07-22T21:53:24.879Z,1563832404.879 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2019-07-22T21:53:25.530Z,1563832405.530 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2019-07-22T21:53:25.626Z,1563832405.626 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2019-07-22T21:53:25.781Z,1563832405.781 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2019-07-22T21:53:25.888Z,1563832405.888 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2019-07-22T21:53:25.990Z,1563832405.990 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2019-07-22T21:53:25.991Z,1563832405.991 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2019-07-22T21:53:26.001Z,1563832406.001 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2019-07-22T21:53:26.100Z,1563832406.100 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2019-07-22T21:53:26.100Z,1563832406.100 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2019-07-22T21:53:26.208Z,1563832406.208 [BuoyancyServo] Loaded 2019-07-22T21:53:26.208Z,1563832406.208 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2019-07-22T21:53:26.223Z,1563832406.223 [ElevatorServo] Loaded 2019-07-22T21:53:26.223Z,1563832406.223 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2019-07-22T21:53:26.238Z,1563832406.238 [MassServo] Loaded 2019-07-22T21:53:26.238Z,1563832406.238 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2019-07-22T21:53:26.254Z,1563832406.254 [RudderServo] Loaded 2019-07-22T21:53:26.254Z,1563832406.254 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2019-07-22T21:53:26.269Z,1563832406.269 [ThrusterServo] Loaded 2019-07-22T21:53:26.269Z,1563832406.269 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2019-07-22T21:53:26.269Z,1563832406.269 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2019-07-22T21:53:26.270Z,1563832406.270 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2019-07-22T21:53:26.405Z,1563832406.405 [SBIT](DEBUG): Construct Startup Built In Test. 2019-07-22T21:53:26.436Z,1563832406.436 [SBIT] Loaded 2019-07-22T21:53:26.436Z,1563832406.436 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2019-07-22T21:53:26.437Z,1563832406.437 [IBIT](DEBUG): Construct Initiated Built In Test. 2019-07-22T21:53:26.464Z,1563832406.464 [IBIT] Loaded 2019-07-22T21:53:26.465Z,1563832406.465 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2019-07-22T21:53:26.468Z,1563832406.468 [CBIT](DEBUG): Construct Continuous Built In Test. 2019-07-22T21:53:26.861Z,1563832406.861 [CBIT] Loaded 2019-07-22T21:53:26.861Z,1563832406.861 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2019-07-22T21:53:26.861Z,1563832406.861 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2019-07-22T21:53:26.862Z,1563832406.862 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2019-07-22T21:53:27.052Z,1563832407.052 [Aanderaa_O2] Loaded 2019-07-22T21:53:27.052Z,1563832407.052 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2019-07-22T21:53:27.082Z,1563832407.082 [ESPComponent] Loaded 2019-07-22T21:53:27.083Z,1563832407.083 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2019-07-22T21:53:27.097Z,1563832407.097 [PAR_Licor] Loaded 2019-07-22T21:53:27.097Z,1563832407.097 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2019-07-22T21:53:27.098Z,1563832407.098 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2019-07-22T21:53:27.099Z,1563832407.099 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2019-07-22T21:53:27.138Z,1563832407.138 [DepthRateCalculator] Loaded 2019-07-22T21:53:27.139Z,1563832407.139 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2019-07-22T21:53:27.144Z,1563832407.144 [PitchRateCalculator] Loaded 2019-07-22T21:53:27.145Z,1563832407.145 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2019-07-22T21:53:27.160Z,1563832407.160 [SpeedCalculator] Loaded 2019-07-22T21:53:27.161Z,1563832407.161 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2019-07-22T21:53:27.182Z,1563832407.182 [TempGradientCalculator] Loaded 2019-07-22T21:53:27.183Z,1563832407.183 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2019-07-22T21:53:27.189Z,1563832407.189 [YawRateCalculator] Loaded 2019-07-22T21:53:27.189Z,1563832407.189 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2019-07-22T21:53:27.222Z,1563832407.222 [ElevatorOffsetCalculator] Loaded 2019-07-22T21:53:27.223Z,1563832407.223 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2019-07-22T21:53:27.223Z,1563832407.223 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2019-07-22T21:53:27.224Z,1563832407.224 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2019-07-22T21:53:27.255Z,1563832407.255 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2019-07-22T21:53:27.256Z,1563832407.256 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2019-07-22T21:53:27.361Z,1563832407.361 [DeadReckonUsingMultipleVelocitySources] Loaded 2019-07-22T21:53:27.361Z,1563832407.361 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2019-07-22T21:53:27.382Z,1563832407.382 [NavChart] Loaded 2019-07-22T21:53:27.382Z,1563832407.382 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2019-07-22T21:53:27.386Z,1563832407.386 [UniversalFixResidualReporter] Loaded 2019-07-22T21:53:27.387Z,1563832407.387 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2019-07-22T21:53:27.387Z,1563832407.387 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2019-07-22T21:53:27.388Z,1563832407.388 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2019-07-22T21:53:27.740Z,1563832407.740 [AHRS_M2] Loaded 2019-07-22T21:53:27.741Z,1563832407.741 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2019-07-22T21:53:27.816Z,1563832407.816 [DataOverHttps] Loaded 2019-07-22T21:53:27.817Z,1563832407.817 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2019-07-22T21:53:27.818Z,1563832407.818 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409134E0 2019-07-22T21:53:27.818Z,1563832407.818 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 5180 2019-07-22T21:53:27.832Z,1563832407.832 [Depth_Keller] Loaded 2019-07-22T21:53:27.832Z,1563832407.832 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2019-07-22T21:53:27.924Z,1563832407.924 [NAL9602] Loaded 2019-07-22T21:53:27.924Z,1563832407.924 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2019-07-22T21:53:27.930Z,1563832407.930 [Onboard] Loaded 2019-07-22T21:53:27.930Z,1563832407.930 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2019-07-22T21:53:27.933Z,1563832407.933 [Radio_Surface] Loaded 2019-07-22T21:53:27.934Z,1563832407.934 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2019-07-22T21:53:27.935Z,1563832407.935 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409434E0 2019-07-22T21:53:27.935Z,1563832407.935 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 5181 2019-07-22T21:53:28.063Z,1563832408.063 [DAT] Loaded 2019-07-22T21:53:28.064Z,1563832408.064 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2019-07-22T21:53:29.345Z,1563832409.345 [BPC1] Loaded 2019-07-22T21:53:29.345Z,1563832409.345 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2019-07-22T21:53:29.346Z,1563832409.346 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2019-07-22T21:53:29.346Z,1563832409.346 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2019-07-22T21:53:29.419Z,1563832409.419 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2019-07-22T21:53:29.420Z,1563832409.420 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2019-07-22T21:53:29.774Z,1563832409.774 [VerticalControl](DEBUG): Construct VerticalControl. 2019-07-22T21:53:29.924Z,1563832409.924 [VerticalControl] Loaded 2019-07-22T21:53:29.925Z,1563832409.925 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2019-07-22T21:53:29.925Z,1563832409.925 [HorizontalControl](DEBUG): Construct HorizontalControl. 2019-07-22T21:53:30.015Z,1563832410.015 [HorizontalControl] Loaded 2019-07-22T21:53:30.015Z,1563832410.015 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2019-07-22T21:53:30.016Z,1563832410.016 [SpeedControl](DEBUG): Construct SpeedControl. 2019-07-22T21:53:30.017Z,1563832410.017 [SpeedControl] Loaded 2019-07-22T21:53:30.018Z,1563832410.018 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2019-07-22T21:53:30.018Z,1563832410.018 [LoopControl](DEBUG): Construct LoopControl. 2019-07-22T21:53:30.019Z,1563832410.019 [LoopControl] Loaded 2019-07-22T21:53:30.019Z,1563832410.019 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2019-07-22T21:53:30.019Z,1563832410.019 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2019-07-22T21:53:30.020Z,1563832410.020 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2019-07-22T21:53:30.033Z,1563832410.033 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2019-07-22T21:53:30.034Z,1563832410.034 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2019-07-22T21:53:30.326Z,1563832410.326 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2019-07-22T21:53:30.329Z,1563832410.329 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2019-07-22T21:53:30.330Z,1563832410.330 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2019-07-22T21:53:30.337Z,1563832410.337 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2019-07-22T21:53:30.338Z,1563832410.338 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A7E4E0 2019-07-22T21:53:30.338Z,1563832410.338 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 5182 2019-07-22T21:53:30.343Z,1563832410.343 [Supervisor](INFO): Main Thread ID is 5096 2019-07-22T21:53:30.344Z,1563832410.344 [Supervisor](DEBUG): Running supervisor. 2019-07-22T21:53:30.344Z,1563832410.344 [CommandLine ThreadHandler](INFO): Handler Thread ID is 5183 2019-07-22T21:53:30.347Z,1563832410.347 [controlThread ThreadHandler](INFO): Handler Thread ID is 5184 2019-07-22T21:53:30.347Z,1563832410.347 [controlThread](DEBUG): Initializing ControlThread 2019-07-22T21:53:30.349Z,1563832410.349 [SBIT](INFO): Initialize SBIT Component. 2019-07-22T21:53:30.349Z,1563832410.349 [SBIT](IMPORTANT): git: 2019-07-16 2019-07-22T21:53:30.349Z,1563832410.349 [SBIT](INFO): git hash: 5dde538a58d6fd4f55501de4ce986b4d4d3b120b 2019-07-22T21:53:30.350Z,1563832410.350 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2019-07-22T21:53:30.351Z,1563832410.351 [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-07-22T21:53:30.353Z,1563832410.353 [SBIT](INFO): Beginning SBIT in 48.000000 seconds. 2019-07-22T21:53:30.353Z,1563832410.353 [IBIT](INFO): Initialize IBIT Component. 2019-07-22T21:53:30.354Z,1563832410.354 [CBIT](DEBUG): Initialize CBIT Component. 2019-07-22T21:53:30.355Z,1563832410.355 [logger ThreadHandler](INFO): Handler Thread ID is 5185 2019-07-22T21:53:30.367Z,1563832410.367 [CBIT](DEBUG): Initialized mux pins. 2019-07-22T21:53:30.367Z,1563832410.367 [CBIT](DEBUG): Initializing the watchdog timer. 2019-07-22T21:53:30.376Z,1563832410.376 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 5186 2019-07-22T21:53:30.377Z,1563832410.377 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2019-07-22T21:53:30.391Z,1563832410.391 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2019-07-22T21:53:30.391Z,1563832410.391 [CBIT](DEBUG): Initializing heartbeat. 2019-07-22T21:53:30.392Z,1563832410.392 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 5187 2019-07-22T21:53:30.404Z,1563832410.404 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 5188 2019-07-22T21:53:30.410Z,1563832410.410 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2019-07-22T21:53:30.410Z,1563832410.410 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2019-07-22T21:53:30.410Z,1563832410.410 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2019-07-22T21:53:30.410Z,1563832410.410 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2019-07-22T21:53:30.410Z,1563832410.410 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2019-07-22T21:53:30.411Z,1563832410.411 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2019-07-22T21:53:30.411Z,1563832410.411 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2019-07-22T21:53:30.411Z,1563832410.411 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2019-07-22T21:53:30.411Z,1563832410.411 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2019-07-22T21:53:30.411Z,1563832410.411 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2019-07-22T21:53:30.412Z,1563832410.412 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2019-07-22T21:53:30.412Z,1563832410.412 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2019-07-22T21:53:30.412Z,1563832410.412 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2019-07-22T21:53:30.412Z,1563832410.412 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2019-07-22T21:53:30.412Z,1563832410.412 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2019-07-22T21:53:30.412Z,1563832410.412 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2019-07-22T21:53:30.464Z,1563832410.464 [CBIT](DEBUG): Deactivating GF circuits. 2019-07-22T21:53:30.464Z,1563832410.464 [CBIT](DEBUG): Deactivating emergency mode. 2019-07-22T21:53:30.499Z,1563832410.499 [CBIT](DEBUG): Backplane powered. 2019-07-22T21:53:30.504Z,1563832410.504 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2019-07-22T21:53:30.504Z,1563832410.504 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2019-07-22T21:53:30.504Z,1563832410.504 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2019-07-22T21:53:30.505Z,1563832410.505 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2019-07-22T21:53:30.505Z,1563832410.505 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2019-07-22T21:53:30.506Z,1563832410.506 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2019-07-22T21:53:30.507Z,1563832410.507 [NavChart](DEBUG): Initialize NavChart Navigation. 2019-07-22T21:53:30.507Z,1563832410.507 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2019-07-22T21:53:30.517Z,1563832410.517 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2019-07-22T21:53:30.518Z,1563832410.518 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2019-07-22T21:53:30.519Z,1563832410.519 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2019-07-22T21:53:30.524Z,1563832410.524 [LoopControl](DEBUG): Initialize LoopControlComponent. 2019-07-22T21:53:30.525Z,1563832410.525 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2019-07-22T21:53:30.560Z,1563832410.560 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2019-07-22T21:53:30.587Z,1563832410.587 [MissionManager](DEBUG): 2019-07-22T21:53:30.592Z,1563832410.592 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2019-07-22T21:53:30.672Z,1563832410.672 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2019-07-22T21:53:30.673Z,1563832410.673 [Default:A.Wait](DEBUG): Construct Wait. 2019-07-22T21:53:30.675Z,1563832410.675 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2019-07-22T21:53:30.718Z,1563832410.718 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2019-07-22T21:53:30.720Z,1563832410.720 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2019-07-22T21:53:30.746Z,1563832410.746 [Default:E.Execute](DEBUG): Construct Execute. 2019-07-22T21:53:30.749Z,1563832410.749 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2019-07-22T21:53:30.756Z,1563832410.756 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,ESPComponent,PAR_Licor,AHRS_M2,Depth_Keller,NAL9602,Onboard,DAT,BPC1,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2019-07-22T21:53:30.796Z,1563832410.796 [Radio_Surface](INFO): Powering up 2019-07-22T21:53:30.829Z,1563832410.829 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-07-22T21:53:30.977Z,1563832410.977 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2 2019-07-22T21:53:30.977Z,1563832410.977 [DAT](INFO): Powering up 2019-07-22T21:53:30.978Z,1563832410.978 [DAT](DEBUG): Initializing DAT. 2019-07-22T21:53:31.049Z,1563832411.049 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2019-07-22T21:53:31.052Z,1563832411.052 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2 2019-07-22T21:53:31.080Z,1563832411.080 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2019-07-22T21:53:31.082Z,1563832411.082 [ElevatorServo](DEBUG): Initializing EZServoServo. 2019-07-22T21:53:31.088Z,1563832411.088 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2019-07-22T21:53:31.089Z,1563832411.089 [MassServo](DEBUG): Initializing EZServoServo. 2019-07-22T21:53:31.100Z,1563832411.100 [MassServo](DEBUG): Initializing MassServo. 2019-07-22T21:53:31.101Z,1563832411.101 [RudderServo](DEBUG): Initializing EZServoServo. 2019-07-22T21:53:31.112Z,1563832411.112 [RudderServo](DEBUG): Initializing RudderServo. 2019-07-22T21:53:31.113Z,1563832411.113 [ThrusterServo](DEBUG): Initializing EZServoServo. 2019-07-22T21:53:31.124Z,1563832411.124 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2019-07-22T21:53:31.952Z,1563832411.952 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2019-07-22T21:53:31.952Z,1563832411.952 [RudderServo](FAULT): Rudder failed to initialize 2019-07-22T21:53:31.952Z,1563832411.952 [RudderServo] Communications Fault, FailCount= 1 2019-07-22T21:53:31.952Z,1563832411.952 [RudderServo](ERROR): Communications Fault 2019-07-22T21:53:32.087Z,1563832412.087 [CBIT](ERROR): Communications Fault in component: RudderServo 2019-07-22T21:53:32.272Z,1563832412.272 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-07-22T21:53:32.273Z,1563832412.273 [RudderServo](INFO): Powering down 2019-07-22T21:53:32.960Z,1563832412.960 [RudderServo](DEBUG): Initializing EZServoServo. 2019-07-22T21:53:33.080Z,1563832413.080 [RudderServo](DEBUG): Initializing RudderServo. 2019-07-22T21:53:33.084Z,1563832413.084 [CBIT](INFO): Clearing failed state for component RudderServo 2019-07-22T21:53:33.084Z,1563832413.084 [RudderServo] No Fault, FailCount= 1 2019-07-22T21:53:34.440Z,1563832414.440 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:34.895Z,1563832414.895 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:35.431Z,1563832415.431 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:36.039Z,1563832416.039 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:36.512Z,1563832416.512 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:37.028Z,1563832417.028 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:37.579Z,1563832417.579 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:38.135Z,1563832418.135 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:38.575Z,1563832418.575 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:38.000Z,1563832419.000 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:39.428Z,1563832419.428 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:39.971Z,1563832419.971 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:40.411Z,1563832420.411 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:40.856Z,1563832420.856 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:40.949Z,1563832420.949 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2019-07-22T21:53:40.949Z,1563832420.949 [Aanderaa_O2] Communications Fault, FailCount= 1 2019-07-22T21:53:40.949Z,1563832420.949 [Aanderaa_O2](ERROR): Communications Fault 2019-07-22T21:53:41.275Z,1563832421.275 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:41.352Z,1563832421.352 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2019-07-22T21:53:41.480Z,1563832421.480 [Aanderaa_O2](INFO): Powering down 2019-07-22T21:53:41.863Z,1563832421.863 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:42.307Z,1563832422.307 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:42.731Z,1563832422.731 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:42.827Z,1563832422.827 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2019-07-22T21:53:42.828Z,1563832422.828 [Aanderaa_O2] No Fault, FailCount= 1 2019-07-22T21:53:43.184Z,1563832423.184 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:43.369Z,1563832423.369 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004690 2019-07-22T21:53:43.615Z,1563832423.615 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:44.052Z,1563832424.052 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:44.052Z,1563832424.052 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-07-22T21:53:44.052Z,1563832424.052 [AHRS_M2] Communications Fault, FailCount= 1 2019-07-22T21:53:44.052Z,1563832424.052 [AHRS_M2](ERROR): Communications Fault 2019-07-22T21:53:44.119Z,1563832424.119 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-07-22T21:53:44.173Z,1563832424.173 [AHRS_M2](INFO): Powering down 2019-07-22T21:53:45.028Z,1563832425.028 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-07-22T21:53:45.028Z,1563832425.028 [AHRS_M2] No Fault, FailCount= 1 2019-07-22T21:53:45.348Z,1563832425.348 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-07-22T21:53:46.167Z,1563832426.167 [DAT](INFO): setting local address to 3 2019-07-22T21:53:46.591Z,1563832426.591 [DAT](INFO): set local address to 3 2019-07-22T21:53:48.895Z,1563832428.895 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:49.351Z,1563832429.351 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:49.796Z,1563832429.796 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:50.235Z,1563832430.235 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:50.671Z,1563832430.671 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:51.104Z,1563832431.104 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:51.547Z,1563832431.547 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:51.991Z,1563832431.991 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:52.428Z,1563832432.428 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:52.855Z,1563832432.855 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:52.938Z,1563832432.938 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2019-07-22T21:53:52.938Z,1563832432.938 [Aanderaa_O2] Communications Fault, FailCount= 2 2019-07-22T21:53:52.938Z,1563832432.938 [Aanderaa_O2](ERROR): Communications Fault 2019-07-22T21:53:53.304Z,1563832433.304 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:53.380Z,1563832433.380 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2019-07-22T21:53:53.504Z,1563832433.504 [Aanderaa_O2](INFO): Powering down 2019-07-22T21:53:53.832Z,1563832433.832 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:54.288Z,1563832434.288 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:54.740Z,1563832434.740 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:54.856Z,1563832434.856 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2019-07-22T21:53:54.856Z,1563832434.856 [Aanderaa_O2] No Fault, FailCount= 2 2019-07-22T21:53:55.219Z,1563832435.219 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:55.659Z,1563832435.659 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:56.099Z,1563832436.099 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:56.603Z,1563832436.603 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:57.035Z,1563832437.035 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:57.467Z,1563832437.467 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:57.899Z,1563832437.899 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:58.331Z,1563832438.331 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:53:58.332Z,1563832438.332 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-07-22T21:53:58.332Z,1563832438.332 [AHRS_M2] Communications Fault, FailCount= 2 2019-07-22T21:53:58.332Z,1563832438.332 [AHRS_M2](ERROR): Communications Fault 2019-07-22T21:53:58.337Z,1563832438.337 [NAL9602](INFO): Powering up NAL9602 2019-07-22T21:53:58.411Z,1563832438.411 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-07-22T21:53:58.488Z,1563832438.488 [AHRS_M2](INFO): Powering down 2019-07-22T21:53:59.289Z,1563832439.289 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-07-22T21:53:59.289Z,1563832439.289 [AHRS_M2] No Fault, FailCount= 2 2019-07-22T21:53:59.636Z,1563832439.636 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-07-22T21:54:03.192Z,1563832443.192 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:03.631Z,1563832443.631 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:04.083Z,1563832444.083 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:04.535Z,1563832444.535 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:04.979Z,1563832444.979 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:05.063Z,1563832445.063 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2019-07-22T21:54:05.063Z,1563832445.063 [Aanderaa_O2] Communications Fault, FailCount= 3 2019-07-22T21:54:05.071Z,1563832445.071 [Aanderaa_O2](ERROR): Communications Fault 2019-07-22T21:54:05.411Z,1563832445.411 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:05.466Z,1563832445.466 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2019-07-22T21:54:05.467Z,1563832445.467 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2019-07-22T21:54:05.596Z,1563832445.596 [Aanderaa_O2](INFO): Powering down 2019-07-22T21:54:05.924Z,1563832445.924 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:06.387Z,1563832446.387 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:06.824Z,1563832446.824 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:07.255Z,1563832447.255 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:07.699Z,1563832447.699 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:08.155Z,1563832448.155 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:08.603Z,1563832448.603 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:09.035Z,1563832449.035 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:09.484Z,1563832449.484 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:09.496Z,1563832449.496 [NAL9602](INFO): NAL9602 initialized 2019-07-22T21:54:09.935Z,1563832449.935 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:10.400Z,1563832450.400 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:10.415Z,1563832450.415 [NAL9602](DEBUG): Fix Requested 2019-07-22T21:54:10.867Z,1563832450.867 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:11.327Z,1563832451.327 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:11.811Z,1563832451.811 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:12.247Z,1563832452.247 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:12.683Z,1563832452.683 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:12.684Z,1563832452.684 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-07-22T21:54:12.684Z,1563832452.684 [AHRS_M2] Communications Fault, FailCount= 3 2019-07-22T21:54:12.684Z,1563832452.684 [AHRS_M2](ERROR): Communications Fault 2019-07-22T21:54:12.761Z,1563832452.761 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-07-22T21:54:12.801Z,1563832452.801 [AHRS_M2](INFO): Powering down 2019-07-22T21:54:13.635Z,1563832453.635 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-07-22T21:54:13.635Z,1563832453.635 [AHRS_M2] No Fault, FailCount= 3 2019-07-22T21:54:13.980Z,1563832453.980 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-07-22T21:54:17.535Z,1563832457.535 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:17.975Z,1563832457.975 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:18.415Z,1563832458.415 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:18.883Z,1563832458.883 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:18.941Z,1563832458.941 [SBIT](IMPORTANT): Beginning Startup BIT 2019-07-22T21:54:18.949Z,1563832458.949 [CBIT](IMPORTANT): Beginning ground fault scan 2019-07-22T21:54:19.099Z,1563832459.099 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:19.687Z,1563832459.687 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:20.156Z,1563832460.156 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:20.664Z,1563832460.664 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:21.215Z,1563832461.215 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:22.135Z,1563832462.135 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:22.656Z,1563832462.656 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:23.347Z,1563832463.347 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:23.800Z,1563832463.800 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:24.295Z,1563832464.295 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:24.951Z,1563832464.951 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:25.383Z,1563832465.383 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:25.819Z,1563832465.819 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:26.279Z,1563832466.279 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:26.783Z,1563832466.783 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:27.211Z,1563832467.211 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:27.212Z,1563832467.212 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-07-22T21:54:27.212Z,1563832467.212 [AHRS_M2] Communications Fault, FailCount= 4 2019-07-22T21:54:27.212Z,1563832467.212 [AHRS_M2](ERROR): Communications Fault 2019-07-22T21:54:27.305Z,1563832467.305 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-07-22T21:54:27.312Z,1563832467.312 [AHRS_M2](INFO): Powering down 2019-07-22T21:54:28.204Z,1563832468.204 [CBIT](INFO): Clearing failed state for component AHRS_M2 2019-07-22T21:54:28.204Z,1563832468.204 [AHRS_M2] No Fault, FailCount= 4 2019-07-22T21:54:28.525Z,1563832468.525 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2019-07-22T21:54:30.220Z,1563832470.220 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.008861 CHAN A1 (24V): -0.023256 CHAN A2 (12V): -0.005090 CHAN A3 (5V): -0.001571 CHAN B0 (3.3V): -0.001196 CHAN B1 (3.15aV): -0.001359 CHAN B2 (3.15bV): -0.001125 CHAN B3 (GND): -0.000256 OPEN: 0.007719 Full Scale Calc: 4.765 mA, -1.589 mA 2019-07-22T21:54:32.083Z,1563832472.083 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:32.535Z,1563832472.535 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:33.071Z,1563832473.071 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:33.540Z,1563832473.540 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:33.984Z,1563832473.984 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:34.423Z,1563832474.423 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:34.999Z,1563832474.999 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:35.831Z,1563832475.831 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:36.315Z,1563832476.315 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:36.795Z,1563832476.795 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:37.271Z,1563832477.271 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:37.748Z,1563832477.748 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:38.211Z,1563832478.211 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:38.707Z,1563832478.707 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:39.199Z,1563832479.199 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:39.719Z,1563832479.719 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:40.308Z,1563832480.308 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:40.967Z,1563832480.967 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:41.399Z,1563832481.399 [AHRS_M2](ERROR): setBoresightMatrix UART error: serial timeout 2019-07-22T21:54:41.400Z,1563832481.400 [AHRS_M2](FAULT): Failed to initialize within timeout. 2019-07-22T21:54:41.400Z,1563832481.400 [AHRS_M2] Communications Fault, FailCount= 5 2019-07-22T21:54:41.400Z,1563832481.400 [AHRS_M2](ERROR): Communications Fault 2019-07-22T21:54:41.496Z,1563832481.496 [CBIT](ERROR): Communications Fault in component: AHRS_M2 2019-07-22T21:54:41.496Z,1563832481.496 [CBIT](CRITICAL): Communications Fault in component: AHRS_M2 2019-07-22T21:54:41.560Z,1563832481.560 [AHRS_M2](INFO): Powering down 2019-07-22T21:54:41.706Z,1563832481.706 [CommandLine](FAULT): Scheduling is paused 2019-07-22T21:54:41.706Z,1563832481.706 [CBIT](INFO): Critical error at 20190722T215441 2019-07-22T21:54:41.707Z,1563832481.707 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2019-07-22T21:55:13.137Z,1563832513.137 [SBIT](IMPORTANT): SBIT PASSED 2019-07-22T21:55:13.232Z,1563832513.232 [CommandLine](IMPORTANT): got command configSet list 2019-07-22T21:55:13.233Z,1563832513.233 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2019-07-22T21:55:13.233Z,1563832513.233 [CommandLine](IMPORTANT): BuoyancyServo.fastPumpCoefficient=6 none; 2019-07-22T21:55:13.234Z,1563832513.234 [CommandLine](IMPORTANT): BuoyancyServo.fastPumpDepth=5 meter; 2019-07-22T21:55:13.234Z,1563832513.234 [CommandLine](IMPORTANT): CTD_NeilBrown.loadAtStartup=0 bool; 2019-07-22T21:55:13.234Z,1563832513.234 [CommandLine](IMPORTANT): CTD_Seabird.loadAtStartup=0 bool; 2019-07-22T21:55:13.234Z,1563832513.234 [CommandLine](IMPORTANT): DVL_micro.loadAtStartup=0 bool; 2019-07-22T21:55:13.234Z,1563832513.234 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2019-07-22T21:55:13.234Z,1563832513.234 [CommandLine](IMPORTANT): VerticalControl.buoyancyNeutral=378 cubic_centimeter; 2019-07-22T21:55:13.234Z,1563832513.234 [CommandLine](IMPORTANT): VerticalControl.kiDepthBuoy=0.3 reciprocal_second; 2019-07-22T21:55:13.234Z,1563832513.234 [CommandLine](IMPORTANT): VerticalControl.massDefault=-7 millimeter; 2019-07-22T21:55:13.234Z,1563832513.234 [CommandLine](IMPORTANT): WetLabsBB2FL.loadAtStartup=0 bool; 2019-07-22T21:55:13.540Z,1563832513.540 [MissionManager](IMPORTANT): Started mission Startup 2019-07-22T21:55:13.541Z,1563832513.541 [Startup] Running Loop=1 2019-07-22T21:55:13.541Z,1563832513.541 [Startup](DEBUG): Aggregate::initialize Startup 2019-07-22T21:55:13.541Z,1563832513.541 [Startup:A.GoToSurface] Running Loop=1 2019-07-22T21:55:13.541Z,1563832513.541 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-07-22T21:55:13.541Z,1563832513.541 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-07-22T21:55:13.542Z,1563832513.542 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-07-22T21:55:13.542Z,1563832513.542 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-07-22T21:55:13.543Z,1563832513.543 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-07-22T21:55:13.543Z,1563832513.543 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-07-22T21:55:13.545Z,1563832513.545 [Startup:StartupSatComms] Running Loop=1 2019-07-22T21:55:13.545Z,1563832513.545 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2019-07-22T21:55:13.545Z,1563832513.545 [Startup:StartupSatComms:A] Running Loop=1 2019-07-22T21:55:13.946Z,1563832513.946 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2019-07-22T21:55:27.020Z,1563832527.020 [CommandLine](IMPORTANT): got command failVariable 2019-07-22T21:55:27.020Z,1563832527.020 [CommandLine](IMPORTANT): Failed variables: 2019-07-22T21:55:27.021Z,1563832527.021 [CommandLine](IMPORTANT): acoustic_receive_time is invalid. 2019-07-22T21:55:27.021Z,1563832527.021 [CommandLine](IMPORTANT): acoustic_transmit_time is invalid. 2019-07-22T21:55:27.021Z,1563832527.021 [CommandLine](IMPORTANT): distance_from_shore is invalid. 2019-07-22T21:55:27.022Z,1563832527.022 [CommandLine](IMPORTANT): downwelling_photosynthetic_photon_flux_in_sea_water is invalid. 2019-07-22T21:55:27.022Z,1563832527.022 [CommandLine](IMPORTANT): fix_distance_made_good is invalid. 2019-07-22T21:55:27.022Z,1563832527.022 [CommandLine](IMPORTANT): fix_horizontal_path_length_since_last_fix is invalid. 2019-07-22T21:55:27.022Z,1563832527.022 [CommandLine](IMPORTANT): fix_residual_distance is invalid. 2019-07-22T21:55:27.022Z,1563832527.022 [CommandLine](IMPORTANT): fix_residual_bearing is invalid. 2019-07-22T21:55:27.023Z,1563832527.023 [CommandLine](IMPORTANT): fix_residual_percent_distance_traveled is invalid. 2019-07-22T21:55:27.023Z,1563832527.023 [CommandLine](IMPORTANT): height_above_sea_floor is invalid. 2019-07-22T21:55:27.023Z,1563832527.023 [CommandLine](IMPORTANT): horizontal_path_length_since_last_fix is invalid. 2019-07-22T21:55:27.024Z,1563832527.024 [CommandLine](IMPORTANT): latitude is invalid. 2019-07-22T21:55:27.024Z,1563832527.024 [CommandLine](IMPORTANT): latitude_fix is invalid. 2019-07-22T21:55:27.024Z,1563832527.024 [CommandLine](IMPORTANT): location_fix is invalid. 2019-07-22T21:55:27.024Z,1563832527.024 [CommandLine](IMPORTANT): longitude is invalid. 2019-07-22T21:55:27.024Z,1563832527.024 [CommandLine](IMPORTANT): longitude_fix is invalid. 2019-07-22T21:55:27.025Z,1563832527.025 [CommandLine](IMPORTANT): mass_concentration_of_oxygen_in_sea_water is invalid. 2019-07-22T21:55:27.025Z,1563832527.025 [CommandLine](IMPORTANT): platform_battery_charge is invalid. 2019-07-22T21:55:27.025Z,1563832527.025 [CommandLine](IMPORTANT): platform_battery_voltage is invalid. 2019-07-22T21:55:27.026Z,1563832527.026 [CommandLine](IMPORTANT): platform_communications is invalid. 2019-07-22T21:55:27.026Z,1563832527.026 [CommandLine](IMPORTANT): platform_conversation is invalid. 2019-07-22T21:55:27.026Z,1563832527.026 [CommandLine](IMPORTANT): platform_fault_leak is invalid. 2019-07-22T21:55:27.027Z,1563832527.027 [CommandLine](IMPORTANT): platform_magnetic_orientation is invalid. 2019-07-22T21:55:27.027Z,1563832527.027 [CommandLine](IMPORTANT): platform_orientation is invalid. 2019-07-22T21:55:27.027Z,1563832527.027 [CommandLine](IMPORTANT): platform_orientation_matrix is invalid. 2019-07-22T21:55:27.027Z,1563832527.027 [CommandLine](IMPORTANT): platform_pitch_angle is invalid. 2019-07-22T21:55:27.056Z,1563832527.056 [CommandLine](IMPORTANT): platform_pitch_rate is invalid. 2019-07-22T21:55:27.056Z,1563832527.056 [CommandLine](IMPORTANT): platform_roll_angle is invalid. 2019-07-22T21:55:27.057Z,1563832527.057 [CommandLine](IMPORTANT): platform_yaw_rate is invalid. 2019-07-22T21:55:27.058Z,1563832527.058 [CommandLine](IMPORTANT): sea_floor_depth_below_geoid is invalid. 2019-07-22T21:55:27.058Z,1563832527.058 [CommandLine](IMPORTANT): time_fix is invalid. 2019-07-22T21:55:27.059Z,1563832527.059 [CommandLine](IMPORTANT): upward_derivative_of_sea_water_temperature is invalid. 2019-07-22T21:55:27.151Z,1563832527.151 [CommandLine](IMPORTANT): CBIT.clearFaultCmd is unavailable. 2019-07-22T21:55:27.151Z,1563832527.151 [CommandLine](IMPORTANT): CBIT.clearFaultCmd is invalid. 2019-07-22T21:55:27.164Z,1563832527.164 [CommandLine](IMPORTANT): CBIT.clearLeakFaultCmd is unavailable. 2019-07-22T21:55:27.164Z,1563832527.164 [CommandLine](IMPORTANT): CBIT.clearLeakFaultCmd is invalid. 2019-07-22T21:55:27.164Z,1563832527.164 [CommandLine](IMPORTANT): BPC1.BattTemp_0 is unavailable. 2019-07-22T21:55:27.164Z,1563832527.164 [CommandLine](IMPORTANT): BPC1.BattTemp_0 is invalid. 2019-07-22T21:55:27.168Z,1563832527.168 [CommandLine](IMPORTANT): Aanderaa_O2.mass_concentration_of_oxygen_in_sea_water is unavailable. 2019-07-22T21:55:27.169Z,1563832527.169 [CommandLine](IMPORTANT): Aanderaa_O2.mass_concentration_of_oxygen_in_sea_water is invalid. 2019-07-22T21:55:27.169Z,1563832527.169 [CommandLine](IMPORTANT): Aanderaa_O2.temperature is unavailable. 2019-07-22T21:55:27.169Z,1563832527.169 [CommandLine](IMPORTANT): Aanderaa_O2.temperature is invalid. 2019-07-22T21:55:27.169Z,1563832527.169 [CommandLine](IMPORTANT): Aanderaa_O2.airSaturation is unavailable. 2019-07-22T21:55:27.169Z,1563832527.169 [CommandLine](IMPORTANT): Aanderaa_O2.airSaturation is invalid. 2019-07-22T21:55:27.170Z,1563832527.170 [CommandLine](IMPORTANT): ESPComponent.cartridge is unavailable. 2019-07-22T21:55:27.170Z,1563832527.170 [CommandLine](IMPORTANT): ESPComponent.cartridge is invalid. 2019-07-22T21:55:27.170Z,1563832527.170 [CommandLine](IMPORTANT): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water is invalid. 2019-07-22T21:55:27.184Z,1563832527.184 [CommandLine](IMPORTANT): DeadReckonUsingMultipleVelocitySources.latitude is invalid. 2019-07-22T21:55:27.184Z,1563832527.184 [CommandLine](IMPORTANT): DeadReckonUsingMultipleVelocitySources.longitude is invalid. 2019-07-22T21:55:27.184Z,1563832527.184 [CommandLine](IMPORTANT): DeadReckonUsingMultipleVelocitySources.depth is invalid. 2019-07-22T21:55:27.184Z,1563832527.184 [CommandLine](IMPORTANT): DeadReckonUsingMultipleVelocitySources.horizontal_path_length_since_last_fix is invalid. 2019-07-22T21:55:27.185Z,1563832527.185 [CommandLine](IMPORTANT): AHRS_M2.platform_magnetic_orientation is unavailable. 2019-07-22T21:55:27.185Z,1563832527.185 [CommandLine](IMPORTANT): AHRS_M2.platform_magnetic_orientation is invalid. 2019-07-22T21:55:27.186Z,1563832527.186 [CommandLine](IMPORTANT): AHRS_M2.platform_pitch_angle is unavailable. 2019-07-22T21:55:27.186Z,1563832527.186 [CommandLine](IMPORTANT): AHRS_M2.platform_pitch_angle is invalid. 2019-07-22T21:55:27.186Z,1563832527.186 [CommandLine](IMPORTANT): AHRS_M2.platform_roll_angle is unavailable. 2019-07-22T21:55:27.186Z,1563832527.186 [CommandLine](IMPORTANT): AHRS_M2.platform_roll_angle is invalid. 2019-07-22T21:55:27.186Z,1563832527.186 [CommandLine](IMPORTANT): AHRS_M2.platform_orientation_matrix is unavailable. 2019-07-22T21:55:27.186Z,1563832527.186 [CommandLine](IMPORTANT): AHRS_M2.platform_orientation_matrix is invalid. 2019-07-22T21:55:27.187Z,1563832527.187 [CommandLine](IMPORTANT): AHRS_M2.platform_orientation is unavailable. 2019-07-22T21:55:27.187Z,1563832527.187 [CommandLine](IMPORTANT): AHRS_M2.platform_orientation is invalid. 2019-07-22T21:55:27.187Z,1563832527.187 [CommandLine](IMPORTANT): AHRS_M2.calibration_state is unavailable. 2019-07-22T21:55:27.187Z,1563832527.187 [CommandLine](IMPORTANT): AHRS_M2.calibration_state is invalid. 2019-07-22T21:55:27.187Z,1563832527.187 [CommandLine](IMPORTANT): AHRS_M2.orientation_error is unavailable. 2019-07-22T21:55:27.188Z,1563832527.188 [CommandLine](IMPORTANT): AHRS_M2.orientation_error is invalid. 2019-07-22T21:55:27.188Z,1563832527.188 [CommandLine](IMPORTANT): AHRS_M2.orientation is unavailable. 2019-07-22T21:55:27.188Z,1563832527.188 [CommandLine](IMPORTANT): AHRS_M2.orientation is invalid. 2019-07-22T21:55:27.188Z,1563832527.188 [CommandLine](IMPORTANT): AHRS_M2.temperature is unavailable. 2019-07-22T21:55:27.188Z,1563832527.188 [CommandLine](IMPORTANT): AHRS_M2.temperature is invalid. 2019-07-22T21:55:27.189Z,1563832527.189 [CommandLine](IMPORTANT): AHRS_M2.magnetic_field_along_x_axis is unavailable. 2019-07-22T21:55:27.189Z,1563832527.189 [CommandLine](IMPORTANT): AHRS_M2.magnetic_field_along_x_axis is invalid. 2019-07-22T21:55:27.189Z,1563832527.189 [CommandLine](IMPORTANT): AHRS_M2.magnetic_field_along_y_axis is unavailable. 2019-07-22T21:55:27.189Z,1563832527.189 [CommandLine](IMPORTANT): AHRS_M2.magnetic_field_along_y_axis is invalid. 2019-07-22T21:55:27.189Z,1563832527.189 [CommandLine](IMPORTANT): AHRS_M2.magnetic_field_along_z_axis is unavailable. 2019-07-22T21:55:27.189Z,1563832527.189 [CommandLine](IMPORTANT): AHRS_M2.magnetic_field_along_z_axis is invalid. 2019-07-22T21:55:27.190Z,1563832527.190 [CommandLine](IMPORTANT): AHRS_M2.acceleration_along_x_axis is unavailable. 2019-07-22T21:55:27.190Z,1563832527.190 [CommandLine](IMPORTANT): AHRS_M2.acceleration_along_x_axis is invalid. 2019-07-22T21:55:27.190Z,1563832527.190 [CommandLine](IMPORTANT): AHRS_M2.acceleration_along_y_axis is unavailable. 2019-07-22T21:55:27.190Z,1563832527.190 [CommandLine](IMPORTANT): AHRS_M2.acceleration_along_y_axis is invalid. 2019-07-22T21:55:27.190Z,1563832527.190 [CommandLine](IMPORTANT): AHRS_M2.acceleration_along_z_axis is unavailable. 2019-07-22T21:55:27.190Z,1563832527.190 [CommandLine](IMPORTANT): AHRS_M2.acceleration_along_z_axis is invalid. 2019-07-22T21:55:27.191Z,1563832527.191 [CommandLine](IMPORTANT): AHRS_M2.angular_velocity_along_x_axis is unavailable. 2019-07-22T21:55:27.191Z,1563832527.191 [CommandLine](IMPORTANT): AHRS_M2.angular_velocity_along_x_axis is invalid. 2019-07-22T21:55:27.191Z,1563832527.191 [CommandLine](IMPORTANT): AHRS_M2.angular_velocity_along_y_axis is unavailable. 2019-07-22T21:55:27.191Z,1563832527.191 [CommandLine](IMPORTANT): AHRS_M2.angular_velocity_along_y_axis is invalid. 2019-07-22T21:55:27.191Z,1563832527.191 [CommandLine](IMPORTANT): AHRS_M2.angular_velocity_along_z_axis is unavailable. 2019-07-22T21:55:27.192Z,1563832527.192 [CommandLine](IMPORTANT): AHRS_M2.angular_velocity_along_z_axis is invalid. 2019-07-22T21:55:27.192Z,1563832527.192 [CommandLine](IMPORTANT): AHRS_M2.number_of_calbration_points is unavailable. 2019-07-22T21:55:27.192Z,1563832527.192 [CommandLine](IMPORTANT): AHRS_M2.number_of_calbration_points is invalid. 2019-07-22T21:55:27.193Z,1563832527.193 [CommandLine](IMPORTANT): DAT.queryAddressRequested is unavailable. 2019-07-22T21:55:27.194Z,1563832527.194 [CommandLine](IMPORTANT): DAT.queryAddressRequested is invalid. 2019-07-22T21:55:27.194Z,1563832527.194 [CommandLine](IMPORTANT): DAT.numberOfPingsRequested is unavailable. 2019-07-22T21:55:27.194Z,1563832527.194 [CommandLine](IMPORTANT): DAT.numberOfPingsRequested is invalid. 2019-07-22T21:55:27.225Z,1563832527.225 [CommandLine](IMPORTANT): VerticalControl.depthCmd is unavailable. 2019-07-22T21:55:27.225Z,1563832527.225 [CommandLine](IMPORTANT): VerticalControl.depthCmd is invalid. 2019-07-22T21:55:27.225Z,1563832527.225 [CommandLine](IMPORTANT): VerticalControl.pitchRateCmd is unavailable. 2019-07-22T21:55:27.225Z,1563832527.225 [CommandLine](IMPORTANT): VerticalControl.pitchRateCmd is invalid. 2019-07-22T21:55:27.225Z,1563832527.225 [CommandLine](IMPORTANT): VerticalControl.buoyancyCmd is unavailable. 2019-07-22T21:55:27.226Z,1563832527.226 [CommandLine](IMPORTANT): VerticalControl.buoyancyCmd is invalid. 2019-07-22T21:55:27.226Z,1563832527.226 [CommandLine](IMPORTANT): LoopControl.periodCmd is unavailable. 2019-07-22T21:55:27.226Z,1563832527.226 [CommandLine](IMPORTANT): LoopControl.periodCmd is invalid. 2019-07-22T21:55:27.227Z,1563832527.227 [CommandLine](IMPORTANT): HorizontalControl.latitudeCmd is unavailable. 2019-07-22T21:55:27.227Z,1563832527.227 [CommandLine](IMPORTANT): HorizontalControl.latitudeCmd is invalid. 2019-07-22T21:55:27.227Z,1563832527.227 [CommandLine](IMPORTANT): HorizontalControl.longitudeCmd is unavailable. 2019-07-22T21:55:27.227Z,1563832527.227 [CommandLine](IMPORTANT): HorizontalControl.longitudeCmd is invalid. 2019-07-22T21:55:27.227Z,1563832527.227 [CommandLine](IMPORTANT): HorizontalControl.headingCmd is unavailable. 2019-07-22T21:55:27.228Z,1563832527.228 [CommandLine](IMPORTANT): HorizontalControl.headingCmd is invalid. 2019-07-22T21:55:27.228Z,1563832527.228 [CommandLine](IMPORTANT): HorizontalControl.headingRateCmd is unavailable. 2019-07-22T21:55:27.228Z,1563832527.228 [CommandLine](IMPORTANT): HorizontalControl.headingRateCmd is invalid. 2019-07-22T21:55:27.228Z,1563832527.228 [CommandLine](IMPORTANT): HorizontalControl.bearingCmd is unavailable. 2019-07-22T21:55:27.228Z,1563832527.228 [CommandLine](IMPORTANT): HorizontalControl.bearingCmd is invalid. 2019-07-22T21:55:27.230Z,1563832527.230 [CommandLine](IMPORTANT): Aanderaa_O2.component_voltage is unavailable. 2019-07-22T21:55:27.230Z,1563832527.230 [CommandLine](IMPORTANT): Aanderaa_O2.component_voltage is invalid. 2019-07-22T21:55:27.231Z,1563832527.231 [CommandLine](IMPORTANT): Aanderaa_O2.component_avgVoltage is unavailable. 2019-07-22T21:55:27.231Z,1563832527.231 [CommandLine](IMPORTANT): Aanderaa_O2.component_avgVoltage is invalid. 2019-07-22T21:55:27.231Z,1563832527.231 [CommandLine](IMPORTANT): Aanderaa_O2.component_current is unavailable. 2019-07-22T21:55:27.231Z,1563832527.231 [CommandLine](IMPORTANT): Aanderaa_O2.component_current is invalid. 2019-07-22T21:55:27.231Z,1563832527.231 [CommandLine](IMPORTANT): Aanderaa_O2.component_avgCurrent is unavailable. 2019-07-22T21:55:27.231Z,1563832527.231 [CommandLine](IMPORTANT): Aanderaa_O2.component_avgCurrent is invalid. 2019-07-22T21:55:27.232Z,1563832527.232 [CommandLine](IMPORTANT): AHRS_M2.component_voltage is unavailable. 2019-07-22T21:55:27.232Z,1563832527.232 [CommandLine](IMPORTANT): AHRS_M2.component_voltage is invalid. 2019-07-22T21:55:27.232Z,1563832527.232 [CommandLine](IMPORTANT): AHRS_M2.component_avgVoltage is unavailable. 2019-07-22T21:55:27.232Z,1563832527.232 [CommandLine](IMPORTANT): AHRS_M2.component_avgVoltage is invalid. 2019-07-22T21:55:27.232Z,1563832527.232 [CommandLine](IMPORTANT): AHRS_M2.component_current is unavailable. 2019-07-22T21:55:27.233Z,1563832527.233 [CommandLine](IMPORTANT): AHRS_M2.component_current is invalid. 2019-07-22T21:55:27.233Z,1563832527.233 [CommandLine](IMPORTANT): AHRS_M2.component_avgCurrent is unavailable. 2019-07-22T21:55:27.233Z,1563832527.233 [CommandLine](IMPORTANT): AHRS_M2.component_avgCurrent is invalid. 2019-07-22T21:55:30.909Z,1563832530.909 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-07-22T21:55:30.909Z,1563832530.909 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2019-07-22T21:55:30.909Z,1563832530.909 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-07-22T21:55:30.920Z,1563832530.920 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-07-22T21:55:31.328Z,1563832531.328 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-07-22T21:55:31.328Z,1563832531.328 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2019-07-22T21:55:36.909Z,1563832536.909 [CommandLine](IMPORTANT): got command failComponent 2019-07-22T21:55:36.909Z,1563832536.909 [CommandLine](IMPORTANT): Failed components: 2019-07-22T21:55:36.910Z,1563832536.910 [CommandLine](IMPORTANT): Aanderaa_O2: Communications Fault 2019-07-22T21:55:36.910Z,1563832536.910 [CommandLine](IMPORTANT): AHRS_M2: Communications Fault 2019-07-22T21:56:13.783Z,1563832573.783 [Startup:StartupSatComms:A](INFO): Timed out from 2019-07-22T21:55:13.5Z 2019-07-22T21:56:13.783Z,1563832573.783 [Startup:StartupSatComms:A] Stopped 2019-07-22T21:56:13.784Z,1563832573.784 [Startup:StartupSatComms:B] Running Loop=1 2019-07-22T21:56:14.161Z,1563832574.161 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2019-07-22T21:56:21.579Z,1563832581.579 [DataOverHttps](INFO): Sending 78 bytes from file Logs/20190722T174454/Courier0040.lzma 2019-07-22T21:56:22.385Z,1563832582.385 [DataOverHttps](INFO): Moved sent file to Logs/20190722T174454/Courier0040.lzma.bak 2019-07-22T21:56:22.385Z,1563832582.385 [DataOverHttps](INFO): SBD MOMSN=11463749 2019-07-22T21:56:35.356Z,1563832595.356 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2019-07-22T21:56:35.356Z,1563832595.356 [Aanderaa_O2] No Fault, FailCount= 3 2019-07-22T21:56:37.107Z,1563832597.107 [DataOverHttps](INFO): Sending 101 bytes from file Logs/20190722T215319/Courier0000.lzma 2019-07-22T21:56:37.913Z,1563832597.913 [DataOverHttps](INFO): Moved sent file to Logs/20190722T215319/Courier0000.lzma.bak 2019-07-22T21:56:37.913Z,1563832597.913 [DataOverHttps](INFO): SBD MOMSN=11463752 2019-07-22T21:56:45.772Z,1563832605.772 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2019-07-22T21:56:45.772Z,1563832605.772 [Aanderaa_O2] Communications Fault, FailCount= 1 2019-07-22T21:56:45.772Z,1563832605.772 [Aanderaa_O2](ERROR): Communications Fault 2019-07-22T21:56:45.860Z,1563832605.860 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2019-07-22T21:56:46.296Z,1563832606.296 [Aanderaa_O2](INFO): Powering down 2019-07-22T21:56:47.065Z,1563832607.065 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2019-07-22T21:56:47.065Z,1563832607.065 [Aanderaa_O2] No Fault, FailCount= 1 2019-07-22T21:56:54.188Z,1563832614.188 [CommandLine](IMPORTANT): got command burn on 2019-07-22T21:56:54.188Z,1563832614.188 [CommandLine](IMPORTANT): Activating dropweight wire 2019-07-22T21:56:55.171Z,1563832615.171 [DataOverHttps](INFO): Sending 253 bytes from file Logs/20190722T174454/Express0041.lzma 2019-07-22T21:56:55.977Z,1563832615.977 [DataOverHttps](INFO): Moved sent file to Logs/20190722T174454/Express0041.lzma.bak 2019-07-22T21:56:55.977Z,1563832615.977 [DataOverHttps](INFO): SBD MOMSN=11463756 2019-07-22T21:56:57.488Z,1563832617.488 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2019-07-22T21:56:57.488Z,1563832617.488 [Aanderaa_O2] Communications Fault, FailCount= 2 2019-07-22T21:56:57.488Z,1563832617.488 [Aanderaa_O2](ERROR): Communications Fault 2019-07-22T21:56:57.557Z,1563832617.557 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2019-07-22T21:56:58.012Z,1563832618.012 [Aanderaa_O2](INFO): Powering down 2019-07-22T21:56:58.784Z,1563832618.784 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2019-07-22T21:56:58.784Z,1563832618.784 [Aanderaa_O2] No Fault, FailCount= 2 2019-07-22T21:57:09.272Z,1563832629.272 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2019-07-22T21:57:09.272Z,1563832629.272 [Aanderaa_O2] Communications Fault, FailCount= 3 2019-07-22T21:57:09.272Z,1563832629.272 [Aanderaa_O2](ERROR): Communications Fault 2019-07-22T21:57:09.326Z,1563832629.326 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2019-07-22T21:57:09.327Z,1563832629.327 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2019-07-22T21:57:09.796Z,1563832629.796 [Aanderaa_O2](INFO): Powering down 2019-07-22T21:57:12.663Z,1563832632.663 [DataOverHttps](INFO): Sending 2254 bytes from file Logs/20190722T215319/Express0001.lzma 2019-07-22T21:57:13.465Z,1563832633.465 [DataOverHttps](INFO): Moved sent file to Logs/20190722T215319/Express0001.lzma.bak 2019-07-22T21:57:13.465Z,1563832633.465 [DataOverHttps](INFO): SBD MOMSN=11463766 2019-07-22T21:57:14.172Z,1563832634.172 [Startup:StartupSatComms:B](INFO): Timed out from 2019-07-22T21:56:13.8Z 2019-07-22T21:57:14.172Z,1563832634.172 [Startup:StartupSatComms:B] Stopped 2019-07-22T21:57:14.172Z,1563832634.172 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2019-07-22T21:57:14.172Z,1563832634.172 [Startup:StartupSatComms] Stopped 2019-07-22T21:57:14.172Z,1563832634.172 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2019-07-22T21:57:14.173Z,1563832634.173 [Startup](INFO): Completed Startup 2019-07-22T21:57:14.173Z,1563832634.173 [MissionManager](INFO): Startup is completed. 2019-07-22T21:57:14.173Z,1563832634.173 [MissionManager](INFO): Uninitializing Mission Startup 2019-07-22T21:57:14.173Z,1563832634.173 [Startup] Stopped 2019-07-22T21:57:14.173Z,1563832634.173 [Startup](DEBUG): Aggregate::uninitialize Startup 2019-07-22T21:57:14.174Z,1563832634.174 [Startup:A.GoToSurface] Stopped 2019-07-22T21:57:14.174Z,1563832634.174 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-07-22T21:57:14.583Z,1563832634.583 [MissionManager](IMPORTANT): Started mission Default 2019-07-22T21:57:14.584Z,1563832634.584 [Default] Running Loop=1 2019-07-22T21:57:14.584Z,1563832634.584 [Default](DEBUG): Aggregate::initialize Default 2019-07-22T21:57:14.584Z,1563832634.584 [Default:B.GoToSurface] Running Loop=1 2019-07-22T21:57:14.584Z,1563832634.584 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-07-22T21:57:14.584Z,1563832634.584 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-07-22T21:57:14.584Z,1563832634.584 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-07-22T21:57:14.585Z,1563832634.585 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-07-22T21:57:14.585Z,1563832634.585 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-07-22T21:57:14.585Z,1563832634.585 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-07-22T21:57:14.586Z,1563832634.586 [Default:A.Wait] Running Loop=1 2019-07-22T21:57:14.586Z,1563832634.586 [Default:A.Wait](DEBUG): Initialize Wait Component. 2019-07-22T21:57:23.809Z,1563832643.809 [CommandLine](IMPORTANT): got command burn off 2019-07-22T21:57:23.809Z,1563832643.809 [CommandLine](IMPORTANT): Deactivating dropweight wire 2019-07-22T21:57:27.906Z,1563832647.906 [Default:A.Wait](INFO): Done Waiting. 2019-07-22T21:57:27.906Z,1563832647.906 [Default:A.Wait] Stopped 2019-07-22T21:57:27.906Z,1563832647.906 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2019-07-22T21:57:28.313Z,1563832648.313 [Default:CheckIn] Running Loop=1 2019-07-22T21:57:28.313Z,1563832648.313 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-07-22T21:57:28.313Z,1563832648.313 [Default:CheckIn:Read_GPS] Running Loop=1 2019-07-22T21:57:28.708Z,1563832648.708 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2019-07-22T21:57:31.925Z,1563832651.925 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2019-07-22T21:57:31.925Z,1563832651.925 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2019-07-22T21:57:31.926Z,1563832651.926 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2019-07-22T21:57:31.936Z,1563832651.936 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2019-07-22T21:57:32.344Z,1563832652.344 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2019-07-22T21:57:32.344Z,1563832652.344 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2019-07-22T21:57:48.445Z,1563832668.445 [CommandLine](IMPORTANT): got command quit 2019-07-22T21:57:49.452Z,1563832669.452 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-22T21:57:49.452Z,1563832669.452 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-07-22T21:57:49.639Z,1563832669.639 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2019-07-22T21:57:49.640Z,1563832669.640 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-07-22T21:57:49.640Z,1563832669.640 [CommandLine](INFO): Join timeout helper Thread ID is 5221 2019-07-22T21:57:49.651Z,1563832669.651 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2019-07-22T21:57:49.652Z,1563832669.652 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-07-22T21:57:49.652Z,1563832669.652 [NavChartDb](INFO): Join timeout helper Thread ID is 5222 2019-07-22T21:57:49.824Z,1563832669.824 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-22T21:57:49.824Z,1563832669.824 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-07-22T21:57:49.828Z,1563832669.828 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2019-07-22T21:57:49.828Z,1563832669.828 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-07-22T21:57:49.828Z,1563832669.828 [Radio_Surface](INFO): Join timeout helper Thread ID is 5223 2019-07-22T21:57:50.216Z,1563832670.216 [Radio_Surface](INFO): Powering down 2019-07-22T21:57:50.216Z,1563832670.216 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-22T21:57:50.217Z,1563832670.217 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-07-22T21:57:50.220Z,1563832670.220 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2019-07-22T21:57:50.220Z,1563832670.220 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-07-22T21:57:50.220Z,1563832670.220 [DataOverHttps](INFO): Join timeout helper Thread ID is 5224 2019-07-22T21:57:54.702Z,1563832674.702 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-22T21:57:54.706Z,1563832674.706 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-07-22T21:57:54.724Z,1563832674.724 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2019-07-22T21:57:54.724Z,1563832674.724 [logger ThreadHandler](INFO): Thread cancelled. 2019-07-22T21:57:54.724Z,1563832674.724 [logger](INFO): Join timeout helper Thread ID is 5225 2019-07-22T21:57:54.732Z,1563832674.732 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-22T21:57:54.732Z,1563832674.732 [logger ThreadHandler](INFO): Thread cancelled. 2019-07-22T21:57:54.744Z,1563832674.744 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2019-07-22T21:57:54.744Z,1563832674.744 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-07-22T21:57:54.745Z,1563832674.745 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2019-07-22T21:57:54.745Z,1563832674.745 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-07-22T21:57:54.745Z,1563832674.745 [controlThread](INFO): Join timeout helper Thread ID is 5226 2019-07-22T21:57:54.920Z,1563832674.920 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2019-07-22T21:57:54.920Z,1563832674.920 [controlThread](DEBUG): Uninitializing ControlThread 2019-07-22T21:57:54.920Z,1563832674.920 [Aanderaa_O2](INFO): Powering down 2019-07-22T21:57:54.941Z,1563832674.941 [AHRS_M2](INFO): Powering down 2019-07-22T21:57:54.942Z,1563832674.942 [NAL9602](INFO): Powering down 2019-07-22T21:57:54.944Z,1563832674.944 [DAT](INFO): Powering down 2019-07-22T21:57:55.065Z,1563832675.065 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2019-07-22T21:57:55.066Z,1563832675.066 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2019-07-22T21:57:55.066Z,1563832675.066 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2019-07-22T21:57:55.066Z,1563832675.066 [MissionManager](INFO): Uninitializing Mission Default 2019-07-22T21:57:55.067Z,1563832675.067 [Default] Stopped 2019-07-22T21:57:55.067Z,1563832675.067 [Default](DEBUG): Aggregate::uninitialize Default 2019-07-22T21:57:55.067Z,1563832675.067 [Default:B.GoToSurface] Stopped 2019-07-22T21:57:55.067Z,1563832675.067 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-07-22T21:57:55.067Z,1563832675.067 [Default:CheckIn] Stopped 2019-07-22T21:57:55.067Z,1563832675.067 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-07-22T21:57:55.067Z,1563832675.067 [Default:CheckIn:Read_GPS] Stopped 2019-07-22T21:57:55.069Z,1563832675.069 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2019-07-22T21:57:55.070Z,1563832675.070 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2019-07-22T21:57:55.070Z,1563832675.070 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2019-07-22T21:57:55.070Z,1563832675.070 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2019-07-22T21:57:55.071Z,1563832675.071 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2019-07-22T21:57:55.071Z,1563832675.071 [BuoyancyServo](INFO): Powering down 2019-07-22T21:57:55.083Z,1563832675.083 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2019-07-22T21:57:55.084Z,1563832675.084 [ElevatorServo](INFO): Powering down 2019-07-22T21:57:55.084Z,1563832675.084 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-07-22T21:57:55.085Z,1563832675.085 [MassServo](INFO): Powering down 2019-07-22T21:57:55.085Z,1563832675.085 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-07-22T21:57:55.085Z,1563832675.085 [RudderServo](INFO): Powering down 2019-07-22T21:57:55.086Z,1563832675.086 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2019-07-22T21:57:55.086Z,1563832675.086 [ThrusterServo](INFO): Powering down 2019-07-22T21:57:55.087Z,1563832675.087 [SBIT](DEBUG): Uninitialize SBIT Component. 2019-07-22T21:57:55.088Z,1563832675.088 [IBIT](DEBUG): Uninitialize IBIT Component. 2019-07-22T21:57:55.088Z,1563832675.088 [CBIT](DEBUG): Uninitialize CBIT Component. 2019-07-22T21:57:55.088Z,1563832675.088 [CBIT](DEBUG): Powering off loads. 2019-07-22T21:57:55.099Z,1563832675.099 [CBIT](DEBUG): Disabling WDT. 2019-07-22T21:57:55.111Z,1563832675.111 [CBIT](DEBUG): Opening all GF detection circuits. 2019-07-22T21:57:55.112Z,1563832675.112 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-07-22T21:57:55.205Z,1563832675.205 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-07-22T21:57:55.211Z,1563832675.211 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-07-22T21:57:55.261Z,1563832675.261 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-07-22T21:57:55.318Z,1563832675.318 [logger ThreadHandler](INFO): Thread cancelled.