2018-10-10T16:26:30.150Z,1539188790.150 [Supervisor](DEBUG): Initializing supervisor. 2018-10-10T16:26:30.153Z,1539188790.153 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2018-10-10T16:26:30.153Z,1539188790.153 [SyncHandler](INFO): Protected caller Thread ID is 798 2018-10-10T16:26:30.154Z,1539188790.154 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2018-10-10T16:26:30.154Z,1539188790.154 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2018-10-10T16:26:30.155Z,1539188790.155 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 799 2018-10-10T16:26:30.157Z,1539188790.157 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2018-10-10T16:26:30.169Z,1539188790.169 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2018-10-10T16:26:30.170Z,1539188790.170 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2018-10-10T16:26:30.170Z,1539188790.170 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 800 2018-10-10T16:26:30.171Z,1539188790.171 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2018-10-10T16:26:30.172Z,1539188790.172 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2018-10-10T16:26:30.172Z,1539188790.172 [logger ThreadHandler](INFO): Protected caller Thread ID is 801 2018-10-10T16:26:30.174Z,1539188790.174 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2018-10-10T16:26:30.175Z,1539188790.175 [Supervisor](INFO): Looking for Config files in directory: Config/ 2018-10-10T16:26:30.178Z,1539188790.178 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2018-10-10T16:26:30.277Z,1539188790.277 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2018-10-10T16:26:30.279Z,1539188790.279 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2018-10-10T16:26:30.383Z,1539188790.383 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2018-10-10T16:26:30.385Z,1539188790.385 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2018-10-10T16:26:30.594Z,1539188790.594 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2018-10-10T16:26:30.594Z,1539188790.594 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2018-10-10T16:26:30.935Z,1539188790.935 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2018-10-10T16:26:30.937Z,1539188790.937 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2018-10-10T16:26:31.283Z,1539188791.283 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2018-10-10T16:26:31.283Z,1539188791.283 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2018-10-10T16:26:31.757Z,1539188791.757 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2018-10-10T16:26:31.758Z,1539188791.758 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2018-10-10T16:26:32.235Z,1539188792.235 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2018-10-10T16:26:32.236Z,1539188792.236 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2018-10-10T16:26:32.711Z,1539188792.711 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2018-10-10T16:26:32.711Z,1539188792.711 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2018-10-10T16:26:32.795Z,1539188792.795 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2018-10-10T16:26:33.121Z,1539188793.121 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2018-10-10T16:26:33.123Z,1539188793.123 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2018-10-10T16:26:33.275Z,1539188793.275 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2018-10-10T16:26:33.276Z,1539188793.276 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2018-10-10T16:26:33.498Z,1539188793.498 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2018-10-10T16:26:33.500Z,1539188793.500 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2018-10-10T16:26:33.714Z,1539188793.714 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2018-10-10T16:26:33.714Z,1539188793.714 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2018-10-10T16:26:33.830Z,1539188793.830 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2018-10-10T16:26:33.850Z,1539188793.850 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2018-10-10T16:26:34.392Z,1539188794.392 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2018-10-10T16:26:34.394Z,1539188794.394 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2018-10-10T16:26:34.899Z,1539188794.899 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2018-10-10T16:26:35.133Z,1539188795.133 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2018-10-10T16:26:35.133Z,1539188795.133 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2018-10-10T16:26:35.241Z,1539188795.241 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2018-10-10T16:26:35.390Z,1539188795.390 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2018-10-10T16:26:35.528Z,1539188795.528 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2018-10-10T16:26:35.615Z,1539188795.615 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2018-10-10T16:26:35.767Z,1539188795.767 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2018-10-10T16:26:35.962Z,1539188795.962 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2018-10-10T16:26:36.062Z,1539188796.062 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2018-10-10T16:26:36.158Z,1539188796.158 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2018-10-10T16:26:36.257Z,1539188796.257 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2018-10-10T16:26:36.341Z,1539188796.341 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2018-10-10T16:26:36.345Z,1539188796.345 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2018-10-10T16:26:36.473Z,1539188796.473 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2018-10-10T16:26:36.473Z,1539188796.473 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2018-10-10T16:26:36.497Z,1539188796.497 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2018-10-10T16:26:36.498Z,1539188796.498 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2018-10-10T16:26:36.553Z,1539188796.553 [DepthRateCalculator] Loaded 2018-10-10T16:26:36.553Z,1539188796.553 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2018-10-10T16:26:36.559Z,1539188796.559 [PitchRateCalculator] Loaded 2018-10-10T16:26:36.559Z,1539188796.559 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2018-10-10T16:26:36.575Z,1539188796.575 [SpeedCalculator] Loaded 2018-10-10T16:26:36.575Z,1539188796.575 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2018-10-10T16:26:36.596Z,1539188796.596 [TempGradientCalculator] Loaded 2018-10-10T16:26:36.596Z,1539188796.596 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2018-10-10T16:26:36.602Z,1539188796.602 [YawRateCalculator] Loaded 2018-10-10T16:26:36.602Z,1539188796.602 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2018-10-10T16:26:36.641Z,1539188796.641 [ElevatorOffsetCalculator] Loaded 2018-10-10T16:26:36.641Z,1539188796.641 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2018-10-10T16:26:36.642Z,1539188796.642 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2018-10-10T16:26:36.643Z,1539188796.643 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2018-10-10T16:26:36.680Z,1539188796.680 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2018-10-10T16:26:36.681Z,1539188796.681 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2018-10-10T16:26:39.661Z,1539188799.661 [DataOverHttps] Loaded 2018-10-10T16:26:39.661Z,1539188799.661 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2018-10-10T16:26:39.688Z,1539188799.688 [Depth_Keller] Loaded 2018-10-10T16:26:39.688Z,1539188799.688 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2018-10-10T16:26:39.693Z,1539188799.693 [DropWeight] Loaded 2018-10-10T16:26:39.693Z,1539188799.693 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2018-10-10T16:26:39.789Z,1539188799.789 [NAL9602] Loaded 2018-10-10T16:26:39.790Z,1539188799.790 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2018-10-10T16:26:39.805Z,1539188799.805 [Onboard] Loaded 2018-10-10T16:26:39.806Z,1539188799.806 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2018-10-10T16:26:39.815Z,1539188799.815 [Radio_Surface] Loaded 2018-10-10T16:26:39.816Z,1539188799.816 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2018-10-10T16:26:39.817Z,1539188799.817 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AAD4E0 2018-10-10T16:26:39.817Z,1539188799.817 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 881 2018-10-10T16:26:39.969Z,1539188799.969 [PNI_TCM] Loaded 2018-10-10T16:26:39.970Z,1539188799.970 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2018-10-10T16:26:40.030Z,1539188800.030 [Rowe_600LCM] Loaded 2018-10-10T16:26:40.030Z,1539188800.030 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread. 2018-10-10T16:26:40.031Z,1539188800.031 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 40ADD4E0 2018-10-10T16:26:40.032Z,1539188800.032 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 882 2018-10-10T16:26:41.779Z,1539188801.779 [BPC1] Loaded 2018-10-10T16:26:41.779Z,1539188801.779 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2018-10-10T16:26:41.779Z,1539188801.779 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2018-10-10T16:26:41.780Z,1539188801.780 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2018-10-10T16:26:42.268Z,1539188802.268 [SBIT](DEBUG): Construct Startup Built In Test. 2018-10-10T16:26:42.291Z,1539188802.291 [SBIT] Loaded 2018-10-10T16:26:42.291Z,1539188802.291 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2018-10-10T16:26:42.292Z,1539188802.292 [IBIT](DEBUG): Construct Initiated Built In Test. 2018-10-10T16:26:42.304Z,1539188802.304 [IBIT] Loaded 2018-10-10T16:26:42.304Z,1539188802.304 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2018-10-10T16:26:42.307Z,1539188802.307 [CBIT](DEBUG): Construct Continuous Built In Test. 2018-10-10T16:26:42.455Z,1539188802.455 [CBIT] Loaded 2018-10-10T16:26:42.456Z,1539188802.456 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2018-10-10T16:26:42.456Z,1539188802.456 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2018-10-10T16:26:42.457Z,1539188802.457 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2018-10-10T16:26:42.661Z,1539188802.661 [Aanderaa_O2] Loaded 2018-10-10T16:26:42.661Z,1539188802.661 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2018-10-10T16:26:42.713Z,1539188802.713 [CTD_Seabird] Loaded 2018-10-10T16:26:42.713Z,1539188802.713 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2018-10-10T16:26:42.714Z,1539188802.714 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40BA74E0 2018-10-10T16:26:42.714Z,1539188802.714 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 883 2018-10-10T16:26:42.731Z,1539188802.731 [ESPComponent] Loaded 2018-10-10T16:26:42.732Z,1539188802.732 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2018-10-10T16:26:42.746Z,1539188802.746 [PAR_Licor] Loaded 2018-10-10T16:26:42.746Z,1539188802.746 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2018-10-10T16:26:42.794Z,1539188802.794 [WetLabsBB2FL] Loaded 2018-10-10T16:26:42.794Z,1539188802.794 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2018-10-10T16:26:42.795Z,1539188802.795 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40BD74E0 2018-10-10T16:26:42.796Z,1539188802.796 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 884 2018-10-10T16:26:42.797Z,1539188802.797 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2018-10-10T16:26:42.797Z,1539188802.797 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2018-10-10T16:26:43.076Z,1539188803.076 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2018-10-10T16:26:43.078Z,1539188803.078 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2018-10-10T16:26:43.167Z,1539188803.167 [VerticalControl](DEBUG): Construct VerticalControl. 2018-10-10T16:26:43.261Z,1539188803.261 [VerticalControl] Loaded 2018-10-10T16:26:43.261Z,1539188803.261 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2018-10-10T16:26:43.262Z,1539188803.262 [HorizontalControl](DEBUG): Construct HorizontalControl. 2018-10-10T16:26:43.322Z,1539188803.322 [HorizontalControl] Loaded 2018-10-10T16:26:43.322Z,1539188803.322 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2018-10-10T16:26:43.323Z,1539188803.323 [SpeedControl](DEBUG): Construct SpeedControl. 2018-10-10T16:26:43.328Z,1539188803.328 [SpeedControl] Loaded 2018-10-10T16:26:43.328Z,1539188803.328 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2018-10-10T16:26:43.329Z,1539188803.329 [LoopControl](DEBUG): Construct LoopControl. 2018-10-10T16:26:43.329Z,1539188803.329 [LoopControl] Loaded 2018-10-10T16:26:43.330Z,1539188803.330 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2018-10-10T16:26:43.330Z,1539188803.330 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2018-10-10T16:26:43.331Z,1539188803.331 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2018-10-10T16:26:43.433Z,1539188803.433 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2018-10-10T16:26:43.434Z,1539188803.434 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2018-10-10T16:26:43.552Z,1539188803.552 [BuoyancyServo] Loaded 2018-10-10T16:26:43.553Z,1539188803.553 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2018-10-10T16:26:43.564Z,1539188803.564 [ElevatorServo] Loaded 2018-10-10T16:26:43.564Z,1539188803.564 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2018-10-10T16:26:43.575Z,1539188803.575 [MassServo] Loaded 2018-10-10T16:26:43.575Z,1539188803.575 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2018-10-10T16:26:43.587Z,1539188803.587 [RudderServo] Loaded 2018-10-10T16:26:43.587Z,1539188803.587 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2018-10-10T16:26:43.598Z,1539188803.598 [ThrusterServo] Loaded 2018-10-10T16:26:43.598Z,1539188803.598 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2018-10-10T16:26:43.599Z,1539188803.599 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2018-10-10T16:26:43.599Z,1539188803.599 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2018-10-10T16:26:43.707Z,1539188803.707 [DeadReckonUsingSpeedCalculator] Loaded 2018-10-10T16:26:43.708Z,1539188803.708 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2018-10-10T16:26:43.724Z,1539188803.724 [NavChart] Loaded 2018-10-10T16:26:43.724Z,1539188803.724 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2018-10-10T16:26:43.728Z,1539188803.728 [UniversalFixResidualReporter] Loaded 2018-10-10T16:26:43.728Z,1539188803.728 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2018-10-10T16:26:43.729Z,1539188803.729 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2018-10-10T16:26:43.732Z,1539188803.732 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2018-10-10T16:26:43.733Z,1539188803.733 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2018-10-10T16:26:43.740Z,1539188803.740 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2018-10-10T16:26:43.741Z,1539188803.741 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40D304E0 2018-10-10T16:26:43.741Z,1539188803.741 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 885 2018-10-10T16:26:43.746Z,1539188803.746 [Supervisor](INFO): Main Thread ID is 797 2018-10-10T16:26:43.746Z,1539188803.746 [Supervisor](DEBUG): Running supervisor. 2018-10-10T16:26:43.747Z,1539188803.747 [CommandLine ThreadHandler](INFO): Handler Thread ID is 886 2018-10-10T16:26:43.749Z,1539188803.749 [controlThread ThreadHandler](INFO): Handler Thread ID is 887 2018-10-10T16:26:43.750Z,1539188803.750 [controlThread](DEBUG): Initializing ControlThread 2018-10-10T16:26:43.751Z,1539188803.751 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-10-10T16:26:43.751Z,1539188803.751 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2018-10-10T16:26:43.751Z,1539188803.751 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2018-10-10T16:26:43.752Z,1539188803.752 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2018-10-10T16:26:43.752Z,1539188803.752 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2018-10-10T16:26:43.753Z,1539188803.753 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2018-10-10T16:26:43.759Z,1539188803.759 [SBIT](INFO): Initialize SBIT Component. 2018-10-10T16:26:43.760Z,1539188803.760 [SBIT](IMPORTANT): git: 2018-10-09-5-g8e0f966 2018-10-10T16:26:43.760Z,1539188803.760 [SBIT](INFO): git hash: 8e0f9669898461179fe27a6b90da366188de3daf 2018-10-10T16:26:43.760Z,1539188803.760 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2018-10-10T16:26:43.760Z,1539188803.760 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018 2018-10-10T16:26:43.762Z,1539188803.762 [SBIT](INFO): Beginning SBIT in 24.000000 seconds. 2018-10-10T16:26:43.762Z,1539188803.762 [IBIT](INFO): Initialize IBIT Component. 2018-10-10T16:26:43.763Z,1539188803.763 [CBIT](DEBUG): Initialize CBIT Component. 2018-10-10T16:26:43.763Z,1539188803.763 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2018-10-10T16:26:43.763Z,1539188803.763 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET. 2018-10-10T16:26:43.764Z,1539188803.764 [logger ThreadHandler](INFO): Handler Thread ID is 888 2018-10-10T16:26:43.781Z,1539188803.781 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 889 2018-10-10T16:26:43.787Z,1539188803.787 [Radio_Surface](INFO): Powering up 2018-10-10T16:26:43.793Z,1539188803.793 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 890 2018-10-10T16:26:43.794Z,1539188803.794 [Rowe_600LCM](INFO): Initializing 2018-10-10T16:26:43.794Z,1539188803.794 [Rowe_600LCM](INFO): Checking LCM 2018-10-10T16:26:43.899Z,1539188803.899 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2018-10-10T16:26:43.901Z,1539188803.901 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2018-10-10T16:26:43.902Z,1539188803.902 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2018-10-10T16:26:43.902Z,1539188803.902 [LoopControl](DEBUG): Initialize LoopControlComponent. 2018-10-10T16:26:43.904Z,1539188803.904 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-10-10T16:26:43.905Z,1539188803.905 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 891 2018-10-10T16:26:43.906Z,1539188803.906 [CTD_Seabird](INFO): Initializing 2018-10-10T16:26:43.906Z,1539188803.906 [CTD_Seabird](INFO): Checking LCM 2018-10-10T16:26:43.913Z,1539188803.913 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-10-10T16:26:43.913Z,1539188803.913 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-10-10T16:26:43.914Z,1539188803.914 [NavChart](DEBUG): Initialize NavChart Navigation. 2018-10-10T16:26:43.914Z,1539188803.914 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2018-10-10T16:26:43.915Z,1539188803.915 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2018-10-10T16:26:43.995Z,1539188803.995 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 892 2018-10-10T16:26:43.997Z,1539188803.997 [WetLabsBB2FL](INFO): Powering down 2018-10-10T16:26:44.022Z,1539188804.022 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2018-10-10T16:26:44.141Z,1539188804.141 [MissionManager](DEBUG): 2018-10-10T16:26:44.142Z,1539188804.142 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2018-10-10T16:26:44.143Z,1539188804.143 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 893 2018-10-10T16:26:44.153Z,1539188804.153 [NavChartDb](FAULT): Change detected in ENC collection. Wiping NavChart Directory 2018-10-10T16:26:44.157Z,1539188804.157 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2018-10-10T16:26:44.159Z,1539188804.159 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US1WC07M.000 2018-10-10T16:26:44.159Z,1539188804.159 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2018-10-10T16:26:44.161Z,1539188804.161 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US2WC11M.000 2018-10-10T16:26:44.161Z,1539188804.161 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2018-10-10T16:26:44.162Z,1539188804.162 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US3CA52M.000 2018-10-10T16:26:44.163Z,1539188804.163 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2018-10-10T16:26:44.164Z,1539188804.164 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4CA60M.000 2018-10-10T16:26:44.164Z,1539188804.164 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2018-10-10T16:26:44.166Z,1539188804.166 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA50M.000 2018-10-10T16:26:44.166Z,1539188804.166 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2018-10-10T16:26:44.168Z,1539188804.168 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA61M.000 2018-10-10T16:26:44.168Z,1539188804.168 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2018-10-10T16:26:44.169Z,1539188804.169 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA62M.000 2018-10-10T16:26:44.170Z,1539188804.170 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2018-10-10T16:26:44.171Z,1539188804.171 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US5CA83M.000 2018-10-10T16:26:44.241Z,1539188804.241 [CTD_Seabird](INFO): LCM OK 2018-10-10T16:26:44.241Z,1539188804.241 [CTD_Seabird](INFO): Powering up 2018-10-10T16:26:44.241Z,1539188804.241 [Rowe_600LCM](INFO): LCM OK 2018-10-10T16:26:44.241Z,1539188804.241 [Rowe_600LCM](INFO): Powering up 2018-10-10T16:26:44.249Z,1539188804.249 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2018-10-10T16:26:44.251Z,1539188804.251 [Default:A.Wait](DEBUG): Construct Wait. 2018-10-10T16:26:44.257Z,1539188804.257 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US5CA83M.000 2018-10-10T16:26:44.258Z,1539188804.258 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2018-10-10T16:26:44.322Z,1539188804.322 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2018-10-10T16:26:44.345Z,1539188804.345 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2018-10-10T16:26:44.378Z,1539188804.378 [Default:E.Execute](DEBUG): Construct Execute. 2018-10-10T16:26:44.410Z,1539188804.410 [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-10-10T16:26:44.416Z,1539188804.416 [controlThread](DEBUG): Component order: CycleStarter,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-10-10T16:26:44.447Z,1539188804.447 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2018-10-10T16:26:44.819Z,1539188804.819 [ESPComponent](INFO): powering down ESP 2018-10-10T16:26:45.243Z,1539188805.243 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:45.448Z,1539188805.448 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:26:45.469Z,1539188805.469 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-10T16:26:45.484Z,1539188805.484 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:26:45.493Z,1539188805.493 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-10-10T16:26:45.499Z,1539188805.499 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:26:45.505Z,1539188805.505 [MassServo](DEBUG): Initializing MassServo. 2018-10-10T16:26:45.523Z,1539188805.523 [RudderServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:26:45.529Z,1539188805.529 [RudderServo](DEBUG): Initializing RudderServo. 2018-10-10T16:26:45.535Z,1539188805.535 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:26:45.541Z,1539188805.541 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-10T16:26:45.607Z,1539188805.607 [CommandLine](FAULT): Scheduling is paused 2018-10-10T16:26:45.607Z,1539188805.607 [CBIT](INFO): Critical error at 20181010T162643 2018-10-10T16:26:45.608Z,1539188805.608 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2018-10-10T16:26:45.738Z,1539188805.738 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2018-10-10T16:26:45.738Z,1539188805.738 [DropWeight] Hardware Fault, FailCount= 1 2018-10-10T16:26:45.738Z,1539188805.738 [DropWeight](ERROR): Hardware Fault 2018-10-10T16:26:45.807Z,1539188805.807 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:45.832Z,1539188805.832 [CBIT](INFO): Critical error at 20181010T162645 2018-10-10T16:26:45.834Z,1539188805.834 [CBIT](ERROR): Hardware Fault in component: DropWeight 2018-10-10T16:26:45.835Z,1539188805.835 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2018-10-10T16:26:46.113Z,1539188806.113 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:46.449Z,1539188806.449 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-10T16:26:46.449Z,1539188806.449 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-10T16:26:46.449Z,1539188806.449 [BuoyancyServo] Communications Fault, FailCount= 1 2018-10-10T16:26:46.449Z,1539188806.449 [BuoyancyServo](ERROR): Communications Fault 2018-10-10T16:26:46.765Z,1539188806.765 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2018-10-10T16:26:46.765Z,1539188806.765 [ElevatorServo](FAULT): Elevator failed to initialize 2018-10-10T16:26:46.765Z,1539188806.765 [ElevatorServo] Communications Fault, FailCount= 1 2018-10-10T16:26:46.765Z,1539188806.765 [ElevatorServo](ERROR): Communications Fault 2018-10-10T16:26:47.077Z,1539188807.077 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2018-10-10T16:26:47.077Z,1539188807.077 [RudderServo](FAULT): Rudder failed to initialize 2018-10-10T16:26:47.077Z,1539188807.077 [RudderServo] Communications Fault, FailCount= 1 2018-10-10T16:26:47.077Z,1539188807.077 [RudderServo](ERROR): Communications Fault 2018-10-10T16:26:47.401Z,1539188807.401 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-10-10T16:26:47.425Z,1539188807.425 [ThrusterServo](FAULT): Thruster failed to initialize 2018-10-10T16:26:47.426Z,1539188807.426 [ThrusterServo] Communications Fault, FailCount= 1 2018-10-10T16:26:47.426Z,1539188807.426 [ThrusterServo](ERROR): Communications Fault 2018-10-10T16:26:47.437Z,1539188807.437 [CBIT](INFO): Critical error at 20181010T162645 2018-10-10T16:26:47.444Z,1539188807.444 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-10T16:26:47.445Z,1539188807.445 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2018-10-10T16:26:47.447Z,1539188807.447 [CBIT](ERROR): Communications Fault in component: RudderServo 2018-10-10T16:26:47.448Z,1539188807.448 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-10T16:26:47.542Z,1539188807.542 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:47.548Z,1539188807.548 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-10T16:26:47.580Z,1539188807.580 [BuoyancyServo](INFO): Powering down 2018-10-10T16:26:47.645Z,1539188807.645 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-10-10T16:26:47.645Z,1539188807.645 [ElevatorServo](INFO): Powering down 2018-10-10T16:26:47.747Z,1539188807.747 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-10-10T16:26:47.747Z,1539188807.747 [RudderServo](INFO): Powering down 2018-10-10T16:26:47.825Z,1539188807.825 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-10T16:26:47.825Z,1539188807.825 [ThrusterServo](INFO): Powering down 2018-10-10T16:26:48.034Z,1539188808.034 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:48.154Z,1539188808.154 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2018-10-10T16:26:48.244Z,1539188808.244 [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-10-10T16:26:48.339Z,1539188808.339 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track 2018-10-10T16:26:48.340Z,1539188808.340 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity 2018-10-10T16:26:48.367Z,1539188808.367 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe 2018-10-10T16:26:48.429Z,1539188808.429 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:48.452Z,1539188808.452 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:26:48.452Z,1539188808.452 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-10-10T16:26:48.737Z,1539188808.737 [MassServo](FAULT): Mass initialization uart error:serial timeout 2018-10-10T16:26:48.737Z,1539188808.737 [MassServo] Communications Fault, FailCount= 1 2018-10-10T16:26:48.737Z,1539188808.737 [MassServo](ERROR): Communications Fault 2018-10-10T16:26:48.738Z,1539188808.738 [RudderServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:26:48.739Z,1539188808.739 [RudderServo](DEBUG): Initializing RudderServo. 2018-10-10T16:26:48.745Z,1539188808.745 [CBIT](INFO): Clearing failed state for component ElevatorServo 2018-10-10T16:26:48.745Z,1539188808.745 [ElevatorServo] No Fault, FailCount= 1 2018-10-10T16:26:48.746Z,1539188808.746 [CBIT](ERROR): Communications Fault in component: MassServo 2018-10-10T16:26:48.746Z,1539188808.746 [CBIT](INFO): Clearing failed state for component RudderServo 2018-10-10T16:26:48.746Z,1539188808.746 [RudderServo] No Fault, FailCount= 1 2018-10-10T16:26:48.746Z,1539188808.746 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-10T16:26:48.746Z,1539188808.746 [ThrusterServo] No Fault, FailCount= 1 2018-10-10T16:26:48.828Z,1539188808.828 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:48.843Z,1539188808.843 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-10T16:26:48.844Z,1539188808.844 [MassServo](INFO): Powering down 2018-10-10T16:26:48.914Z,1539188808.914 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:26:48.914Z,1539188808.914 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-10T16:26:49.221Z,1539188809.221 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:49.458Z,1539188809.458 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-10T16:26:49.555Z,1539188809.555 [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-10-10T16:26:49.557Z,1539188809.557 [CTD_Seabird](INFO): LCM subscribed to channel:seabird_gpctd_t.seabird-gpctd 2018-10-10T16:26:49.614Z,1539188809.614 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2018-10-10T16:26:49.614Z,1539188809.614 [RudderServo](FAULT): Rudder failed to initialize 2018-10-10T16:26:49.614Z,1539188809.614 [RudderServo] Communications Fault, FailCount= 2 2018-10-10T16:26:49.615Z,1539188809.615 [RudderServo](ERROR): Communications Fault 2018-10-10T16:26:49.753Z,1539188809.753 [CBIT](ERROR): Communications Fault in component: RudderServo 2018-10-10T16:26:49.835Z,1539188809.835 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:49.849Z,1539188809.849 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:26:49.849Z,1539188809.849 [MassServo](DEBUG): Initializing MassServo. 2018-10-10T16:26:49.850Z,1539188809.850 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-10-10T16:26:49.850Z,1539188809.850 [RudderServo](INFO): Powering down 2018-10-10T16:26:49.879Z,1539188809.879 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-10T16:26:49.880Z,1539188809.880 [BuoyancyServo] No Fault, FailCount= 1 2018-10-10T16:26:49.880Z,1539188809.880 [CBIT](INFO): Clearing failed state for component MassServo 2018-10-10T16:26:49.880Z,1539188809.880 [MassServo] No Fault, FailCount= 1 2018-10-10T16:26:49.935Z,1539188809.935 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-10T16:26:49.935Z,1539188809.935 [CTD_Seabird](INFO): Powering down 2018-10-10T16:26:50.221Z,1539188810.221 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:50.228Z,1539188810.228 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:26:50.228Z,1539188810.228 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-10T16:26:50.636Z,1539188810.636 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:50.727Z,1539188810.727 [RudderServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:26:50.728Z,1539188810.728 [RudderServo](DEBUG): Initializing RudderServo. 2018-10-10T16:26:50.750Z,1539188810.750 [CBIT](INFO): Clearing failed state for component RudderServo 2018-10-10T16:26:50.750Z,1539188810.750 [RudderServo] No Fault, FailCount= 2 2018-10-10T16:26:51.022Z,1539188811.022 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:51.381Z,1539188811.381 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-10T16:26:51.381Z,1539188811.381 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-10T16:26:51.381Z,1539188811.381 [BuoyancyServo] Communications Fault, FailCount= 2 2018-10-10T16:26:51.381Z,1539188811.381 [BuoyancyServo](ERROR): Communications Fault 2018-10-10T16:26:51.469Z,1539188811.469 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-10T16:26:51.554Z,1539188811.554 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:51.577Z,1539188811.577 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-10T16:26:51.577Z,1539188811.577 [BuoyancyServo](INFO): Powering down 2018-10-10T16:26:51.901Z,1539188811.901 [ThrusterServo](FAULT): Thruster initialization uart error:serial timeout 2018-10-10T16:26:51.901Z,1539188811.901 [ThrusterServo] Communications Fault, FailCount= 2 2018-10-10T16:26:51.901Z,1539188811.901 [ThrusterServo](ERROR): Communications Fault 2018-10-10T16:26:51.905Z,1539188811.905 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-10T16:26:51.950Z,1539188811.950 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:51.983Z,1539188811.983 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-10T16:26:51.984Z,1539188811.984 [ThrusterServo](INFO): Powering down 2018-10-10T16:26:52.384Z,1539188812.384 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:52.780Z,1539188812.780 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:52.822Z,1539188812.822 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-10T16:26:52.822Z,1539188812.822 [ThrusterServo] No Fault, FailCount= 2 2018-10-10T16:26:53.136Z,1539188813.136 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2018-10-10T16:26:53.136Z,1539188813.136 [PNI_TCM] Data Fault, FailCount= 1 2018-10-10T16:26:53.136Z,1539188813.136 [PNI_TCM](ERROR): Data Fault 2018-10-10T16:26:53.157Z,1539188813.157 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:53.493Z,1539188813.493 [MassServo](ERROR): isCommunicating uart error serial timeout 2018-10-10T16:26:53.493Z,1539188813.493 [MassServo](FAULT): Invalid EZ Servo response:"" 2018-10-10T16:26:53.493Z,1539188813.493 [MassServo] Communications Fault, FailCount= 2 2018-10-10T16:26:53.493Z,1539188813.493 [MassServo](ERROR): Communications Fault 2018-10-10T16:26:53.493Z,1539188813.493 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: serial timeout 2018-10-10T16:26:53.494Z,1539188813.494 [MassServo] Hardware Fault, FailCount= 2 2018-10-10T16:26:53.494Z,1539188813.494 [MassServo](ERROR): Hardware Fault 2018-10-10T16:26:53.829Z,1539188813.829 [MassServo](FAULT): Invalid EZ Servo response:"17\r" 2018-10-10T16:26:53.829Z,1539188813.829 [MassServo] Communications Fault, FailCount= 2 2018-10-10T16:26:53.829Z,1539188813.829 [MassServo](ERROR): Communications Fault 2018-10-10T16:26:53.857Z,1539188813.857 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:26:53.858Z,1539188813.858 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-10T16:26:53.870Z,1539188813.870 [CBIT](CRITICAL): Environmental Failure. Press:14.705774 PSI. Humidity:39%. Temp:26 C. ABORTING MISSION 2018-10-10T16:26:53.871Z,1539188813.871 [CBIT](ERROR): Data Fault in component: PNI_TCM 2018-10-10T16:26:53.871Z,1539188813.871 [CBIT](ERROR): Communications Fault in component: MassServo 2018-10-10T16:26:53.921Z,1539188813.921 [PNI_TCM](INFO): Powering down 2018-10-10T16:26:53.986Z,1539188813.986 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:54.004Z,1539188814.004 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-10T16:26:54.004Z,1539188814.004 [MassServo](INFO): Powering down 2018-10-10T16:26:54.012Z,1539188814.012 [CBIT](INFO): Critical error at 20181010T162653 2018-10-10T16:26:54.026Z,1539188814.026 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-10T16:26:54.026Z,1539188814.026 [BuoyancyServo] No Fault, FailCount= 2 2018-10-10T16:26:54.340Z,1539188814.340 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:54.347Z,1539188814.347 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:26:54.348Z,1539188814.348 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-10T16:26:54.665Z,1539188814.665 [RudderServo](ERROR): getPosition uart error serial timeout 2018-10-10T16:26:54.665Z,1539188814.665 [RudderServo](FAULT): Rudder uart error - getPosition..serial timeout 2018-10-10T16:26:54.665Z,1539188814.665 [RudderServo] Communications Fault, FailCount= 3 2018-10-10T16:26:54.665Z,1539188814.665 [RudderServo](ERROR): Communications Fault 2018-10-10T16:26:54.993Z,1539188814.993 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-10-10T16:26:55.077Z,1539188815.077 [ThrusterServo](FAULT): Thruster failed to initialize 2018-10-10T16:26:55.077Z,1539188815.077 [ThrusterServo] Communications Fault, FailCount= 3 2018-10-10T16:26:55.077Z,1539188815.077 [ThrusterServo](ERROR): Communications Fault 2018-10-10T16:26:55.081Z,1539188815.081 [CBIT](ERROR): Communications Fault in component: RudderServo 2018-10-10T16:26:55.082Z,1539188815.082 [CBIT](CRITICAL): Communications Fault in component: RudderServo 2018-10-10T16:26:55.082Z,1539188815.082 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-10T16:26:55.139Z,1539188815.139 [Aanderaa_O2](FAULT): Timed out starting 2018-10-10T16:26:55.139Z,1539188815.139 [Aanderaa_O2] Communications Fault, FailCount= 1 2018-10-10T16:26:55.139Z,1539188815.139 [Aanderaa_O2](ERROR): Communications Fault 2018-10-10T16:26:55.155Z,1539188815.155 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:55.517Z,1539188815.517 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-10T16:26:55.517Z,1539188815.517 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-10T16:26:55.517Z,1539188815.517 [BuoyancyServo] Communications Fault, FailCount= 3 2018-10-10T16:26:55.517Z,1539188815.517 [BuoyancyServo](ERROR): Communications Fault 2018-10-10T16:26:55.518Z,1539188815.518 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:26:55.519Z,1539188815.519 [MassServo](DEBUG): Initializing MassServo. 2018-10-10T16:26:55.519Z,1539188815.519 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-10-10T16:26:55.520Z,1539188815.520 [RudderServo](INFO): Powering down 2018-10-10T16:26:55.521Z,1539188815.521 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-10T16:26:55.521Z,1539188815.521 [ThrusterServo](INFO): Powering down 2018-10-10T16:26:55.524Z,1539188815.524 [CBIT](INFO): Critical error at 20181010T162655 2018-10-10T16:26:55.527Z,1539188815.527 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-10T16:26:55.527Z,1539188815.527 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-10T16:26:55.527Z,1539188815.527 [CBIT](INFO): Clearing failed state for component MassServo 2018-10-10T16:26:55.527Z,1539188815.527 [MassServo] No Fault, FailCount= 2 2018-10-10T16:26:55.573Z,1539188815.573 [Aanderaa_O2](INFO): Powering down 2018-10-10T16:26:55.650Z,1539188815.650 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:55.692Z,1539188815.692 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-10T16:26:55.693Z,1539188815.693 [BuoyancyServo](INFO): Powering down 2018-10-10T16:26:55.711Z,1539188815.711 [CBIT](INFO): Clearing failed state for component PNI_TCM 2018-10-10T16:26:55.711Z,1539188815.711 [PNI_TCM] No Fault, FailCount= 1 2018-10-10T16:26:55.994Z,1539188815.994 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:56.018Z,1539188816.018 [RudderServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:26:56.018Z,1539188816.018 [RudderServo](DEBUG): Initializing RudderServo. 2018-10-10T16:26:56.024Z,1539188816.024 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-10T16:26:56.024Z,1539188816.024 [ThrusterServo] No Fault, FailCount= 3 2018-10-10T16:26:56.397Z,1539188816.397 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:56.419Z,1539188816.419 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:26:56.425Z,1539188816.425 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-10T16:26:56.441Z,1539188816.441 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-10T16:26:56.442Z,1539188816.442 [Aanderaa_O2] No Fault, FailCount= 1 2018-10-10T16:26:56.798Z,1539188816.798 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:57.249Z,1539188817.249 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:57.587Z,1539188817.587 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:57.615Z,1539188817.615 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-10T16:26:57.615Z,1539188817.615 [BuoyancyServo] No Fault, FailCount= 3 2018-10-10T16:26:58.005Z,1539188818.005 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:58.016Z,1539188818.016 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:26:58.016Z,1539188818.016 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-10T16:26:58.398Z,1539188818.398 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:58.785Z,1539188818.785 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:58.885Z,1539188818.885 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-10T16:26:58.885Z,1539188818.885 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-10T16:26:58.885Z,1539188818.885 [BuoyancyServo] Communications Fault, FailCount= 4 2018-10-10T16:26:58.885Z,1539188818.885 [BuoyancyServo](ERROR): Communications Fault 2018-10-10T16:26:58.945Z,1539188818.945 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-10T16:26:59.186Z,1539188819.186 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:59.196Z,1539188819.196 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-10T16:26:59.205Z,1539188819.205 [BuoyancyServo](INFO): Powering down 2018-10-10T16:26:59.601Z,1539188819.601 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:26:59.969Z,1539188819.969 [ThrusterServo](ERROR): Thruster uart error: serial timeout 2018-10-10T16:26:59.969Z,1539188819.969 [ThrusterServo] Communications Fault, FailCount= 4 2018-10-10T16:26:59.969Z,1539188819.969 [ThrusterServo](ERROR): Communications Fault 2018-10-10T16:26:59.973Z,1539188819.973 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-10T16:27:00.026Z,1539188820.026 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:00.304Z,1539188820.304 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US5CA83M.000 2018-10-10T16:27:00.353Z,1539188820.353 [MassServo](ERROR): isCommunicating uart error serial timeout 2018-10-10T16:27:00.353Z,1539188820.353 [MassServo](FAULT): Invalid EZ Servo response:"" 2018-10-10T16:27:00.353Z,1539188820.353 [MassServo] Communications Fault, FailCount= 3 2018-10-10T16:27:00.353Z,1539188820.353 [MassServo](ERROR): Communications Fault 2018-10-10T16:27:00.353Z,1539188820.353 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: serial timeout 2018-10-10T16:27:00.353Z,1539188820.353 [MassServo] Hardware Fault, FailCount= 3 2018-10-10T16:27:00.353Z,1539188820.353 [MassServo](ERROR): Hardware Fault 2018-10-10T16:27:00.702Z,1539188820.702 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-10T16:27:00.703Z,1539188820.703 [ThrusterServo](INFO): Powering down 2018-10-10T16:27:00.709Z,1539188820.709 [CBIT](ERROR): Hardware Fault in component: MassServo 2018-10-10T16:27:00.790Z,1539188820.790 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:00.812Z,1539188820.812 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-10T16:27:00.812Z,1539188820.812 [MassServo](INFO): Powering down 2018-10-10T16:27:01.178Z,1539188821.178 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:01.195Z,1539188821.195 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-10T16:27:01.195Z,1539188821.195 [BuoyancyServo] No Fault, FailCount= 4 2018-10-10T16:27:01.196Z,1539188821.196 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-10T16:27:01.196Z,1539188821.196 [ThrusterServo] No Fault, FailCount= 4 2018-10-10T16:27:01.577Z,1539188821.577 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:01.591Z,1539188821.591 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:27:01.592Z,1539188821.592 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-10T16:27:01.602Z,1539188821.602 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:27:01.602Z,1539188821.602 [MassServo](DEBUG): Initializing MassServo. 2018-10-10T16:27:01.603Z,1539188821.603 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:27:01.604Z,1539188821.604 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-10T16:27:01.621Z,1539188821.621 [CBIT](INFO): Clearing failed state for component MassServo 2018-10-10T16:27:01.621Z,1539188821.621 [MassServo] No Fault, FailCount= 3 2018-10-10T16:27:01.969Z,1539188821.969 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:02.396Z,1539188822.396 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:02.505Z,1539188822.505 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-10T16:27:02.505Z,1539188822.505 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-10T16:27:02.505Z,1539188822.505 [BuoyancyServo] Communications Fault, FailCount= 5 2018-10-10T16:27:02.505Z,1539188822.505 [BuoyancyServo](ERROR): Communications Fault 2018-10-10T16:27:02.621Z,1539188822.621 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-10T16:27:02.755Z,1539188822.755 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:02.793Z,1539188822.793 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-10T16:27:02.793Z,1539188822.793 [BuoyancyServo](INFO): Powering down 2018-10-10T16:27:03.145Z,1539188823.145 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2018-10-10T16:27:03.145Z,1539188823.145 [PNI_TCM] Data Fault, FailCount= 2 2018-10-10T16:27:03.145Z,1539188823.145 [PNI_TCM](ERROR): Data Fault 2018-10-10T16:27:03.158Z,1539188823.158 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:03.198Z,1539188823.198 [CBIT](ERROR): Data Fault in component: PNI_TCM 2018-10-10T16:27:03.538Z,1539188823.538 [PNI_TCM](INFO): Powering down 2018-10-10T16:27:03.550Z,1539188823.550 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:03.980Z,1539188823.980 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:04.376Z,1539188824.376 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:04.773Z,1539188824.773 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:05.109Z,1539188825.109 [MassServo](ERROR): isCommunicating uart error serial timeout 2018-10-10T16:27:05.109Z,1539188825.109 [MassServo](FAULT): Invalid EZ Servo response:"" 2018-10-10T16:27:05.109Z,1539188825.109 [MassServo] Communications Fault, FailCount= 4 2018-10-10T16:27:05.109Z,1539188825.109 [MassServo](ERROR): Communications Fault 2018-10-10T16:27:05.109Z,1539188825.109 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: serial timeout 2018-10-10T16:27:05.109Z,1539188825.109 [MassServo] Hardware Fault, FailCount= 4 2018-10-10T16:27:05.109Z,1539188825.109 [MassServo](ERROR): Hardware Fault 2018-10-10T16:27:05.441Z,1539188825.441 [MassServo](FAULT): Invalid EZ Servo response:"" 2018-10-10T16:27:05.441Z,1539188825.441 [MassServo] Communications Fault, FailCount= 4 2018-10-10T16:27:05.441Z,1539188825.441 [MassServo](ERROR): Communications Fault 2018-10-10T16:27:05.446Z,1539188825.446 [CBIT](INFO): Clearing failed state for component PNI_TCM 2018-10-10T16:27:05.446Z,1539188825.446 [PNI_TCM] No Fault, FailCount= 2 2018-10-10T16:27:05.446Z,1539188825.446 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-10T16:27:05.446Z,1539188825.446 [BuoyancyServo] No Fault, FailCount= 5 2018-10-10T16:27:05.447Z,1539188825.447 [CBIT](ERROR): Communications Fault in component: MassServo 2018-10-10T16:27:05.515Z,1539188825.515 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:05.527Z,1539188825.527 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:27:05.527Z,1539188825.527 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-10T16:27:05.537Z,1539188825.537 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-10T16:27:05.537Z,1539188825.537 [MassServo](INFO): Powering down 2018-10-10T16:27:05.907Z,1539188825.907 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:06.306Z,1539188826.306 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:06.641Z,1539188826.641 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-10T16:27:06.641Z,1539188826.641 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-10T16:27:06.641Z,1539188826.641 [BuoyancyServo] Communications Fault, FailCount= 6 2018-10-10T16:27:06.641Z,1539188826.641 [BuoyancyServo](ERROR): Communications Fault 2018-10-10T16:27:06.642Z,1539188826.642 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:27:06.643Z,1539188826.643 [MassServo](DEBUG): Initializing MassServo. 2018-10-10T16:27:06.648Z,1539188826.648 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-10T16:27:06.648Z,1539188826.648 [CBIT](INFO): Clearing failed state for component MassServo 2018-10-10T16:27:06.648Z,1539188826.648 [MassServo] No Fault, FailCount= 4 2018-10-10T16:27:06.723Z,1539188826.723 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:06.749Z,1539188826.749 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-10T16:27:06.749Z,1539188826.749 [BuoyancyServo](INFO): Powering down 2018-10-10T16:27:07.079Z,1539188827.079 [Aanderaa_O2](FAULT): Timed out starting 2018-10-10T16:27:07.079Z,1539188827.079 [Aanderaa_O2] Communications Fault, FailCount= 2 2018-10-10T16:27:07.079Z,1539188827.079 [Aanderaa_O2](ERROR): Communications Fault 2018-10-10T16:27:07.141Z,1539188827.141 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:07.217Z,1539188827.217 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-10T16:27:07.494Z,1539188827.494 [Aanderaa_O2](INFO): Powering down 2018-10-10T16:27:07.534Z,1539188827.534 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:07.914Z,1539188827.914 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:08.302Z,1539188828.302 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:08.625Z,1539188828.625 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout 2018-10-10T16:27:08.625Z,1539188828.625 [MassServo] Communications Fault, FailCount= 5 2018-10-10T16:27:08.625Z,1539188828.625 [MassServo](ERROR): Communications Fault 2018-10-10T16:27:08.626Z,1539188828.626 [SBIT](IMPORTANT): Beginning Startup BIT 2018-10-10T16:27:08.631Z,1539188828.631 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-10T16:27:08.631Z,1539188828.631 [Aanderaa_O2] No Fault, FailCount= 2 2018-10-10T16:27:08.631Z,1539188828.631 [CBIT](ERROR): Communications Fault in component: MassServo 2018-10-10T16:27:08.631Z,1539188828.631 [CBIT](CRITICAL): Communications Fault in component: MassServo 2018-10-10T16:27:08.632Z,1539188828.632 [CBIT](IMPORTANT): Beginning ground fault scan 2018-10-10T16:27:08.732Z,1539188828.732 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:09.089Z,1539188829.089 [ElevatorServo](ERROR): getPosition uart error serial timeout 2018-10-10T16:27:09.089Z,1539188829.089 [ElevatorServo](FAULT): Elevator uart error - getPosition.serial timeout 2018-10-10T16:27:09.089Z,1539188829.089 [ElevatorServo] Communications Fault, FailCount= 2 2018-10-10T16:27:09.089Z,1539188829.089 [ElevatorServo](ERROR): Communications Fault 2018-10-10T16:27:09.090Z,1539188829.090 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-10T16:27:09.090Z,1539188829.090 [MassServo](INFO): Powering down 2018-10-10T16:27:09.113Z,1539188829.113 [CBIT](INFO): Critical error at 20181010T162708 2018-10-10T16:27:09.115Z,1539188829.115 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-10T16:27:09.115Z,1539188829.115 [BuoyancyServo] No Fault, FailCount= 6 2018-10-10T16:27:09.116Z,1539188829.116 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2018-10-10T16:27:09.199Z,1539188829.199 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:09.222Z,1539188829.222 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:27:09.223Z,1539188829.223 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-10T16:27:09.224Z,1539188829.224 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-10-10T16:27:09.224Z,1539188829.224 [ElevatorServo](INFO): Powering down 2018-10-10T16:27:09.609Z,1539188829.609 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:09.625Z,1539188829.625 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:27:09.625Z,1539188829.625 [MassServo](DEBUG): Initializing MassServo. 2018-10-10T16:27:09.946Z,1539188829.946 [NAL9602](INFO): Powering up NAL9602 2018-10-10T16:27:09.997Z,1539188829.997 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:10.341Z,1539188830.341 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-10T16:27:10.341Z,1539188830.341 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-10T16:27:10.341Z,1539188830.341 [BuoyancyServo] Communications Fault, FailCount= 7 2018-10-10T16:27:10.341Z,1539188830.341 [BuoyancyServo](ERROR): Communications Fault 2018-10-10T16:27:10.342Z,1539188830.342 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:27:10.342Z,1539188830.342 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-10-10T16:27:10.376Z,1539188830.376 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-10T16:27:10.376Z,1539188830.376 [CBIT](INFO): Clearing failed state for component ElevatorServo 2018-10-10T16:27:10.376Z,1539188830.376 [ElevatorServo] No Fault, FailCount= 2 2018-10-10T16:27:10.542Z,1539188830.542 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:10.575Z,1539188830.575 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-10T16:27:10.576Z,1539188830.576 [BuoyancyServo](INFO): Powering down 2018-10-10T16:27:10.969Z,1539188830.969 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:11.281Z,1539188831.281 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2018-10-10T16:27:11.281Z,1539188831.281 [ElevatorServo](FAULT): Elevator failed to initialize 2018-10-10T16:27:11.281Z,1539188831.281 [ElevatorServo] Communications Fault, FailCount= 3 2018-10-10T16:27:11.281Z,1539188831.281 [ElevatorServo](ERROR): Communications Fault 2018-10-10T16:27:11.286Z,1539188831.286 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2018-10-10T16:27:11.287Z,1539188831.287 [CBIT](CRITICAL): Communications Fault in component: ElevatorServo 2018-10-10T16:27:11.382Z,1539188831.382 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:11.398Z,1539188831.398 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-10-10T16:27:11.398Z,1539188831.398 [ElevatorServo](INFO): Powering down 2018-10-10T16:27:11.406Z,1539188831.406 [CBIT](INFO): Critical error at 20181010T162711 2018-10-10T16:27:11.758Z,1539188831.758 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:12.142Z,1539188832.142 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:12.149Z,1539188832.149 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:27:12.149Z,1539188832.149 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-10-10T16:27:12.519Z,1539188832.519 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2018-10-10T16:27:12.519Z,1539188832.519 [PNI_TCM] Data Fault, FailCount= 3 2018-10-10T16:27:12.519Z,1539188832.519 [PNI_TCM](ERROR): Data Fault 2018-10-10T16:27:12.554Z,1539188832.554 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:12.566Z,1539188832.566 [CBIT](ERROR): Data Fault in component: PNI_TCM 2018-10-10T16:27:12.566Z,1539188832.566 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-10T16:27:12.566Z,1539188832.566 [BuoyancyServo] No Fault, FailCount= 7 2018-10-10T16:27:12.919Z,1539188832.919 [PNI_TCM](INFO): Powering down 2018-10-10T16:27:12.947Z,1539188832.947 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:12.954Z,1539188832.954 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-10T16:27:12.955Z,1539188832.955 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-10T16:27:13.361Z,1539188833.361 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:13.754Z,1539188833.754 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:13.849Z,1539188833.849 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-10T16:27:13.849Z,1539188833.849 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-10T16:27:13.849Z,1539188833.849 [BuoyancyServo] Communications Fault, FailCount= 8 2018-10-10T16:27:13.849Z,1539188833.849 [BuoyancyServo](ERROR): Communications Fault 2018-10-10T16:27:13.854Z,1539188833.854 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-10T16:27:14.158Z,1539188834.158 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:14.168Z,1539188834.168 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-10T16:27:14.168Z,1539188834.168 [BuoyancyServo](INFO): Powering down 2018-10-10T16:27:14.214Z,1539188834.214 [CBIT](INFO): Clearing failed state for component PNI_TCM 2018-10-10T16:27:14.214Z,1539188834.214 [PNI_TCM] No Fault, FailCount= 3 2018-10-10T16:27:14.552Z,1539188834.552 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:14.933Z,1539188834.933 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:15.347Z,1539188835.347 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T16:27:15.737Z,1539188835.737 [DeadReckonUsingSpeed