2018-11-16T00:12:40.085Z,1542327160.085 [Supervisor](DEBUG): Initializing supervisor. 2018-11-16T00:12:40.088Z,1542327160.088 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2018-11-16T00:12:40.089Z,1542327160.089 [SyncHandler](INFO): Protected caller Thread ID is 7735 2018-11-16T00:12:40.089Z,1542327160.089 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2018-11-16T00:12:40.090Z,1542327160.090 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2018-11-16T00:12:40.090Z,1542327160.090 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 7736 2018-11-16T00:12:40.093Z,1542327160.093 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2018-11-16T00:12:40.105Z,1542327160.105 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2018-11-16T00:12:40.106Z,1542327160.106 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2018-11-16T00:12:40.106Z,1542327160.106 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 7737 2018-11-16T00:12:40.107Z,1542327160.107 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2018-11-16T00:12:40.108Z,1542327160.108 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2018-11-16T00:12:40.108Z,1542327160.108 [logger ThreadHandler](INFO): Protected caller Thread ID is 7738 2018-11-16T00:12:40.110Z,1542327160.110 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2018-11-16T00:12:40.110Z,1542327160.110 [Supervisor](INFO): Looking for Config files in directory: Config/ 2018-11-16T00:12:40.112Z,1542327160.112 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2018-11-16T00:12:40.211Z,1542327160.211 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2018-11-16T00:12:40.212Z,1542327160.212 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2018-11-16T00:12:40.311Z,1542327160.311 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2018-11-16T00:12:40.312Z,1542327160.312 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2018-11-16T00:12:40.511Z,1542327160.511 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2018-11-16T00:12:40.512Z,1542327160.512 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2018-11-16T00:12:40.849Z,1542327160.849 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2018-11-16T00:12:40.850Z,1542327160.850 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2018-11-16T00:12:41.244Z,1542327161.244 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2018-11-16T00:12:41.244Z,1542327161.244 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2018-11-16T00:12:41.767Z,1542327161.767 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2018-11-16T00:12:41.768Z,1542327161.768 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2018-11-16T00:12:42.238Z,1542327162.238 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2018-11-16T00:12:42.239Z,1542327162.239 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2018-11-16T00:12:42.696Z,1542327162.696 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2018-11-16T00:12:42.697Z,1542327162.697 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2018-11-16T00:12:42.777Z,1542327162.777 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2018-11-16T00:12:43.105Z,1542327163.105 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2018-11-16T00:12:43.105Z,1542327163.105 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2018-11-16T00:12:43.255Z,1542327163.255 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2018-11-16T00:12:43.255Z,1542327163.255 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2018-11-16T00:12:43.472Z,1542327163.472 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2018-11-16T00:12:43.473Z,1542327163.473 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2018-11-16T00:12:43.681Z,1542327163.681 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2018-11-16T00:12:43.682Z,1542327163.682 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2018-11-16T00:12:43.779Z,1542327163.779 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2018-11-16T00:12:43.780Z,1542327163.780 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2018-11-16T00:12:43.926Z,1542327163.926 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2018-11-16T00:12:43.928Z,1542327163.928 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2018-11-16T00:12:43.928Z,1542327163.928 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2018-11-16T00:12:44.161Z,1542327164.161 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2018-11-16T00:12:44.161Z,1542327164.161 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2018-11-16T00:12:44.266Z,1542327164.266 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2018-11-16T00:12:44.416Z,1542327164.416 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2018-11-16T00:12:44.508Z,1542327164.508 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2018-11-16T00:12:44.593Z,1542327164.593 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2018-11-16T00:12:44.750Z,1542327164.750 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2018-11-16T00:12:44.948Z,1542327164.948 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2018-11-16T00:12:45.045Z,1542327165.045 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2018-11-16T00:12:45.140Z,1542327165.140 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2018-11-16T00:12:45.237Z,1542327165.237 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2018-11-16T00:12:45.320Z,1542327165.320 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2018-11-16T00:12:45.320Z,1542327165.320 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2018-11-16T00:12:45.324Z,1542327165.324 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2018-11-16T00:12:45.429Z,1542327165.429 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2018-11-16T00:12:45.430Z,1542327165.430 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2018-11-16T00:12:45.443Z,1542327165.443 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2018-11-16T00:12:45.444Z,1542327165.444 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2018-11-16T00:12:45.487Z,1542327165.487 [DepthRateCalculator] Loaded 2018-11-16T00:12:45.487Z,1542327165.487 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2018-11-16T00:12:45.493Z,1542327165.493 [PitchRateCalculator] Loaded 2018-11-16T00:12:45.494Z,1542327165.494 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2018-11-16T00:12:45.510Z,1542327165.510 [SpeedCalculator] Loaded 2018-11-16T00:12:45.510Z,1542327165.510 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2018-11-16T00:12:45.531Z,1542327165.531 [TempGradientCalculator] Loaded 2018-11-16T00:12:45.532Z,1542327165.532 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2018-11-16T00:12:45.537Z,1542327165.537 [YawRateCalculator] Loaded 2018-11-16T00:12:45.538Z,1542327165.538 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2018-11-16T00:12:45.578Z,1542327165.578 [ElevatorOffsetCalculator] Loaded 2018-11-16T00:12:45.578Z,1542327165.578 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2018-11-16T00:12:45.579Z,1542327165.579 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2018-11-16T00:12:45.579Z,1542327165.579 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2018-11-16T00:12:45.605Z,1542327165.605 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2018-11-16T00:12:45.606Z,1542327165.606 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2018-11-16T00:12:45.881Z,1542327165.881 [AcousticModem_Benthos_ATM900] Loaded 2018-11-16T00:12:45.881Z,1542327165.881 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread. 2018-11-16T00:12:45.956Z,1542327165.956 [DataOverHttps] Loaded 2018-11-16T00:12:45.956Z,1542327165.956 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2018-11-16T00:12:45.970Z,1542327165.970 [Depth_Keller] Loaded 2018-11-16T00:12:45.970Z,1542327165.970 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2018-11-16T00:12:45.975Z,1542327165.975 [DropWeight] Loaded 2018-11-16T00:12:45.975Z,1542327165.975 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2018-11-16T00:12:46.075Z,1542327166.075 [NAL9602] Loaded 2018-11-16T00:12:46.075Z,1542327166.075 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2018-11-16T00:12:46.091Z,1542327166.091 [Onboard] Loaded 2018-11-16T00:12:46.092Z,1542327166.092 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2018-11-16T00:12:46.102Z,1542327166.102 [Radio_Surface] Loaded 2018-11-16T00:12:46.102Z,1542327166.102 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2018-11-16T00:12:46.103Z,1542327166.103 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407C24E0 2018-11-16T00:12:46.104Z,1542327166.104 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 7817 2018-11-16T00:12:46.152Z,1542327166.152 [PNI_TCM] Loaded 2018-11-16T00:12:46.152Z,1542327166.152 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2018-11-16T00:12:46.215Z,1542327166.215 [Rowe_600LCM] Loaded 2018-11-16T00:12:46.215Z,1542327166.215 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread. 2018-11-16T00:12:46.216Z,1542327166.216 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 407F24E0 2018-11-16T00:12:46.216Z,1542327166.216 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 7818 2018-11-16T00:12:48.626Z,1542327168.626 [BPC1] Loaded 2018-11-16T00:12:48.626Z,1542327168.626 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2018-11-16T00:12:48.626Z,1542327168.626 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2018-11-16T00:12:48.627Z,1542327168.627 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2018-11-16T00:12:48.766Z,1542327168.766 [SBIT](DEBUG): Construct Startup Built In Test. 2018-11-16T00:12:48.789Z,1542327168.789 [SBIT] Loaded 2018-11-16T00:12:48.790Z,1542327168.790 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2018-11-16T00:12:48.790Z,1542327168.790 [IBIT](DEBUG): Construct Initiated Built In Test. 2018-11-16T00:12:48.802Z,1542327168.802 [IBIT] Loaded 2018-11-16T00:12:48.802Z,1542327168.802 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2018-11-16T00:12:48.805Z,1542327168.805 [CBIT](DEBUG): Construct Continuous Built In Test. 2018-11-16T00:12:48.958Z,1542327168.958 [CBIT] Loaded 2018-11-16T00:12:48.958Z,1542327168.958 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2018-11-16T00:12:48.958Z,1542327168.958 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2018-11-16T00:12:48.959Z,1542327168.959 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2018-11-16T00:12:49.126Z,1542327169.126 [Aanderaa_O2] Loaded 2018-11-16T00:12:49.126Z,1542327169.126 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2018-11-16T00:12:49.185Z,1542327169.185 [CTD_Seabird] Loaded 2018-11-16T00:12:49.185Z,1542327169.185 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2018-11-16T00:12:49.186Z,1542327169.186 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 408C74E0 2018-11-16T00:12:49.186Z,1542327169.186 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 7819 2018-11-16T00:12:49.204Z,1542327169.204 [ESPComponent] Loaded 2018-11-16T00:12:49.204Z,1542327169.204 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2018-11-16T00:12:49.218Z,1542327169.218 [PAR_Licor] Loaded 2018-11-16T00:12:49.219Z,1542327169.219 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2018-11-16T00:12:49.269Z,1542327169.269 [WetLabsBB2FL] Loaded 2018-11-16T00:12:49.269Z,1542327169.269 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2018-11-16T00:12:49.270Z,1542327169.270 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 408F74E0 2018-11-16T00:12:49.270Z,1542327169.270 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 7820 2018-11-16T00:12:49.271Z,1542327169.271 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2018-11-16T00:12:49.272Z,1542327169.272 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2018-11-16T00:12:49.526Z,1542327169.526 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2018-11-16T00:12:49.526Z,1542327169.526 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2018-11-16T00:12:49.598Z,1542327169.598 [VerticalControl](DEBUG): Construct VerticalControl. 2018-11-16T00:12:49.694Z,1542327169.694 [VerticalControl] Loaded 2018-11-16T00:12:49.694Z,1542327169.694 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2018-11-16T00:12:49.695Z,1542327169.695 [HorizontalControl](DEBUG): Construct HorizontalControl. 2018-11-16T00:12:49.757Z,1542327169.757 [HorizontalControl] Loaded 2018-11-16T00:12:49.757Z,1542327169.757 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2018-11-16T00:12:49.758Z,1542327169.758 [SpeedControl](DEBUG): Construct SpeedControl. 2018-11-16T00:12:49.763Z,1542327169.763 [SpeedControl] Loaded 2018-11-16T00:12:49.763Z,1542327169.763 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2018-11-16T00:12:49.764Z,1542327169.764 [LoopControl](DEBUG): Construct LoopControl. 2018-11-16T00:12:49.764Z,1542327169.764 [LoopControl] Loaded 2018-11-16T00:12:49.765Z,1542327169.765 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2018-11-16T00:12:49.765Z,1542327169.765 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2018-11-16T00:12:49.766Z,1542327169.766 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2018-11-16T00:12:49.833Z,1542327169.833 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2018-11-16T00:12:49.834Z,1542327169.834 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2018-11-16T00:12:49.937Z,1542327169.937 [BuoyancyServo] Loaded 2018-11-16T00:12:49.937Z,1542327169.937 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2018-11-16T00:12:49.948Z,1542327169.948 [ElevatorServo] Loaded 2018-11-16T00:12:49.949Z,1542327169.949 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2018-11-16T00:12:49.960Z,1542327169.960 [MassServo] Loaded 2018-11-16T00:12:49.960Z,1542327169.960 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2018-11-16T00:12:49.972Z,1542327169.972 [RudderServo] Loaded 2018-11-16T00:12:49.972Z,1542327169.972 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2018-11-16T00:12:49.983Z,1542327169.983 [ThrusterServo] Loaded 2018-11-16T00:12:49.983Z,1542327169.983 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2018-11-16T00:12:49.983Z,1542327169.983 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2018-11-16T00:12:49.984Z,1542327169.984 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2018-11-16T00:12:50.077Z,1542327170.077 [DeadReckonUsingSpeedCalculator] Loaded 2018-11-16T00:12:50.077Z,1542327170.077 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2018-11-16T00:12:50.093Z,1542327170.093 [NavChart] Loaded 2018-11-16T00:12:50.094Z,1542327170.094 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2018-11-16T00:12:50.098Z,1542327170.098 [UniversalFixResidualReporter] Loaded 2018-11-16T00:12:50.098Z,1542327170.098 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2018-11-16T00:12:50.098Z,1542327170.098 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2018-11-16T00:12:50.102Z,1542327170.102 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2018-11-16T00:12:50.103Z,1542327170.103 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2018-11-16T00:12:50.110Z,1542327170.110 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2018-11-16T00:12:50.111Z,1542327170.111 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A504E0 2018-11-16T00:12:50.111Z,1542327170.111 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 7821 2018-11-16T00:12:50.116Z,1542327170.116 [Supervisor](INFO): Main Thread ID is 7556 2018-11-16T00:12:50.116Z,1542327170.116 [Supervisor](DEBUG): Running supervisor. 2018-11-16T00:12:50.116Z,1542327170.116 [CommandLine ThreadHandler](INFO): Handler Thread ID is 7822 2018-11-16T00:12:50.119Z,1542327170.119 [controlThread ThreadHandler](INFO): Handler Thread ID is 7823 2018-11-16T00:12:50.119Z,1542327170.119 [controlThread](DEBUG): Initializing ControlThread 2018-11-16T00:12:50.120Z,1542327170.120 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-11-16T00:12:50.120Z,1542327170.120 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2018-11-16T00:12:50.121Z,1542327170.121 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2018-11-16T00:12:50.121Z,1542327170.121 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2018-11-16T00:12:50.122Z,1542327170.122 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2018-11-16T00:12:50.122Z,1542327170.122 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2018-11-16T00:12:50.129Z,1542327170.129 [SBIT](INFO): Initialize SBIT Component. 2018-11-16T00:12:50.129Z,1542327170.129 [SBIT](IMPORTANT): git: 2018-11-05-3-g424fd37 2018-11-16T00:12:50.130Z,1542327170.130 [SBIT](INFO): git hash: 424fd377e53a63ada65ca308b07209cf4fd40d4d 2018-11-16T00:12:50.130Z,1542327170.130 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2018-11-16T00:12:50.131Z,1542327170.131 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018 2018-11-16T00:12:50.132Z,1542327170.132 [SBIT](INFO): Beginning SBIT in 24.000000 seconds. 2018-11-16T00:12:50.132Z,1542327170.132 [IBIT](INFO): Initialize IBIT Component. 2018-11-16T00:12:50.133Z,1542327170.133 [CBIT](DEBUG): Initialize CBIT Component. 2018-11-16T00:12:50.133Z,1542327170.133 [CBIT](DEBUG): Initialized mux pins. 2018-11-16T00:12:50.134Z,1542327170.134 [CBIT](DEBUG): Initializing the watchdog timer. 2018-11-16T00:12:50.135Z,1542327170.135 [logger ThreadHandler](INFO): Handler Thread ID is 7824 2018-11-16T00:12:50.155Z,1542327170.155 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 7825 2018-11-16T00:12:50.161Z,1542327170.161 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2018-11-16T00:12:50.161Z,1542327170.161 [CBIT](DEBUG): Initializing heartbeat. 2018-11-16T00:12:50.161Z,1542327170.161 [Radio_Surface](INFO): Powering up 2018-11-16T00:12:50.167Z,1542327170.167 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 7826 2018-11-16T00:12:50.167Z,1542327170.167 [Rowe_600LCM](INFO): Initializing 2018-11-16T00:12:50.168Z,1542327170.168 [Rowe_600LCM](INFO): Checking LCM 2018-11-16T00:12:50.177Z,1542327170.177 [Rowe_600LCM](INFO): LCM OK 2018-11-16T00:12:50.177Z,1542327170.177 [Rowe_600LCM](INFO): Powering up 2018-11-16T00:12:50.183Z,1542327170.183 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 7827 2018-11-16T00:12:50.184Z,1542327170.184 [CTD_Seabird](INFO): Initializing 2018-11-16T00:12:50.184Z,1542327170.184 [CTD_Seabird](INFO): Checking LCM 2018-11-16T00:12:50.184Z,1542327170.184 [CTD_Seabird](INFO): LCM OK 2018-11-16T00:12:50.184Z,1542327170.184 [CTD_Seabird](INFO): Powering up 2018-11-16T00:12:50.195Z,1542327170.195 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 7828 2018-11-16T00:12:50.196Z,1542327170.196 [WetLabsBB2FL](INFO): Powering down 2018-11-16T00:12:50.223Z,1542327170.223 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 7829 2018-11-16T00:12:50.226Z,1542327170.226 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2018-11-16T00:12:50.226Z,1542327170.226 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2018-11-16T00:12:50.227Z,1542327170.227 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2018-11-16T00:12:50.227Z,1542327170.227 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2018-11-16T00:12:50.227Z,1542327170.227 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2018-11-16T00:12:50.227Z,1542327170.227 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2018-11-16T00:12:50.227Z,1542327170.227 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2018-11-16T00:12:50.228Z,1542327170.228 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2018-11-16T00:12:50.228Z,1542327170.228 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2018-11-16T00:12:50.228Z,1542327170.228 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2018-11-16T00:12:50.228Z,1542327170.228 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2018-11-16T00:12:50.228Z,1542327170.228 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2018-11-16T00:12:50.229Z,1542327170.229 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2018-11-16T00:12:50.229Z,1542327170.229 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2018-11-16T00:12:50.229Z,1542327170.229 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2018-11-16T00:12:50.229Z,1542327170.229 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2018-11-16T00:12:50.230Z,1542327170.230 [CBIT](DEBUG): Deactivating GF circuits. 2018-11-16T00:12:50.231Z,1542327170.231 [CBIT](DEBUG): Deactivating emergency mode. 2018-11-16T00:12:50.269Z,1542327170.269 [CBIT](INFO): Reporting lpc3250 register adresses and status: LPC3Reg::P3MuxClrPhys_ (0x40418114) = 0 LPC3Reg::TimClkCtrl_ (0x400200bc) = 1 LPC3Reg::WDTimCtrl_ (0x4041f004) = 1 LPC3Reg::WDTimMCtrl_ (0x4041f00c) = 17 LPC3Reg::WDTimEMR_ (0x4041f014) = 32 LPC3Reg::PioOutpClrPhys_ (0x40418008) = 0 LPC3Reg::PioOutpSetPhys_ (0x40418004) = 0 2018-11-16T00:12:50.271Z,1542327170.271 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2018-11-16T00:12:50.273Z,1542327170.273 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2018-11-16T00:12:50.273Z,1542327170.273 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2018-11-16T00:12:50.274Z,1542327170.274 [LoopControl](DEBUG): Initialize LoopControlComponent. 2018-11-16T00:12:50.275Z,1542327170.275 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-16T00:12:50.276Z,1542327170.276 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-16T00:12:50.277Z,1542327170.277 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-16T00:12:50.277Z,1542327170.277 [NavChart](DEBUG): Initialize NavChart Navigation. 2018-11-16T00:12:50.277Z,1542327170.277 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2018-11-16T00:12:50.278Z,1542327170.278 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2018-11-16T00:12:50.302Z,1542327170.302 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2018-11-16T00:12:50.333Z,1542327170.333 [MissionManager](DEBUG): 2018-11-16T00:12:50.334Z,1542327170.334 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2018-11-16T00:12:50.424Z,1542327170.424 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2018-11-16T00:12:50.425Z,1542327170.425 [Default:A.Wait](DEBUG): Construct Wait. 2018-11-16T00:12:50.427Z,1542327170.427 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2018-11-16T00:12:50.457Z,1542327170.457 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2018-11-16T00:12:50.482Z,1542327170.482 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2018-11-16T00:12:50.504Z,1542327170.504 [Default:E.Execute](DEBUG): Construct Execute. 2018-11-16T00:12:50.508Z,1542327170.508 [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 2018-11-16T00:12:50.527Z,1542327170.527 [controlThread](DEBUG): Component order: CycleStarter,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,Aanderaa_O2,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2018-11-16T00:12:50.544Z,1542327170.544 [AcousticModem_Benthos_ATM900](INFO): Powering up 2018-11-16T00:12:50.545Z,1542327170.545 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900. 2018-11-16T00:12:50.569Z,1542327170.569 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2018-11-16T00:12:50.879Z,1542327170.879 [ESPComponent](INFO): powering down ESP 2018-11-16T00:12:51.380Z,1542327171.380 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:12:51.387Z,1542327171.387 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-16T00:12:51.409Z,1542327171.409 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:12:51.415Z,1542327171.415 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-11-16T00:12:51.437Z,1542327171.437 [MassServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:12:51.443Z,1542327171.443 [MassServo](DEBUG): Initializing MassServo. 2018-11-16T00:12:51.448Z,1542327171.448 [RudderServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:12:51.455Z,1542327171.455 [RudderServo](DEBUG): Initializing RudderServo. 2018-11-16T00:12:51.476Z,1542327171.476 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:12:51.483Z,1542327171.483 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-16T00:12:51.652Z,1542327171.652 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2018-11-16T00:12:51.652Z,1542327171.652 [DropWeight] Hardware Fault, FailCount= 1 2018-11-16T00:12:51.652Z,1542327171.652 [DropWeight](ERROR): Hardware Fault 2018-11-16T00:12:51.747Z,1542327171.747 [CommandLine](FAULT): Scheduling is paused 2018-11-16T00:12:51.748Z,1542327171.748 [CBIT](INFO): Critical error at 20181116T001251 2018-11-16T00:12:51.748Z,1542327171.748 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2018-11-16T00:12:51.751Z,1542327171.751 [CBIT](ERROR): Hardware Fault in component: DropWeight 2018-11-16T00:12:51.751Z,1542327171.751 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2018-11-16T00:12:52.398Z,1542327172.398 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-16T00:12:52.399Z,1542327172.399 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-16T00:12:52.399Z,1542327172.399 [BuoyancyServo] Communications Fault, FailCount= 1 2018-11-16T00:12:52.399Z,1542327172.399 [BuoyancyServo](ERROR): Communications Fault 2018-11-16T00:12:52.710Z,1542327172.710 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2018-11-16T00:12:52.711Z,1542327172.711 [ElevatorServo](FAULT): Elevator failed to initialize 2018-11-16T00:12:52.711Z,1542327172.711 [ElevatorServo] Communications Fault, FailCount= 1 2018-11-16T00:12:52.711Z,1542327172.711 [ElevatorServo](ERROR): Communications Fault 2018-11-16T00:12:53.015Z,1542327173.015 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2018-11-16T00:12:53.015Z,1542327173.015 [RudderServo](FAULT): Rudder failed to initialize 2018-11-16T00:12:53.015Z,1542327173.015 [RudderServo] Communications Fault, FailCount= 1 2018-11-16T00:12:53.015Z,1542327173.015 [RudderServo](ERROR): Communications Fault 2018-11-16T00:12:53.338Z,1542327173.338 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-11-16T00:12:53.662Z,1542327173.662 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2018-11-16T00:12:53.663Z,1542327173.663 [ThrusterServo](FAULT): Thruster failed to initialize 2018-11-16T00:12:53.663Z,1542327173.663 [ThrusterServo] Communications Fault, FailCount= 1 2018-11-16T00:12:53.663Z,1542327173.663 [ThrusterServo](ERROR): Communications Fault 2018-11-16T00:12:53.665Z,1542327173.665 [CBIT](INFO): Critical error at 20181116T001251 2018-11-16T00:12:53.667Z,1542327173.667 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-16T00:12:53.667Z,1542327173.667 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2018-11-16T00:12:53.668Z,1542327173.668 [CBIT](ERROR): Communications Fault in component: RudderServo 2018-11-16T00:12:53.668Z,1542327173.668 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-11-16T00:12:53.740Z,1542327173.740 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-11-16T00:12:53.741Z,1542327173.741 [ElevatorServo](INFO): Powering down 2018-11-16T00:12:54.150Z,1542327174.150 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout 2018-11-16T00:12:54.150Z,1542327174.150 [MassServo] Communications Fault, FailCount= 1 2018-11-16T00:12:54.151Z,1542327174.151 [MassServo](ERROR): Communications Fault 2018-11-16T00:12:54.151Z,1542327174.151 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-11-16T00:12:54.151Z,1542327174.151 [RudderServo](INFO): Powering down 2018-11-16T00:12:54.177Z,1542327174.177 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-16T00:12:54.177Z,1542327174.177 [ThrusterServo](INFO): Powering down 2018-11-16T00:12:54.295Z,1542327174.295 [CBIT](ERROR): Communications Fault in component: MassServo 2018-11-16T00:12:54.418Z,1542327174.418 [ElevatorServo](FAULT): LCB fault: Current Limiter Activated. 2018-11-16T00:12:54.418Z,1542327174.418 [ElevatorServo] Hardware Fault, FailCount= 1 2018-11-16T00:12:54.418Z,1542327174.418 [ElevatorServo](ERROR): Hardware Fault 2018-11-16T00:12:54.443Z,1542327174.443 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-11-16T00:12:54.443Z,1542327174.443 [MassServo](INFO): Powering down 2018-11-16T00:12:54.494Z,1542327174.494 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2018-11-16T00:12:54.536Z,1542327174.536 [RudderServo](FAULT): LCB fault: Current Limiter Activated. 2018-11-16T00:12:54.536Z,1542327174.536 [RudderServo] Hardware Fault, FailCount= 1 2018-11-16T00:12:54.536Z,1542327174.536 [RudderServo](ERROR): Hardware Fault 2018-11-16T00:12:54.609Z,1542327174.609 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null & 2018-11-16T00:12:54.664Z,1542327174.664 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track 2018-11-16T00:12:54.665Z,1542327174.665 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity 2018-11-16T00:12:54.665Z,1542327174.665 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe 2018-11-16T00:12:54.801Z,1542327174.801 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:12:54.802Z,1542327174.802 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-11-16T00:12:54.815Z,1542327174.815 [MassServo](FAULT): LCB fault: Current Limiter Activated. 2018-11-16T00:12:54.815Z,1542327174.815 [MassServo] Hardware Fault, FailCount= 1 2018-11-16T00:12:54.816Z,1542327174.816 [MassServo](ERROR): Hardware Fault 2018-11-16T00:12:54.817Z,1542327174.817 [RudderServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:12:54.817Z,1542327174.817 [RudderServo](DEBUG): Initializing RudderServo. 2018-11-16T00:12:54.835Z,1542327174.835 [CBIT](INFO): Clearing failed state for component ElevatorServo 2018-11-16T00:12:54.835Z,1542327174.835 [ElevatorServo] No Fault, FailCount= 1 2018-11-16T00:12:54.835Z,1542327174.835 [CBIT](INFO): Clearing failed state for component RudderServo 2018-11-16T00:12:54.835Z,1542327174.835 [RudderServo] No Fault, FailCount= 1 2018-11-16T00:12:54.835Z,1542327174.835 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-11-16T00:12:54.835Z,1542327174.835 [ThrusterServo] No Fault, FailCount= 1 2018-11-16T00:12:55.185Z,1542327175.185 [MassServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:12:55.186Z,1542327175.186 [MassServo](DEBUG): Initializing MassServo. 2018-11-16T00:12:55.195Z,1542327175.195 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:12:55.196Z,1542327175.196 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-16T00:12:55.208Z,1542327175.208 [CBIT](INFO): Clearing failed state for component MassServo 2018-11-16T00:12:55.208Z,1542327175.208 [MassServo] No Fault, FailCount= 1 2018-11-16T00:12:55.849Z,1542327175.849 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-11-16T00:12:55.931Z,1542327175.931 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2018-11-16T00:12:55.931Z,1542327175.931 [ElevatorServo](FAULT): Elevator failed to initialize 2018-11-16T00:12:55.931Z,1542327175.931 [ElevatorServo] Communications Fault, FailCount= 2 2018-11-16T00:12:55.931Z,1542327175.931 [ElevatorServo](ERROR): Communications Fault 2018-11-16T00:12:55.981Z,1542327175.981 [CTD_Seabird](INFO): Started Seabird LCM interface with command:nohup ./lrauv-framework/onboard/bin/gpctd -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyC6 -b 9600 >& /dev/null & 2018-11-16T00:12:55.983Z,1542327175.983 [CTD_Seabird](INFO): LCM subscribed to channel:seabird_gpctd_t.seabird-gpctd 2018-11-16T00:12:56.239Z,1542327176.239 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2018-11-16T00:12:56.239Z,1542327176.239 [RudderServo](FAULT): Rudder failed to initialize 2018-11-16T00:12:56.239Z,1542327176.239 [RudderServo] Communications Fault, FailCount= 2 2018-11-16T00:12:56.239Z,1542327176.239 [RudderServo](ERROR): Communications Fault 2018-11-16T00:12:56.291Z,1542327176.291 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-11-16T00:12:56.291Z,1542327176.291 [CTD_Seabird](INFO): Powering down 2018-11-16T00:12:56.562Z,1542327176.562 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-11-16T00:12:56.886Z,1542327176.886 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2018-11-16T00:12:56.887Z,1542327176.887 [ThrusterServo](FAULT): Thruster failed to initialize 2018-11-16T00:12:56.887Z,1542327176.887 [ThrusterServo] Communications Fault, FailCount= 2 2018-11-16T00:12:56.887Z,1542327176.887 [ThrusterServo](ERROR): Communications Fault 2018-11-16T00:12:56.892Z,1542327176.892 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2018-11-16T00:12:56.892Z,1542327176.892 [CBIT](ERROR): Communications Fault in component: RudderServo 2018-11-16T00:12:56.892Z,1542327176.892 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-11-16T00:12:57.013Z,1542327177.013 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-11-16T00:12:57.014Z,1542327177.014 [ElevatorServo](INFO): Powering down 2018-11-16T00:12:57.326Z,1542327177.326 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout 2018-11-16T00:12:57.327Z,1542327177.327 [MassServo] Communications Fault, FailCount= 2 2018-11-16T00:12:57.327Z,1542327177.327 [MassServo](ERROR): Communications Fault 2018-11-16T00:12:57.327Z,1542327177.327 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-11-16T00:12:57.327Z,1542327177.327 [RudderServo](INFO): Powering down 2018-11-16T00:12:57.329Z,1542327177.329 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-16T00:12:57.329Z,1542327177.329 [ThrusterServo](INFO): Powering down 2018-11-16T00:12:57.333Z,1542327177.333 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-11-16T00:12:57.333Z,1542327177.333 [BuoyancyServo] No Fault, FailCount= 1 2018-11-16T00:12:57.334Z,1542327177.334 [CBIT](ERROR): Communications Fault in component: MassServo 2018-11-16T00:12:57.436Z,1542327177.436 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:12:57.436Z,1542327177.436 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-16T00:12:57.437Z,1542327177.437 [ElevatorServo](FAULT): LCB fault: Current Limiter Activated. 2018-11-16T00:12:57.437Z,1542327177.437 [ElevatorServo] Hardware Fault, FailCount= 2 2018-11-16T00:12:57.437Z,1542327177.437 [ElevatorServo](ERROR): Hardware Fault 2018-11-16T00:12:57.438Z,1542327177.438 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-11-16T00:12:57.442Z,1542327177.442 [MassServo](INFO): Powering down 2018-11-16T00:12:57.444Z,1542327177.444 [RudderServo](FAULT): LCB fault: Current Limiter Activated. 2018-11-16T00:12:57.444Z,1542327177.444 [RudderServo] Hardware Fault, FailCount= 2 2018-11-16T00:12:57.444Z,1542327177.444 [RudderServo](ERROR): Hardware Fault 2018-11-16T00:12:57.828Z,1542327177.828 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:12:57.828Z,1542327177.828 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-11-16T00:12:57.829Z,1542327177.829 [MassServo](FAULT): LCB fault: Current Limiter Activated. 2018-11-16T00:12:57.829Z,1542327177.829 [MassServo] Hardware Fault, FailCount= 2 2018-11-16T00:12:57.830Z,1542327177.830 [MassServo](ERROR): Hardware Fault 2018-11-16T00:12:57.835Z,1542327177.835 [RudderServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:12:57.835Z,1542327177.835 [RudderServo](DEBUG): Initializing RudderServo. 2018-11-16T00:12:57.851Z,1542327177.851 [CBIT](INFO): Clearing failed state for component ElevatorServo 2018-11-16T00:12:57.851Z,1542327177.851 [ElevatorServo] No Fault, FailCount= 2 2018-11-16T00:12:57.852Z,1542327177.852 [CBIT](INFO): Clearing failed state for component RudderServo 2018-11-16T00:12:57.852Z,1542327177.852 [RudderServo] No Fault, FailCount= 2 2018-11-16T00:12:57.852Z,1542327177.852 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-11-16T00:12:57.852Z,1542327177.852 [ThrusterServo] No Fault, FailCount= 2 2018-11-16T00:12:58.546Z,1542327178.546 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-16T00:12:58.547Z,1542327178.547 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-16T00:12:58.547Z,1542327178.547 [BuoyancyServo] Communications Fault, FailCount= 2 2018-11-16T00:12:58.547Z,1542327178.547 [BuoyancyServo](ERROR): Communications Fault 2018-11-16T00:12:58.858Z,1542327178.858 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2018-11-16T00:12:58.859Z,1542327178.859 [ElevatorServo](FAULT): Elevator failed to initialize 2018-11-16T00:12:58.859Z,1542327178.859 [ElevatorServo] Communications Fault, FailCount= 3 2018-11-16T00:12:58.859Z,1542327178.859 [ElevatorServo](ERROR): Communications Fault 2018-11-16T00:12:58.860Z,1542327178.860 [MassServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:12:58.860Z,1542327178.860 [MassServo](DEBUG): Initializing MassServo. 2018-11-16T00:12:59.167Z,1542327179.167 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2018-11-16T00:12:59.167Z,1542327179.167 [RudderServo](FAULT): Rudder failed to initialize 2018-11-16T00:12:59.167Z,1542327179.167 [RudderServo] Communications Fault, FailCount= 3 2018-11-16T00:12:59.167Z,1542327179.167 [RudderServo](ERROR): Communications Fault 2018-11-16T00:12:59.168Z,1542327179.168 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:12:59.168Z,1542327179.168 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-16T00:12:59.172Z,1542327179.172 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-16T00:12:59.173Z,1542327179.173 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2018-11-16T00:12:59.173Z,1542327179.173 [CBIT](CRITICAL): Communications Fault in component: ElevatorServo 2018-11-16T00:12:59.173Z,1542327179.173 [CBIT](INFO): Clearing failed state for component MassServo 2018-11-16T00:12:59.173Z,1542327179.173 [MassServo] No Fault, FailCount= 2 2018-11-16T00:12:59.174Z,1542327179.174 [CBIT](ERROR): Communications Fault in component: RudderServo 2018-11-16T00:12:59.174Z,1542327179.174 [CBIT](CRITICAL): Communications Fault in component: RudderServo 2018-11-16T00:12:59.259Z,1542327179.259 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-11-16T00:12:59.260Z,1542327179.260 [ElevatorServo](INFO): Powering down 2018-11-16T00:12:59.262Z,1542327179.262 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-11-16T00:12:59.262Z,1542327179.262 [RudderServo](INFO): Powering down 2018-11-16T00:12:59.269Z,1542327179.269 [CBIT](INFO): Critical error at 20181116T001259 2018-11-16T00:12:59.603Z,1542327179.603 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2018-11-16T00:12:59.603Z,1542327179.603 [PNI_TCM] Data Fault, FailCount= 1 2018-11-16T00:12:59.603Z,1542327179.603 [PNI_TCM](ERROR): Data Fault 2018-11-16T00:12:59.645Z,1542327179.645 [ElevatorServo](FAULT): LCB fault: Current Limiter Activated. 2018-11-16T00:12:59.645Z,1542327179.645 [ElevatorServo] Hardware Fault, FailCount= 3 2018-11-16T00:12:59.645Z,1542327179.645 [ElevatorServo](ERROR): Hardware Fault 2018-11-16T00:12:59.668Z,1542327179.668 [RudderServo](FAULT): LCB fault: Current Limiter Activated. 2018-11-16T00:12:59.669Z,1542327179.669 [RudderServo] Hardware Fault, FailCount= 3 2018-11-16T00:12:59.669Z,1542327179.669 [RudderServo](ERROR): Hardware Fault 2018-11-16T00:13:00.002Z,1542327180.002 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-11-16T00:13:00.326Z,1542327180.326 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2018-11-16T00:13:00.327Z,1542327180.327 [ThrusterServo](FAULT): Thruster failed to initialize 2018-11-16T00:13:00.327Z,1542327180.327 [ThrusterServo] Communications Fault, FailCount= 3 2018-11-16T00:13:00.327Z,1542327180.327 [ThrusterServo](ERROR): Communications Fault 2018-11-16T00:13:00.331Z,1542327180.331 [CBIT](CRITICAL): Environmental Failure. Press:14.795126 PSI. Humidity:34%. Temp:27 C. ABORTING MISSION 2018-11-16T00:13:00.332Z,1542327180.332 [CBIT](ERROR): Data Fault in component: PNI_TCM 2018-11-16T00:13:00.332Z,1542327180.332 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-11-16T00:13:00.358Z,1542327180.358 [PNI_TCM](INFO): Powering down 2018-11-16T00:13:00.453Z,1542327180.453 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:00.453Z,1542327180.453 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-11-16T00:13:00.459Z,1542327180.459 [RudderServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:00.459Z,1542327180.459 [RudderServo](DEBUG): Initializing RudderServo. 2018-11-16T00:13:00.460Z,1542327180.460 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-16T00:13:00.460Z,1542327180.460 [ThrusterServo](INFO): Powering down 2018-11-16T00:13:00.471Z,1542327180.471 [CBIT](INFO): Critical error at 20181116T001300 2018-11-16T00:13:00.814Z,1542327180.814 [BuoyancyServo](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated. 2018-11-16T00:13:00.814Z,1542327180.814 [BuoyancyServo] Hardware Fault, FailCount= 2 2018-11-16T00:13:00.814Z,1542327180.814 [BuoyancyServo](ERROR): Hardware Fault 2018-11-16T00:13:01.134Z,1542327181.134 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout 2018-11-16T00:13:01.134Z,1542327181.134 [MassServo] Communications Fault, FailCount= 3 2018-11-16T00:13:01.135Z,1542327181.135 [MassServo](ERROR): Communications Fault 2018-11-16T00:13:01.139Z,1542327181.139 [CBIT](ERROR): Communications Fault in component: MassServo 2018-11-16T00:13:01.175Z,1542327181.175 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-16T00:13:01.175Z,1542327181.175 [Aanderaa_O2] Communications Fault, FailCount= 1 2018-11-16T00:13:01.175Z,1542327181.175 [Aanderaa_O2](ERROR): Communications Fault 2018-11-16T00:13:01.209Z,1542327181.209 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-11-16T00:13:01.209Z,1542327181.209 [MassServo](INFO): Powering down 2018-11-16T00:13:01.230Z,1542327181.230 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-16T00:13:01.231Z,1542327181.231 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-11-16T00:13:01.231Z,1542327181.231 [BuoyancyServo] No Fault, FailCount= 2 2018-11-16T00:13:01.231Z,1542327181.231 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-11-16T00:13:01.231Z,1542327181.231 [ThrusterServo] No Fault, FailCount= 3 2018-11-16T00:13:01.569Z,1542327181.569 [Aanderaa_O2](INFO): Powering down 2018-11-16T00:13:01.652Z,1542327181.652 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:01.653Z,1542327181.653 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-16T00:13:01.654Z,1542327181.654 [MassServo](FAULT): LCB fault: Current Limiter Activated. 2018-11-16T00:13:01.654Z,1542327181.654 [MassServo] Hardware Fault, FailCount= 3 2018-11-16T00:13:01.654Z,1542327181.654 [MassServo](ERROR): Hardware Fault 2018-11-16T00:13:01.655Z,1542327181.655 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:01.655Z,1542327181.655 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-16T00:13:01.686Z,1542327181.686 [CBIT](INFO): Clearing failed state for component PNI_TCM 2018-11-16T00:13:01.686Z,1542327181.686 [PNI_TCM] No Fault, FailCount= 1 2018-11-16T00:13:02.009Z,1542327182.009 [MassServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:02.009Z,1542327182.009 [MassServo](DEBUG): Initializing MassServo. 2018-11-16T00:13:02.035Z,1542327182.035 [CBIT](INFO): Clearing failed state for component MassServo 2018-11-16T00:13:02.035Z,1542327182.035 [MassServo] No Fault, FailCount= 3 2018-11-16T00:13:02.778Z,1542327182.778 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-16T00:13:02.779Z,1542327182.779 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-16T00:13:02.779Z,1542327182.779 [BuoyancyServo] Communications Fault, FailCount= 3 2018-11-16T00:13:02.779Z,1542327182.779 [BuoyancyServo](ERROR): Communications Fault 2018-11-16T00:13:03.107Z,1542327183.107 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-11-16T00:13:03.431Z,1542327183.431 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2018-11-16T00:13:03.431Z,1542327183.431 [ThrusterServo](FAULT): Thruster failed to initialize 2018-11-16T00:13:03.431Z,1542327183.431 [ThrusterServo] Communications Fault, FailCount= 4 2018-11-16T00:13:03.431Z,1542327183.431 [ThrusterServo](ERROR): Communications Fault 2018-11-16T00:13:03.435Z,1542327183.435 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-11-16T00:13:03.435Z,1542327183.435 [Aanderaa_O2] No Fault, FailCount= 1 2018-11-16T00:13:03.435Z,1542327183.435 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-16T00:13:03.436Z,1542327183.436 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-11-16T00:13:03.514Z,1542327183.514 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-16T00:13:03.514Z,1542327183.514 [ThrusterServo](INFO): Powering down 2018-11-16T00:13:04.226Z,1542327184.226 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout 2018-11-16T00:13:04.226Z,1542327184.226 [MassServo] Communications Fault, FailCount= 4 2018-11-16T00:13:04.227Z,1542327184.227 [MassServo](ERROR): Communications Fault 2018-11-16T00:13:04.231Z,1542327184.231 [CBIT](ERROR): Communications Fault in component: MassServo 2018-11-16T00:13:04.345Z,1542327184.345 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-11-16T00:13:04.345Z,1542327184.345 [MassServo](INFO): Powering down 2018-11-16T00:13:04.359Z,1542327184.359 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-11-16T00:13:04.359Z,1542327184.359 [ThrusterServo] No Fault, FailCount= 4 2018-11-16T00:13:04.717Z,1542327184.717 [MassServo](FAULT): LCB fault: Current Limiter Activated. 2018-11-16T00:13:04.717Z,1542327184.717 [MassServo] Hardware Fault, FailCount= 4 2018-11-16T00:13:04.717Z,1542327184.717 [MassServo](ERROR): Hardware Fault 2018-11-16T00:13:04.718Z,1542327184.718 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:04.726Z,1542327184.726 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-16T00:13:05.128Z,1542327185.128 [BuoyancyServo](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated. 2018-11-16T00:13:05.128Z,1542327185.128 [BuoyancyServo] Hardware Fault, FailCount= 3 2018-11-16T00:13:05.128Z,1542327185.128 [BuoyancyServo](ERROR): Hardware Fault 2018-11-16T00:13:05.129Z,1542327185.129 [MassServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:05.129Z,1542327185.129 [MassServo](DEBUG): Initializing MassServo. 2018-11-16T00:13:05.134Z,1542327185.134 [CBIT](INFO): Clearing failed state for component MassServo 2018-11-16T00:13:05.142Z,1542327185.142 [MassServo] No Fault, FailCount= 4 2018-11-16T00:13:05.842Z,1542327185.842 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-11-16T00:13:06.166Z,1542327186.166 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2018-11-16T00:13:06.167Z,1542327186.167 [ThrusterServo](FAULT): Thruster failed to initialize 2018-11-16T00:13:06.167Z,1542327186.167 [ThrusterServo] Communications Fault, FailCount= 5 2018-11-16T00:13:06.167Z,1542327186.167 [ThrusterServo](ERROR): Communications Fault 2018-11-16T00:13:06.171Z,1542327186.171 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-11-16T00:13:06.171Z,1542327186.171 [BuoyancyServo] No Fault, FailCount= 3 2018-11-16T00:13:06.171Z,1542327186.171 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-11-16T00:13:06.172Z,1542327186.172 [CBIT](CRITICAL): Communications Fault in component: ThrusterServo 2018-11-16T00:13:06.259Z,1542327186.259 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:06.260Z,1542327186.260 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-16T00:13:06.282Z,1542327186.282 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-16T00:13:06.283Z,1542327186.283 [ThrusterServo](INFO): Powering down 2018-11-16T00:13:06.296Z,1542327186.296 [CBIT](INFO): Critical error at 20181116T001306 2018-11-16T00:13:07.386Z,1542327187.386 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-16T00:13:07.387Z,1542327187.387 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-16T00:13:07.387Z,1542327187.387 [BuoyancyServo] Communications Fault, FailCount= 4 2018-11-16T00:13:07.387Z,1542327187.387 [BuoyancyServo](ERROR): Communications Fault 2018-11-16T00:13:07.690Z,1542327187.690 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout 2018-11-16T00:13:07.691Z,1542327187.691 [MassServo] Communications Fault, FailCount= 5 2018-11-16T00:13:07.691Z,1542327187.691 [MassServo](ERROR): Communications Fault 2018-11-16T00:13:07.695Z,1542327187.695 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-16T00:13:07.695Z,1542327187.695 [CBIT](ERROR): Communications Fault in component: MassServo 2018-11-16T00:13:07.696Z,1542327187.696 [CBIT](CRITICAL): Communications Fault in component: MassServo 2018-11-16T00:13:07.761Z,1542327187.761 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-11-16T00:13:07.762Z,1542327187.762 [MassServo](INFO): Powering down 2018-11-16T00:13:07.777Z,1542327187.777 [CBIT](INFO): Critical error at 20181116T001307 2018-11-16T00:13:08.181Z,1542327188.181 [MassServo](FAULT): LCB fault: Current Limiter Activated. 2018-11-16T00:13:08.181Z,1542327188.181 [MassServo] Hardware Fault, FailCount= 5 2018-11-16T00:13:08.181Z,1542327188.181 [MassServo](ERROR): Hardware Fault 2018-11-16T00:13:08.569Z,1542327188.569 [MassServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:08.569Z,1542327188.569 [MassServo](DEBUG): Initializing MassServo. 2018-11-16T00:13:09.376Z,1542327189.376 [BuoyancyServo](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated. 2018-11-16T00:13:09.377Z,1542327189.377 [BuoyancyServo] Hardware Fault, FailCount= 4 2018-11-16T00:13:09.377Z,1542327189.377 [BuoyancyServo](ERROR): Hardware Fault 2018-11-16T00:13:09.726Z,1542327189.726 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2018-11-16T00:13:09.726Z,1542327189.726 [PNI_TCM] Data Fault, FailCount= 2 2018-11-16T00:13:09.726Z,1542327189.726 [PNI_TCM](ERROR): Data Fault 2018-11-16T00:13:09.785Z,1542327189.785 [CBIT](ERROR): Data Fault in component: PNI_TCM 2018-11-16T00:13:09.785Z,1542327189.785 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-11-16T00:13:09.785Z,1542327189.785 [BuoyancyServo] No Fault, FailCount= 4 2018-11-16T00:13:10.122Z,1542327190.122 [PNI_TCM](INFO): Powering down 2018-11-16T00:13:10.192Z,1542327190.192 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:10.193Z,1542327190.193 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-16T00:13:10.903Z,1542327190.903 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface 2018-11-16T00:13:10.903Z,1542327190.903 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 1 2018-11-16T00:13:10.903Z,1542327190.903 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault 2018-11-16T00:13:11.314Z,1542327191.314 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-16T00:13:11.315Z,1542327191.315 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-16T00:13:11.315Z,1542327191.315 [BuoyancyServo] Communications Fault, FailCount= 5 2018-11-16T00:13:11.315Z,1542327191.315 [BuoyancyServo](ERROR): Communications Fault 2018-11-16T00:13:11.319Z,1542327191.319 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900 2018-11-16T00:13:11.319Z,1542327191.319 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-16T00:13:11.326Z,1542327191.326 [AcousticModem_Benthos_ATM900](INFO): Powering down 2018-11-16T00:13:11.569Z,1542327191.569 [CBIT](INFO): Clearing failed state for component PNI_TCM 2018-11-16T00:13:11.569Z,1542327191.569 [PNI_TCM] No Fault, FailCount= 2 2018-11-16T00:13:11.729Z,1542327191.729 [AcousticModem_Benthos_ATM900](FAULT): LCB fault: Hardware Overcurrent Shutdown. Current Limiter Activated. 2018-11-16T00:13:11.729Z,1542327191.729 [AcousticModem_Benthos_ATM900] Hardware Fault, FailCount= 1 2018-11-16T00:13:11.729Z,1542327191.729 [AcousticModem_Benthos_ATM900](ERROR): Hardware Fault 2018-11-16T00:13:12.239Z,1542327192.239 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900 2018-11-16T00:13:12.239Z,1542327192.239 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 1 2018-11-16T00:13:13.761Z,1542327193.761 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-16T00:13:13.761Z,1542327193.761 [Aanderaa_O2] Communications Fault, FailCount= 2 2018-11-16T00:13:13.761Z,1542327193.761 [Aanderaa_O2](ERROR): Communications Fault 2018-11-16T00:13:13.847Z,1542327193.847 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-16T00:13:13.848Z,1542327193.848 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-11-16T00:13:13.848Z,1542327193.848 [BuoyancyServo] No Fault, FailCount= 5 2018-11-16T00:13:14.152Z,1542327194.152 [Aanderaa_O2](INFO): Powering down 2018-11-16T00:13:14.189Z,1542327194.189 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:14.189Z,1542327194.189 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-16T00:13:14.539Z,1542327194.539 [AcousticModem_Benthos_ATM900](INFO): Powering up 2018-11-16T00:13:14.539Z,1542327194.539 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900. 2018-11-16T00:13:14.620Z,1542327194.620 [SBIT](IMPORTANT): Beginning Startup BIT 2018-11-16T00:13:14.625Z,1542327194.625 [CBIT](IMPORTANT): Beginning ground fault scan 2018-11-16T00:13:15.327Z,1542327195.327 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-16T00:13:15.327Z,1542327195.327 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-16T00:13:15.327Z,1542327195.327 [BuoyancyServo] Communications Fault, FailCount= 6 2018-11-16T00:13:15.327Z,1542327195.327 [BuoyancyServo](ERROR): Communications Fault 2018-11-16T00:13:15.331Z,1542327195.331 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-11-16T00:13:15.332Z,1542327195.332 [Aanderaa_O2] No Fault, FailCount= 2 2018-11-16T00:13:15.332Z,1542327195.332 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-16T00:13:16.148Z,1542327196.148 [NAL9602](INFO): Powering up NAL9602 2018-11-16T00:13:17.394Z,1542327197.394 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-11-16T00:13:17.394Z,1542327197.394 [BuoyancyServo] No Fault, FailCount= 6 2018-11-16T00:13:17.792Z,1542327197.792 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:17.793Z,1542327197.793 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-16T00:13:18.918Z,1542327198.918 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-16T00:13:18.919Z,1542327198.919 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-16T00:13:18.919Z,1542327198.919 [BuoyancyServo] Communications Fault, FailCount= 7 2018-11-16T00:13:18.919Z,1542327198.919 [BuoyancyServo](ERROR): Communications Fault 2018-11-16T00:13:18.923Z,1542327198.923 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-16T00:13:19.051Z,1542327199.051 [CommandLine](IMPORTANT): got command failComponent 2018-11-16T00:13:19.052Z,1542327199.052 [CommandLine](IMPORTANT): Failed components: 2018-11-16T00:13:19.052Z,1542327199.052 [CommandLine](IMPORTANT): DropWeight: Hardware Fault 2018-11-16T00:13:19.052Z,1542327199.052 [CommandLine](IMPORTANT): BuoyancyServo: Communications Fault 2018-11-16T00:13:19.052Z,1542327199.052 [CommandLine](IMPORTANT): ElevatorServo: Hardware Fault 2018-11-16T00:13:19.053Z,1542327199.053 [CommandLine](IMPORTANT): MassServo: Hardware Fault 2018-11-16T00:13:19.053Z,1542327199.053 [CommandLine](IMPORTANT): RudderServo: Hardware Fault 2018-11-16T00:13:19.053Z,1542327199.053 [CommandLine](IMPORTANT): ThrusterServo: Communications Fault 2018-11-16T00:13:19.070Z,1542327199.070 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2018-11-16T00:13:19.070Z,1542327199.070 [PNI_TCM] Data Fault, FailCount= 3 2018-11-16T00:13:19.070Z,1542327199.070 [PNI_TCM](ERROR): Data Fault 2018-11-16T00:13:19.137Z,1542327199.137 [CBIT](ERROR): Data Fault in component: PNI_TCM 2018-11-16T00:13:19.450Z,1542327199.450 [PNI_TCM](INFO): Powering down 2018-11-16T00:13:19.851Z,1542327199.851 [PNI_TCM](FAULT): LCB fault: Current Limiter Activated. 2018-11-16T00:13:19.851Z,1542327199.851 [PNI_TCM] Hardware Fault, FailCount= 3 2018-11-16T00:13:19.851Z,1542327199.851 [PNI_TCM](ERROR): Hardware Fault 2018-11-16T00:13:20.698Z,1542327200.698 [CBIT](INFO): Clearing failed state for component PNI_TCM 2018-11-16T00:13:20.698Z,1542327200.698 [PNI_TCM] No Fault, FailCount= 3 2018-11-16T00:13:21.124Z,1542327201.124 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-11-16T00:13:21.124Z,1542327201.124 [BuoyancyServo] No Fault, FailCount= 7 2018-11-16T00:13:21.501Z,1542327201.501 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:21.619Z,1542327201.619 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-16T00:13:22.618Z,1542327202.618 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-16T00:13:22.619Z,1542327202.619 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-16T00:13:22.619Z,1542327202.619 [BuoyancyServo] Communications Fault, FailCount= 8 2018-11-16T00:13:22.619Z,1542327202.619 [BuoyancyServo](ERROR): Communications Fault 2018-11-16T00:13:22.623Z,1542327202.623 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-16T00:13:24.704Z,1542327204.704 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-11-16T00:13:24.704Z,1542327204.704 [BuoyancyServo] No Fault, FailCount= 8 2018-11-16T00:13:25.104Z,1542327205.104 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:25.223Z,1542327205.223 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-16T00:13:25.463Z,1542327205.463 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-16T00:13:25.463Z,1542327205.463 [Aanderaa_O2] Communications Fault, FailCount= 3 2018-11-16T00:13:25.464Z,1542327205.464 [Aanderaa_O2](ERROR): Communications Fault 2018-11-16T00:13:25.543Z,1542327205.543 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-16T00:13:25.543Z,1542327205.543 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2018-11-16T00:13:25.974Z,1542327205.974 [Aanderaa_O2](INFO): Powering down 2018-11-16T00:13:26.394Z,1542327206.394 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-16T00:13:26.395Z,1542327206.395 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-16T00:13:26.395Z,1542327206.395 [BuoyancyServo] Communications Fault, FailCount= 9 2018-11-16T00:13:26.395Z,1542327206.395 [BuoyancyServo](ERROR): Communications Fault 2018-11-16T00:13:26.399Z,1542327206.399 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-16T00:13:26.403Z,1542327206.403 [CBIT](IMPORTANT): Ground fault detected mA: CHAN A0 (Batt): -0.004062 CHAN A1 (24V): -0.115489 CHAN A2 (12V): -0.084160 CHAN A3 (5V): -0.031423 CHAN B0 (3.3V): -0.010078 CHAN B1 (3.15aV): -0.001720 CHAN B2 (3.15bV): -0.000714 CHAN B3 (GND): 0.000388 OPEN: 0.004647 Full Scale Calc: 4.765 mA, -1.589 mA 2018-11-16T00:13:27.690Z,1542327207.690 [SBIT](ERROR): Could not read elevatorAngleReader_. 2018-11-16T00:13:27.690Z,1542327207.690 [SBIT](ERROR): Could not read rudderAngleReader_. 2018-11-16T00:13:27.690Z,1542327207.690 [SBIT](ERROR): Could not read massPosReader_. 2018-11-16T00:13:28.432Z,1542327208.432 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2018-11-16T00:13:28.432Z,1542327208.432 [PNI_TCM] Data Fault, FailCount= 4 2018-11-16T00:13:28.432Z,1542327208.432 [PNI_TCM](ERROR): Data Fault 2018-11-16T00:13:28.534Z,1542327208.534 [CBIT](ERROR): Data Fault in component: PNI_TCM 2018-11-16T00:13:28.535Z,1542327208.535 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-11-16T00:13:28.535Z,1542327208.535 [BuoyancyServo] No Fault, FailCount= 9 2018-11-16T00:13:28.859Z,1542327208.859 [PNI_TCM](INFO): Powering down 2018-11-16T00:13:28.988Z,1542327208.988 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:29.103Z,1542327209.103 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-16T00:13:29.998Z,1542327209.998 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-16T00:13:29.999Z,1542327209.999 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-16T00:13:29.999Z,1542327209.999 [BuoyancyServo] Communications Fault, FailCount= 10 2018-11-16T00:13:29.999Z,1542327209.999 [BuoyancyServo](ERROR): Communications Fault 2018-11-16T00:13:30.003Z,1542327210.003 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-16T00:13:30.004Z,1542327210.004 [CBIT](CRITICAL): Communications Fault in component: BuoyancyServo 2018-11-16T00:13:30.117Z,1542327210.117 [CBIT](INFO): Critical error at 20181116T001330 2018-11-16T00:13:30.135Z,1542327210.135 [CBIT](INFO): Clearing failed state for component PNI_TCM 2018-11-16T00:13:30.135Z,1542327210.135 [PNI_TCM] No Fault, FailCount= 4 2018-11-16T00:13:34.811Z,1542327214.811 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface 2018-11-16T00:13:34.812Z,1542327214.812 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 2 2018-11-16T00:13:34.812Z,1542327214.812 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault 2018-11-16T00:13:34.893Z,1542327214.893 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900 2018-11-16T00:13:35.211Z,1542327215.211 [AcousticModem_Benthos_ATM900](INFO): Powering down 2018-11-16T00:13:36.076Z,1542327216.076 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900 2018-11-16T00:13:36.076Z,1542327216.076 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 2 2018-11-16T00:13:36.469Z,1542327216.469 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-11-16T00:13:36.469Z,1542327216.469 [ThrusterServo] No Fault, FailCount= 5 2018-11-16T00:13:36.903Z,1542327216.903 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:36.911Z,1542327216.911 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-16T00:13:37.216Z,1542327217.216 [NAL9602](ERROR): NAL9602 initialization error. 2018-11-16T00:13:37.216Z,1542327217.216 [NAL9602] Communications Fault, FailCount= 1 2018-11-16T00:13:37.216Z,1542327217.216 [NAL9602](ERROR): Communications Fault 2018-11-16T00:13:37.302Z,1542327217.302 [CBIT](ERROR): Communications Fault in component: NAL9602 2018-11-16T00:13:37.616Z,1542327217.616 [NAL9602](INFO): Powering down 2018-11-16T00:13:37.646Z,1542327217.646 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2018-11-16T00:13:37.646Z,1542327217.646 [PNI_TCM] Data Fault, FailCount= 5 2018-11-16T00:13:37.646Z,1542327217.646 [PNI_TCM](ERROR): Data Fault 2018-11-16T00:13:38.038Z,1542327218.038 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-11-16T00:13:38.362Z,1542327218.362 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2018-11-16T00:13:38.363Z,1542327218.363 [ThrusterServo](FAULT): Thruster failed to initialize 2018-11-16T00:13:38.363Z,1542327218.363 [ThrusterServo] Communications Fault, FailCount= 1 2018-11-16T00:13:38.363Z,1542327218.363 [ThrusterServo](ERROR): Communications Fault 2018-11-16T00:13:38.367Z,1542327218.367 [CBIT](ERROR): Data Fault in component: PNI_TCM 2018-11-16T00:13:38.368Z,1542327218.368 [CBIT](CRITICAL): Data Fault in component: PNI_TCM 2018-11-16T00:13:38.369Z,1542327218.369 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-11-16T00:13:38.376Z,1542327218.376 [AcousticModem_Benthos_ATM900](INFO): Powering up 2018-11-16T00:13:38.376Z,1542327218.376 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900. 2018-11-16T00:13:38.451Z,1542327218.451 [PNI_TCM](INFO): Powering down 2018-11-16T00:13:38.577Z,1542327218.577 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-16T00:13:38.577Z,1542327218.577 [ThrusterServo](INFO): Powering down 2018-11-16T00:13:38.581Z,1542327218.581 [CBIT](INFO): Critical error at 20181116T001338 2018-11-16T00:13:38.856Z,1542327218.856 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-16T00:13:38.856Z,1542327218.856 [NAL9602] No Fault, FailCount= 1 2018-11-16T00:13:39.376Z,1542327219.376 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-11-16T00:13:39.376Z,1542327219.376 [ThrusterServo] No Fault, FailCount= 1 2018-11-16T00:13:39.633Z,1542327219.633 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:39.639Z,1542327219.639 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-16T00:13:40.770Z,1542327220.770 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-11-16T00:13:41.090Z,1542327221.090 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2018-11-16T00:13:41.091Z,1542327221.091 [ThrusterServo](FAULT): Thruster failed to initialize 2018-11-16T00:13:41.091Z,1542327221.091 [ThrusterServo] Communications Fault, FailCount= 2 2018-11-16T00:13:41.091Z,1542327221.091 [ThrusterServo](ERROR): Communications Fault 2018-11-16T00:13:41.096Z,1542327221.096 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-11-16T00:13:41.199Z,1542327221.199 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-16T00:13:41.199Z,1542327221.199 [ThrusterServo](INFO): Powering down 2018-11-16T00:13:42.080Z,1542327222.080 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-11-16T00:13:42.080Z,1542327222.080 [ThrusterServo] No Fault, FailCount= 2 2018-11-16T00:13:42.364Z,1542327222.364 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:42.371Z,1542327222.371 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-16T00:13:43.490Z,1542327223.490 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-11-16T00:13:43.810Z,1542327223.810 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2018-11-16T00:13:43.811Z,1542327223.811 [ThrusterServo](FAULT): Thruster failed to initialize 2018-11-16T00:13:43.811Z,1542327223.811 [ThrusterServo] Communications Fault, FailCount= 3 2018-11-16T00:13:43.811Z,1542327223.811 [ThrusterServo](ERROR): Communications Fault 2018-11-16T00:13:43.816Z,1542327223.816 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-11-16T00:13:43.932Z,1542327223.932 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-16T00:13:43.932Z,1542327223.932 [ThrusterServo](INFO): Powering down 2018-11-16T00:13:44.796Z,1542327224.796 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-11-16T00:13:44.796Z,1542327224.796 [ThrusterServo] No Fault, FailCount= 3 2018-11-16T00:13:45.076Z,1542327225.076 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:45.098Z,1542327225.098 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-16T00:13:46.198Z,1542327226.198 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-11-16T00:13:46.522Z,1542327226.522 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2018-11-16T00:13:46.523Z,1542327226.523 [ThrusterServo](FAULT): Thruster failed to initialize 2018-11-16T00:13:46.523Z,1542327226.523 [ThrusterServo] Communications Fault, FailCount= 4 2018-11-16T00:13:46.523Z,1542327226.523 [ThrusterServo](ERROR): Communications Fault 2018-11-16T00:13:46.528Z,1542327226.528 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-11-16T00:13:46.665Z,1542327226.665 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-16T00:13:46.665Z,1542327226.665 [ThrusterServo](INFO): Powering down 2018-11-16T00:13:47.500Z,1542327227.500 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-11-16T00:13:47.500Z,1542327227.500 [ThrusterServo] No Fault, FailCount= 4 2018-11-16T00:13:47.794Z,1542327227.794 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-16T00:13:47.815Z,1542327227.815 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-16T00:13:48.152Z,1542327228.152 [CommandLine](IMPORTANT): got command failComponent 2018-11-16T00:13:48.152Z,1542327228.152 [CommandLine](IMPORTANT): Failed components: 2018-11-16T00:13:48.153Z,1542327228.153 [CommandLine](IMPORTANT): DropWeight: Hardware Fault 2018-11-16T00:13:48.153Z,1542327228.153 [CommandLine](IMPORTANT): PNI_TCM: Data Fault 2018-11-16T00:13:48.153Z,1542327228.153 [CommandLine](IMPORTANT): Aanderaa_O2: Communications Fault 2018-11-16T00:13:48.153Z,1542327228.153 [CommandLine](IMPORTANT): BuoyancyServo: Communications Fault 2018-11-16T00:13:48.154Z,1542327228.154 [CommandLine](IMPORTANT): ElevatorServo: Hardware Fault 2018-11-16T00:13:48.154Z,1542327228.154 [CommandLine](IMPORTANT): MassServo: Hardware Fault 2018-11-16T00:13:48.154Z,1542327228.154 [CommandLine](IMPORTANT): RudderServo: Hardware Fault 2018-11-16T00:13:48.934Z,1542327228.934 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-11-16T00:13:49.254Z,1542327229.254 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2018-11-16T00:13:49.255Z,1542327229.255 [ThrusterServo](FAULT): Thruster failed to initialize 2018-11-16T00:13:49.255Z,1542327229.255 [ThrusterServo] Communications Fault, FailCount= 5 2018-11-16T00:13:49.255Z,1542327229.255 [ThrusterServo](ERROR): Communications Fault 2018-11-16T00:13:49.289Z,1542327229.289 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-11-16T00:13:49.290Z,1542327229.290 [CBIT](CRITICAL): Communications Fault in component: ThrusterServo 2018-11-16T00:13:49.382Z,1542327229.382 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-16T00:13:49.382Z,1542327229.382 [ThrusterServo](INFO): Powering down 2018-11-16T00:13:49.408Z,1542327229.408 [CBIT](INFO): Critical error at 20181116T001349 2018-11-16T00:13:54.142Z,1542327234.142 [SBIT](ERROR): Could not read elevatorAngleReader_. 2018-11-16T00:13:54.142Z,1542327234.142 [SBIT](ERROR): Could not read rudderAngleReader_. 2018-11-16T00:13:54.142Z,1542327234.142 [SBIT](ERROR): Could not read massPosReader_. 2018-11-16T00:13:54.142Z,1542327234.142 [SBIT](FAULT): Control surface position failure. 2018-11-16T00:13:55.072Z,1542327235.072 [CommandLine](IMPORTANT): got command quit 2018-11-16T00:13:56.085Z,1542327236.085 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-16T00:13:56.086Z,1542327236.086 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:56.086Z,1542327236.086 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2018-11-16T00:13:56.086Z,1542327236.086 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:56.087Z,1542327236.087 [CommandLine](INFO): Join timeout helper Thread ID is 7859 2018-11-16T00:13:56.088Z,1542327236.088 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2018-11-16T00:13:56.088Z,1542327236.088 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:56.088Z,1542327236.088 [NavChartDb](INFO): Join timeout helper Thread ID is 7860 2018-11-16T00:13:56.286Z,1542327236.286 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-16T00:13:56.287Z,1542327236.287 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:56.299Z,1542327236.299 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2018-11-16T00:13:56.299Z,1542327236.299 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:56.299Z,1542327236.299 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 7861 2018-11-16T00:13:56.299Z,1542327236.299 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-16T00:13:56.300Z,1542327236.300 [WetLabsBB2FL](INFO): Powering down 2018-11-16T00:13:56.300Z,1542327236.300 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:56.301Z,1542327236.301 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2018-11-16T00:13:56.301Z,1542327236.301 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:56.301Z,1542327236.301 [CTD_Seabird](INFO): Join timeout helper Thread ID is 7862 2018-11-16T00:13:56.534Z,1542327236.534 [BPC1](FAULT): Failed to parse data from all battery packs. 2018-11-16T00:13:56.534Z,1542327236.534 [BPC1] Data Fault, FailCount= 1 2018-11-16T00:13:56.534Z,1542327236.534 [BPC1](ERROR): Data Fault 2018-11-16T00:13:56.551Z,1542327236.551 [CBIT](ERROR): Data Fault in component: BPC1 2018-11-16T00:13:56.559Z,1542327236.559 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-16T00:13:56.690Z,1542327236.690 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-11-16T00:13:56.691Z,1542327236.691 [CTD_Seabird](INFO): Powering down 2018-11-16T00:13:56.692Z,1542327236.692 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:56.706Z,1542327236.706 [ComponentRegistry](INFO): Shutting down Rowe_600LCM ThreadHandler 2018-11-16T00:13:56.707Z,1542327236.707 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:56.707Z,1542327236.707 [Rowe_600LCM](INFO): Join timeout helper Thread ID is 7864 2018-11-16T00:13:57.195Z,1542327237.195 [Rowe_600LCM ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-16T00:13:57.195Z,1542327237.195 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2018-11-16T00:13:57.283Z,1542327237.283 [Rowe_600LCM](INFO): Powering down 2018-11-16T00:13:57.284Z,1542327237.284 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:57.295Z,1542327237.295 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2018-11-16T00:13:57.296Z,1542327237.296 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:57.296Z,1542327237.296 [Radio_Surface](INFO): Join timeout helper Thread ID is 7866 2018-11-16T00:13:57.667Z,1542327237.667 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-16T00:13:57.667Z,1542327237.667 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:57.671Z,1542327237.671 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2018-11-16T00:13:57.671Z,1542327237.671 [logger ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:57.672Z,1542327237.672 [logger](INFO): Join timeout helper Thread ID is 7867 2018-11-16T00:13:57.679Z,1542327237.679 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-16T00:13:57.679Z,1542327237.679 [logger ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:57.691Z,1542327237.691 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2018-11-16T00:13:57.691Z,1542327237.691 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:57.691Z,1542327237.691 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2018-11-16T00:13:57.692Z,1542327237.692 [controlThread ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:57.692Z,1542327237.692 [controlThread](INFO): Join timeout helper Thread ID is 7868 2018-11-16T00:13:57.695Z,1542327237.695 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-16T00:13:57.695Z,1542327237.695 [controlThread](DEBUG): Uninitializing ControlThread 2018-11-16T00:13:57.695Z,1542327237.695 [AcousticModem_Benthos_ATM900](INFO): Powering down 2018-11-16T00:13:57.815Z,1542327237.815 [NAL9602](INFO): Powering down 2018-11-16T00:13:57.817Z,1542327237.817 [PNI_TCM](INFO): Powering down 2018-11-16T00:13:57.818Z,1542327237.818 [Aanderaa_O2](INFO): Powering down 2018-11-16T00:13:57.821Z,1542327237.821 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-11-16T00:13:57.822Z,1542327237.822 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2018-11-16T00:13:57.822Z,1542327237.822 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2018-11-16T00:13:57.823Z,1542327237.823 [MissionManager](INFO): Uninitializing Mission Default 2018-11-16T00:13:57.826Z,1542327237.826 [MissionManager](INFO): Uninitializing Mission Startup 2018-11-16T00:13:57.827Z,1542327237.827 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2018-11-16T00:13:57.828Z,1542327237.828 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2018-11-16T00:13:57.828Z,1542327237.828 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2018-11-16T00:13:57.828Z,1542327237.828 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2018-11-16T00:13:57.828Z,1542327237.828 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-11-16T00:13:57.829Z,1542327237.829 [BuoyancyServo](INFO): Powering down 2018-11-16T00:13:57.982Z,1542327237.982 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-11-16T00:13:57.983Z,1542327237.983 [ElevatorServo](INFO): Powering down 2018-11-16T00:13:57.984Z,1542327237.984 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-11-16T00:13:57.984Z,1542327237.984 [MassServo](INFO): Powering down 2018-11-16T00:13:57.985Z,1542327237.985 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-11-16T00:13:57.985Z,1542327237.985 [RudderServo](INFO): Powering down 2018-11-16T00:13:57.986Z,1542327237.986 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-16T00:13:57.986Z,1542327237.986 [ThrusterServo](INFO): Powering down 2018-11-16T00:13:57.987Z,1542327237.987 [SBIT](DEBUG): Uninitialize SBIT Component. 2018-11-16T00:13:57.987Z,1542327237.987 [IBIT](DEBUG): Uninitialize IBIT Component. 2018-11-16T00:13:57.987Z,1542327237.987 [CBIT](DEBUG): Uninitialize CBIT Component. 2018-11-16T00:13:57.988Z,1542327237.988 [CBIT](DEBUG): Powering off loads. 2018-11-16T00:13:57.988Z,1542327237.988 [CBIT](DEBUG): Disabling WDT. 2018-11-16T00:13:57.988Z,1542327237.988 [CBIT](DEBUG): Opening all GF detection circuits. 2018-11-16T00:13:57.989Z,1542327237.989 [controlThread ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:58.075Z,1542327238.075 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:58.081Z,1542327238.081 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:58.119Z,1542327238.119 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:58.124Z,1542327238.124 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:58.525Z,1542327238.525 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-11-16T00:13:58.587Z,1542327238.587 [logger ThreadHandler](INFO): Thread cancelled.