2018-10-10T19:29:59.172Z,1539199799.172 [Supervisor](DEBUG): Initializing supervisor. 2018-10-10T19:29:59.176Z,1539199799.176 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2018-10-10T19:29:59.177Z,1539199799.177 [SyncHandler](INFO): Protected caller Thread ID is 797 2018-10-10T19:29:59.177Z,1539199799.177 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2018-10-10T19:29:59.179Z,1539199799.179 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2018-10-10T19:29:59.179Z,1539199799.179 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 798 2018-10-10T19:29:59.183Z,1539199799.183 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2018-10-10T19:29:59.195Z,1539199799.195 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2018-10-10T19:29:59.196Z,1539199799.196 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2018-10-10T19:29:59.196Z,1539199799.196 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 799 2018-10-10T19:29:59.198Z,1539199799.198 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2018-10-10T19:29:59.199Z,1539199799.199 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2018-10-10T19:29:59.199Z,1539199799.199 [logger ThreadHandler](INFO): Protected caller Thread ID is 800 2018-10-10T19:29:59.202Z,1539199799.202 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2018-10-10T19:29:59.203Z,1539199799.203 [Supervisor](INFO): Looking for Config files in directory: Config/ 2018-10-10T19:29:59.206Z,1539199799.206 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2018-10-10T19:29:59.332Z,1539199799.332 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2018-10-10T19:29:59.334Z,1539199799.334 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2018-10-10T19:29:59.447Z,1539199799.447 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2018-10-10T19:29:59.449Z,1539199799.449 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2018-10-10T19:29:59.698Z,1539199799.698 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2018-10-10T19:29:59.698Z,1539199799.698 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2018-10-10T19:30:00.119Z,1539199800.119 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2018-10-10T19:30:00.121Z,1539199800.121 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2018-10-10T19:30:00.496Z,1539199800.496 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2018-10-10T19:30:00.496Z,1539199800.496 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2018-10-10T19:30:01.057Z,1539199801.057 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2018-10-10T19:30:01.059Z,1539199801.059 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2018-10-10T19:30:01.538Z,1539199801.538 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2018-10-10T19:30:01.539Z,1539199801.539 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2018-10-10T19:30:02.018Z,1539199802.018 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2018-10-10T19:30:02.019Z,1539199802.019 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2018-10-10T19:30:02.775Z,1539199802.775 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2018-10-10T19:30:03.103Z,1539199803.103 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2018-10-10T19:30:03.105Z,1539199803.105 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2018-10-10T19:30:03.259Z,1539199803.259 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2018-10-10T19:30:03.260Z,1539199803.260 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2018-10-10T19:30:03.482Z,1539199803.482 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2018-10-10T19:30:03.484Z,1539199803.484 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2018-10-10T19:30:03.697Z,1539199803.697 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2018-10-10T19:30:03.698Z,1539199803.698 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2018-10-10T19:30:03.798Z,1539199803.798 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2018-10-10T19:30:03.800Z,1539199803.800 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2018-10-10T19:30:03.953Z,1539199803.953 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2018-10-10T19:30:03.955Z,1539199803.955 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2018-10-10T19:30:03.958Z,1539199803.958 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2018-10-10T19:30:04.191Z,1539199804.191 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2018-10-10T19:30:04.191Z,1539199804.191 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2018-10-10T19:30:04.300Z,1539199804.300 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2018-10-10T19:30:04.448Z,1539199804.448 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2018-10-10T19:30:04.543Z,1539199804.543 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2018-10-10T19:30:04.630Z,1539199804.630 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2018-10-10T19:30:04.783Z,1539199804.783 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2018-10-10T19:30:04.979Z,1539199804.979 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2018-10-10T19:30:05.079Z,1539199805.079 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2018-10-10T19:30:05.176Z,1539199805.176 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2018-10-10T19:30:05.275Z,1539199805.275 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2018-10-10T19:30:05.359Z,1539199805.359 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2018-10-10T19:30:05.363Z,1539199805.363 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2018-10-10T19:30:05.490Z,1539199805.490 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2018-10-10T19:30:05.490Z,1539199805.490 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2018-10-10T19:30:05.514Z,1539199805.514 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2018-10-10T19:30:05.515Z,1539199805.515 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2018-10-10T19:30:05.569Z,1539199805.569 [DepthRateCalculator] Loaded 2018-10-10T19:30:05.570Z,1539199805.570 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2018-10-10T19:30:05.576Z,1539199805.576 [PitchRateCalculator] Loaded 2018-10-10T19:30:05.576Z,1539199805.576 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2018-10-10T19:30:05.592Z,1539199805.592 [SpeedCalculator] Loaded 2018-10-10T19:30:05.592Z,1539199805.592 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2018-10-10T19:30:05.612Z,1539199805.612 [TempGradientCalculator] Loaded 2018-10-10T19:30:05.613Z,1539199805.613 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2018-10-10T19:30:05.619Z,1539199805.619 [YawRateCalculator] Loaded 2018-10-10T19:30:05.619Z,1539199805.619 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2018-10-10T19:30:05.658Z,1539199805.658 [ElevatorOffsetCalculator] Loaded 2018-10-10T19:30:05.658Z,1539199805.658 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2018-10-10T19:30:05.658Z,1539199805.658 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2018-10-10T19:30:05.659Z,1539199805.659 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2018-10-10T19:30:05.697Z,1539199805.697 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2018-10-10T19:30:05.697Z,1539199805.697 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2018-10-10T19:30:06.263Z,1539199806.263 [DataOverHttps] Loaded 2018-10-10T19:30:06.263Z,1539199806.263 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2018-10-10T19:30:06.288Z,1539199806.288 [Depth_Keller] Loaded 2018-10-10T19:30:06.289Z,1539199806.289 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2018-10-10T19:30:06.294Z,1539199806.294 [DropWeight] Loaded 2018-10-10T19:30:06.294Z,1539199806.294 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2018-10-10T19:30:06.391Z,1539199806.391 [NAL9602] Loaded 2018-10-10T19:30:06.391Z,1539199806.391 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2018-10-10T19:30:06.407Z,1539199806.407 [Onboard] Loaded 2018-10-10T19:30:06.407Z,1539199806.407 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2018-10-10T19:30:06.417Z,1539199806.417 [Radio_Surface] Loaded 2018-10-10T19:30:06.418Z,1539199806.418 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2018-10-10T19:30:06.419Z,1539199806.419 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407C24E0 2018-10-10T19:30:06.419Z,1539199806.419 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 879 2018-10-10T19:30:06.571Z,1539199806.571 [PNI_TCM] Loaded 2018-10-10T19:30:06.572Z,1539199806.572 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2018-10-10T19:30:06.632Z,1539199806.632 [Rowe_600LCM] Loaded 2018-10-10T19:30:06.632Z,1539199806.632 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread. 2018-10-10T19:30:06.633Z,1539199806.633 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 407F24E0 2018-10-10T19:30:06.634Z,1539199806.634 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 880 2018-10-10T19:30:08.896Z,1539199808.896 [BPC1] Loaded 2018-10-10T19:30:08.896Z,1539199808.896 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2018-10-10T19:30:08.896Z,1539199808.896 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2018-10-10T19:30:08.897Z,1539199808.897 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2018-10-10T19:30:09.048Z,1539199809.048 [SBIT](DEBUG): Construct Startup Built In Test. 2018-10-10T19:30:09.071Z,1539199809.071 [SBIT] Loaded 2018-10-10T19:30:09.072Z,1539199809.072 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2018-10-10T19:30:09.072Z,1539199809.072 [IBIT](DEBUG): Construct Initiated Built In Test. 2018-10-10T19:30:09.084Z,1539199809.084 [IBIT] Loaded 2018-10-10T19:30:09.084Z,1539199809.084 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2018-10-10T19:30:09.087Z,1539199809.087 [CBIT](DEBUG): Construct Continuous Built In Test. 2018-10-10T19:30:09.233Z,1539199809.233 [CBIT] Loaded 2018-10-10T19:30:09.233Z,1539199809.233 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2018-10-10T19:30:09.234Z,1539199809.234 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2018-10-10T19:30:09.234Z,1539199809.234 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2018-10-10T19:30:09.437Z,1539199809.437 [Aanderaa_O2] Loaded 2018-10-10T19:30:09.437Z,1539199809.437 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2018-10-10T19:30:09.488Z,1539199809.488 [CTD_Seabird] Loaded 2018-10-10T19:30:09.489Z,1539199809.489 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2018-10-10T19:30:09.490Z,1539199809.490 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 408BC4E0 2018-10-10T19:30:09.490Z,1539199809.490 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 881 2018-10-10T19:30:09.507Z,1539199809.507 [ESPComponent] Loaded 2018-10-10T19:30:09.507Z,1539199809.507 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2018-10-10T19:30:09.521Z,1539199809.521 [PAR_Licor] Loaded 2018-10-10T19:30:09.522Z,1539199809.522 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2018-10-10T19:30:09.569Z,1539199809.569 [WetLabsBB2FL] Loaded 2018-10-10T19:30:09.570Z,1539199809.570 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2018-10-10T19:30:09.571Z,1539199809.571 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 408EC4E0 2018-10-10T19:30:09.571Z,1539199809.571 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 882 2018-10-10T19:30:09.572Z,1539199809.572 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2018-10-10T19:30:09.572Z,1539199809.572 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2018-10-10T19:30:09.849Z,1539199809.849 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2018-10-10T19:30:09.851Z,1539199809.851 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2018-10-10T19:30:09.937Z,1539199809.937 [VerticalControl](DEBUG): Construct VerticalControl. 2018-10-10T19:30:10.030Z,1539199810.030 [VerticalControl] Loaded 2018-10-10T19:30:10.030Z,1539199810.030 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2018-10-10T19:30:10.031Z,1539199810.031 [HorizontalControl](DEBUG): Construct HorizontalControl. 2018-10-10T19:30:10.092Z,1539199810.092 [HorizontalControl] Loaded 2018-10-10T19:30:10.092Z,1539199810.092 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2018-10-10T19:30:10.093Z,1539199810.093 [SpeedControl](DEBUG): Construct SpeedControl. 2018-10-10T19:30:10.098Z,1539199810.098 [SpeedControl] Loaded 2018-10-10T19:30:10.098Z,1539199810.098 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2018-10-10T19:30:10.099Z,1539199810.099 [LoopControl](DEBUG): Construct LoopControl. 2018-10-10T19:30:10.099Z,1539199810.099 [LoopControl] Loaded 2018-10-10T19:30:10.099Z,1539199810.099 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2018-10-10T19:30:10.100Z,1539199810.100 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2018-10-10T19:30:10.101Z,1539199810.101 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2018-10-10T19:30:10.202Z,1539199810.202 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2018-10-10T19:30:10.203Z,1539199810.203 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2018-10-10T19:30:10.322Z,1539199810.322 [BuoyancyServo] Loaded 2018-10-10T19:30:10.322Z,1539199810.322 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2018-10-10T19:30:10.334Z,1539199810.334 [ElevatorServo] Loaded 2018-10-10T19:30:10.334Z,1539199810.334 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2018-10-10T19:30:10.345Z,1539199810.345 [MassServo] Loaded 2018-10-10T19:30:10.345Z,1539199810.345 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2018-10-10T19:30:10.356Z,1539199810.356 [RudderServo] Loaded 2018-10-10T19:30:10.356Z,1539199810.356 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2018-10-10T19:30:10.367Z,1539199810.367 [ThrusterServo] Loaded 2018-10-10T19:30:10.368Z,1539199810.368 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2018-10-10T19:30:10.368Z,1539199810.368 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2018-10-10T19:30:10.369Z,1539199810.369 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2018-10-10T19:30:10.476Z,1539199810.476 [DeadReckonUsingSpeedCalculator] Loaded 2018-10-10T19:30:10.476Z,1539199810.476 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2018-10-10T19:30:10.492Z,1539199810.492 [NavChart] Loaded 2018-10-10T19:30:10.492Z,1539199810.492 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2018-10-10T19:30:10.496Z,1539199810.496 [UniversalFixResidualReporter] Loaded 2018-10-10T19:30:10.497Z,1539199810.497 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2018-10-10T19:30:10.497Z,1539199810.497 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2018-10-10T19:30:10.501Z,1539199810.501 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2018-10-10T19:30:10.501Z,1539199810.501 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2018-10-10T19:30:10.508Z,1539199810.508 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2018-10-10T19:30:10.509Z,1539199810.509 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A454E0 2018-10-10T19:30:10.509Z,1539199810.509 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 883 2018-10-10T19:30:10.514Z,1539199810.514 [Supervisor](INFO): Main Thread ID is 796 2018-10-10T19:30:10.514Z,1539199810.514 [Supervisor](DEBUG): Running supervisor. 2018-10-10T19:30:10.515Z,1539199810.515 [CommandLine ThreadHandler](INFO): Handler Thread ID is 884 2018-10-10T19:30:10.517Z,1539199810.517 [controlThread ThreadHandler](INFO): Handler Thread ID is 885 2018-10-10T19:30:10.518Z,1539199810.518 [controlThread](DEBUG): Initializing ControlThread 2018-10-10T19:30:10.519Z,1539199810.519 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-10-10T19:30:10.519Z,1539199810.519 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2018-10-10T19:30:10.519Z,1539199810.519 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2018-10-10T19:30:10.520Z,1539199810.520 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2018-10-10T19:30:10.520Z,1539199810.520 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2018-10-10T19:30:10.521Z,1539199810.521 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2018-10-10T19:30:10.528Z,1539199810.528 [SBIT](INFO): Initialize SBIT Component. 2018-10-10T19:30:10.528Z,1539199810.528 [SBIT](IMPORTANT): git: 2018-10-09-5-g8e0f966 2018-10-10T19:30:10.528Z,1539199810.528 [SBIT](INFO): git hash: 8e0f9669898461179fe27a6b90da366188de3daf 2018-10-10T19:30:10.529Z,1539199810.529 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2018-10-10T19:30:10.529Z,1539199810.529 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018 2018-10-10T19:30:10.530Z,1539199810.530 [SBIT](INFO): Beginning SBIT in 24.000000 seconds. 2018-10-10T19:30:10.531Z,1539199810.531 [IBIT](INFO): Initialize IBIT Component. 2018-10-10T19:30:10.532Z,1539199810.532 [CBIT](DEBUG): Initialize CBIT Component. 2018-10-10T19:30:10.532Z,1539199810.532 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2018-10-10T19:30:10.532Z,1539199810.532 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET. 2018-10-10T19:30:10.533Z,1539199810.533 [logger ThreadHandler](INFO): Handler Thread ID is 886 2018-10-10T19:30:10.550Z,1539199810.550 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 887 2018-10-10T19:30:10.556Z,1539199810.556 [Radio_Surface](INFO): Powering up 2018-10-10T19:30:10.562Z,1539199810.562 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 888 2018-10-10T19:30:10.562Z,1539199810.562 [Rowe_600LCM](INFO): Initializing 2018-10-10T19:30:10.563Z,1539199810.563 [Rowe_600LCM](INFO): Checking LCM 2018-10-10T19:30:10.647Z,1539199810.647 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 889 2018-10-10T19:30:10.647Z,1539199810.647 [CTD_Seabird](INFO): Initializing 2018-10-10T19:30:10.648Z,1539199810.648 [CTD_Seabird](INFO): Checking LCM 2018-10-10T19:30:10.650Z,1539199810.650 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2018-10-10T19:30:10.652Z,1539199810.652 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2018-10-10T19:30:10.652Z,1539199810.652 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2018-10-10T19:30:10.653Z,1539199810.653 [LoopControl](DEBUG): Initialize LoopControlComponent. 2018-10-10T19:30:10.654Z,1539199810.654 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-10-10T19:30:10.655Z,1539199810.655 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-10-10T19:30:10.655Z,1539199810.655 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-10-10T19:30:10.656Z,1539199810.656 [NavChart](DEBUG): Initialize NavChart Navigation. 2018-10-10T19:30:10.656Z,1539199810.656 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2018-10-10T19:30:10.657Z,1539199810.657 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2018-10-10T19:30:10.669Z,1539199810.668 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 890 2018-10-10T19:30:10.670Z,1539199810.670 [WetLabsBB2FL](INFO): Powering down 2018-10-10T19:30:10.785Z,1539199810.785 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 891 2018-10-10T19:30:10.795Z,1539199810.795 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2018-10-10T19:30:10.795Z,1539199810.795 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2018-10-10T19:30:10.795Z,1539199810.795 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2018-10-10T19:30:10.795Z,1539199810.795 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2018-10-10T19:30:10.795Z,1539199810.795 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2018-10-10T19:30:10.796Z,1539199810.796 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2018-10-10T19:30:10.796Z,1539199810.796 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2018-10-10T19:30:10.796Z,1539199810.796 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2018-10-10T19:30:10.796Z,1539199810.796 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2018-10-10T19:30:10.796Z,1539199810.796 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2018-10-10T19:30:10.797Z,1539199810.797 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2018-10-10T19:30:10.797Z,1539199810.797 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2018-10-10T19:30:10.797Z,1539199810.797 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2018-10-10T19:30:10.797Z,1539199810.797 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2018-10-10T19:30:10.797Z,1539199810.797 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2018-10-10T19:30:10.798Z,1539199810.798 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2018-10-10T19:30:10.892Z,1539199810.892 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2018-10-10T19:30:10.952Z,1539199810.952 [CTD_Seabird](INFO): LCM OK 2018-10-10T19:30:10.952Z,1539199810.952 [CTD_Seabird](INFO): Powering up 2018-10-10T19:30:10.953Z,1539199810.953 [Rowe_600LCM](INFO): LCM OK 2018-10-10T19:30:10.953Z,1539199810.953 [Rowe_600LCM](INFO): Powering up 2018-10-10T19:30:10.959Z,1539199810.959 [MissionManager](DEBUG): 2018-10-10T19:30:10.960Z,1539199810.960 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2018-10-10T19:30:11.039Z,1539199811.039 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2018-10-10T19:30:11.040Z,1539199811.040 [Default:A.Wait](DEBUG): Construct Wait. 2018-10-10T19:30:11.062Z,1539199811.062 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2018-10-10T19:30:11.089Z,1539199811.089 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2018-10-10T19:30:11.091Z,1539199811.091 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2018-10-10T19:30:11.107Z,1539199811.107 [Default:E.Execute](DEBUG): Construct Execute. 2018-10-10T19:30:11.127Z,1539199811.127 [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-10T19:30:11.133Z,1539199811.133 [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-10T19:30:11.158Z,1539199811.158 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2018-10-10T19:30:11.199Z,1539199811.199 [Depth_Keller](ERROR): Pressure reading out of range: 1895.684326 decibar 2018-10-10T19:30:11.364Z,1539199811.364 [ESPComponent](INFO): powering down ESP 2018-10-10T19:30:11.681Z,1539199811.681 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-10-10T19:30:11.765Z,1539199811.765 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:12.010Z,1539199812.010 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:12.018Z,1539199812.018 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-10T19:30:12.040Z,1539199812.040 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:12.046Z,1539199812.046 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-10-10T19:30:12.060Z,1539199812.060 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:12.066Z,1539199812.066 [MassServo](DEBUG): Initializing MassServo. 2018-10-10T19:30:12.080Z,1539199812.080 [RudderServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:12.086Z,1539199812.086 [RudderServo](DEBUG): Initializing RudderServo. 2018-10-10T19:30:12.110Z,1539199812.110 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:12.118Z,1539199812.118 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-10T19:30:12.155Z,1539199812.155 [CommandLine](FAULT): Scheduling is paused 2018-10-10T19:30:12.155Z,1539199812.155 [CBIT](INFO): Critical error at 20181010T193010 2018-10-10T19:30:12.155Z,1539199812.155 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2018-10-10T19:30:12.352Z,1539199812.352 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2018-10-10T19:30:12.352Z,1539199812.352 [DropWeight] Hardware Fault, FailCount= 1 2018-10-10T19:30:12.352Z,1539199812.352 [DropWeight](ERROR): Hardware Fault 2018-10-10T19:30:12.448Z,1539199812.448 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:12.486Z,1539199812.486 [CBIT](INFO): Critical error at 20181010T193012 2018-10-10T19:30:12.489Z,1539199812.489 [CBIT](ERROR): Hardware Fault in component: DropWeight 2018-10-10T19:30:12.489Z,1539199812.489 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2018-10-10T19:30:12.666Z,1539199812.666 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:13.005Z,1539199813.005 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-10T19:30:13.006Z,1539199813.006 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-10T19:30:13.006Z,1539199813.006 [BuoyancyServo] Communications Fault, FailCount= 1 2018-10-10T19:30:13.006Z,1539199813.006 [BuoyancyServo](ERROR): Communications Fault 2018-10-10T19:30:13.317Z,1539199813.317 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2018-10-10T19:30:13.318Z,1539199813.318 [ElevatorServo](FAULT): Elevator failed to initialize 2018-10-10T19:30:13.318Z,1539199813.318 [ElevatorServo] Communications Fault, FailCount= 1 2018-10-10T19:30:13.318Z,1539199813.318 [ElevatorServo](ERROR): Communications Fault 2018-10-10T19:30:13.621Z,1539199813.621 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2018-10-10T19:30:13.622Z,1539199813.622 [RudderServo](FAULT): Rudder failed to initialize 2018-10-10T19:30:13.622Z,1539199813.622 [RudderServo] Communications Fault, FailCount= 1 2018-10-10T19:30:13.622Z,1539199813.622 [RudderServo](ERROR): Communications Fault 2018-10-10T19:30:13.946Z,1539199813.946 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-10-10T19:30:13.970Z,1539199813.970 [ThrusterServo](FAULT): Thruster failed to initialize 2018-10-10T19:30:13.971Z,1539199813.971 [ThrusterServo] Communications Fault, FailCount= 1 2018-10-10T19:30:13.971Z,1539199813.971 [ThrusterServo](ERROR): Communications Fault 2018-10-10T19:30:13.982Z,1539199813.982 [CBIT](INFO): Critical error at 20181010T193012 2018-10-10T19:30:13.989Z,1539199813.989 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-10T19:30:13.990Z,1539199813.990 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2018-10-10T19:30:13.991Z,1539199813.991 [CBIT](ERROR): Communications Fault in component: RudderServo 2018-10-10T19:30:13.993Z,1539199813.993 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-10T19:30:14.101Z,1539199814.101 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:14.115Z,1539199814.115 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-10T19:30:14.116Z,1539199814.116 [BuoyancyServo](INFO): Powering down 2018-10-10T19:30:14.206Z,1539199814.206 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-10-10T19:30:14.206Z,1539199814.206 [ElevatorServo](INFO): Powering down 2018-10-10T19:30:14.258Z,1539199814.258 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-10-10T19:30:14.258Z,1539199814.258 [RudderServo](INFO): Powering down 2018-10-10T19:30:14.313Z,1539199814.313 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-10T19:30:14.313Z,1539199814.313 [ThrusterServo](INFO): Powering down 2018-10-10T19:30:14.474Z,1539199814.474 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:14.791Z,1539199814.791 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2018-10-10T19:30:14.883Z,1539199814.883 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:14.892Z,1539199814.892 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:14.893Z,1539199814.893 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-10-10T19:30:14.988Z,1539199814.988 [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-10T19:30:15.120Z,1539199815.120 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track 2018-10-10T19:30:15.141Z,1539199815.141 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity 2018-10-10T19:30:15.142Z,1539199815.142 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe 2018-10-10T19:30:15.182Z,1539199815.182 [MassServo](FAULT): Mass initialization uart error:serial timeout 2018-10-10T19:30:15.182Z,1539199815.182 [MassServo] Communications Fault, FailCount= 1 2018-10-10T19:30:15.182Z,1539199815.182 [MassServo](ERROR): Communications Fault 2018-10-10T19:30:15.183Z,1539199815.183 [RudderServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:15.183Z,1539199815.183 [RudderServo](DEBUG): Initializing RudderServo. 2018-10-10T19:30:15.189Z,1539199815.189 [CBIT](INFO): Clearing failed state for component ElevatorServo 2018-10-10T19:30:15.189Z,1539199815.189 [ElevatorServo] No Fault, FailCount= 1 2018-10-10T19:30:15.190Z,1539199815.190 [CBIT](ERROR): Communications Fault in component: MassServo 2018-10-10T19:30:15.190Z,1539199815.190 [CBIT](INFO): Clearing failed state for component RudderServo 2018-10-10T19:30:15.190Z,1539199815.190 [RudderServo] No Fault, FailCount= 1 2018-10-10T19:30:15.190Z,1539199815.190 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-10T19:30:15.190Z,1539199815.190 [ThrusterServo] No Fault, FailCount= 1 2018-10-10T19:30:15.309Z,1539199815.309 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:15.341Z,1539199815.341 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-10T19:30:15.341Z,1539199815.341 [MassServo](INFO): Powering down 2018-10-10T19:30:15.426Z,1539199815.426 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:15.426Z,1539199815.426 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-10T19:30:15.650Z,1539199815.650 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:16.027Z,1539199816.027 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-10T19:30:16.050Z,1539199816.050 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2018-10-10T19:30:16.050Z,1539199816.050 [RudderServo](FAULT): Rudder failed to initialize 2018-10-10T19:30:16.050Z,1539199816.050 [RudderServo] Communications Fault, FailCount= 2 2018-10-10T19:30:16.050Z,1539199816.050 [RudderServo](ERROR): Communications Fault 2018-10-10T19:30:16.117Z,1539199816.117 [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-10T19:30:16.118Z,1539199816.118 [CTD_Seabird](INFO): LCM subscribed to channel:seabird_gpctd_t.seabird-gpctd 2018-10-10T19:30:16.378Z,1539199816.378 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-10-10T19:30:16.458Z,1539199816.458 [ThrusterServo](FAULT): Thruster failed to initialize 2018-10-10T19:30:16.458Z,1539199816.458 [ThrusterServo] Communications Fault, FailCount= 2 2018-10-10T19:30:16.458Z,1539199816.458 [ThrusterServo](ERROR): Communications Fault 2018-10-10T19:30:16.463Z,1539199816.463 [CBIT](ERROR): Communications Fault in component: RudderServo 2018-10-10T19:30:16.463Z,1539199816.463 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-10T19:30:16.554Z,1539199816.554 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-10T19:30:16.554Z,1539199816.554 [CTD_Seabird](INFO): Powering down 2018-10-10T19:30:16.586Z,1539199816.586 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:16.620Z,1539199816.620 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:16.620Z,1539199816.620 [MassServo](DEBUG): Initializing MassServo. 2018-10-10T19:30:16.634Z,1539199816.634 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-10-10T19:30:16.634Z,1539199816.634 [RudderServo](INFO): Powering down 2018-10-10T19:30:16.635Z,1539199816.635 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-10T19:30:16.635Z,1539199816.635 [ThrusterServo](INFO): Powering down 2018-10-10T19:30:16.656Z,1539199816.656 [CBIT](INFO): Clearing failed state for component MassServo 2018-10-10T19:30:16.656Z,1539199816.656 [MassServo] No Fault, FailCount= 1 2018-10-10T19:30:16.913Z,1539199816.913 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:16.934Z,1539199816.934 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-10T19:30:16.934Z,1539199816.934 [BuoyancyServo] No Fault, FailCount= 1 2018-10-10T19:30:17.326Z,1539199817.326 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:17.340Z,1539199817.340 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:17.341Z,1539199817.341 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-10T19:30:17.384Z,1539199817.384 [RudderServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:17.394Z,1539199817.394 [RudderServo](DEBUG): Initializing RudderServo. 2018-10-10T19:30:17.437Z,1539199817.437 [CBIT](INFO): Clearing failed state for component RudderServo 2018-10-10T19:30:17.437Z,1539199817.437 [RudderServo] No Fault, FailCount= 2 2018-10-10T19:30:17.438Z,1539199817.438 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-10T19:30:17.438Z,1539199817.438 [ThrusterServo] No Fault, FailCount= 2 2018-10-10T19:30:17.725Z,1539199817.725 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:17.750Z,1539199817.750 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:17.750Z,1539199817.750 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-10T19:30:18.141Z,1539199818.141 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:18.253Z,1539199818.253 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-10T19:30:18.254Z,1539199818.254 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-10T19:30:18.254Z,1539199818.254 [BuoyancyServo] Communications Fault, FailCount= 2 2018-10-10T19:30:18.254Z,1539199818.254 [BuoyancyServo](ERROR): Communications Fault 2018-10-10T19:30:18.630Z,1539199818.630 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-10-10T19:30:18.701Z,1539199818.701 [ThrusterServo](FAULT): Thruster failed to initialize 2018-10-10T19:30:18.702Z,1539199818.702 [ThrusterServo] Communications Fault, FailCount= 3 2018-10-10T19:30:18.702Z,1539199818.702 [ThrusterServo](ERROR): Communications Fault 2018-10-10T19:30:18.706Z,1539199818.706 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-10T19:30:18.706Z,1539199818.706 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-10T19:30:18.759Z,1539199818.759 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:18.783Z,1539199818.783 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-10T19:30:18.783Z,1539199818.783 [BuoyancyServo](INFO): Powering down 2018-10-10T19:30:18.800Z,1539199818.800 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-10T19:30:18.800Z,1539199818.800 [ThrusterServo](INFO): Powering down 2018-10-10T19:30:19.185Z,1539199819.185 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:19.543Z,1539199819.543 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2018-10-10T19:30:19.543Z,1539199819.543 [PNI_TCM] Data Fault, FailCount= 1 2018-10-10T19:30:19.543Z,1539199819.543 [PNI_TCM](ERROR): Data Fault 2018-10-10T19:30:19.584Z,1539199819.584 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:19.633Z,1539199819.633 [CBIT](ERROR): Data Fault in component: PNI_TCM 2018-10-10T19:30:19.633Z,1539199819.633 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-10T19:30:19.649Z,1539199819.649 [ThrusterServo] No Fault, FailCount= 3 2018-10-10T19:30:19.936Z,1539199819.936 [PNI_TCM](INFO): Powering down 2018-10-10T19:30:20.053Z,1539199820.053 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:20.397Z,1539199820.397 [MassServo](ERROR): isCommunicating uart error serial timeout 2018-10-10T19:30:20.398Z,1539199820.398 [MassServo](FAULT): Invalid EZ Servo response:"" 2018-10-10T19:30:20.398Z,1539199820.398 [MassServo] Communications Fault, FailCount= 2 2018-10-10T19:30:20.398Z,1539199820.398 [MassServo](ERROR): Communications Fault 2018-10-10T19:30:20.398Z,1539199820.398 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: serial timeout 2018-10-10T19:30:20.398Z,1539199820.398 [MassServo] Hardware Fault, FailCount= 2 2018-10-10T19:30:20.399Z,1539199820.399 [MassServo](ERROR): Hardware Fault 2018-10-10T19:30:20.774Z,1539199820.774 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:20.774Z,1539199820.774 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-10T19:30:20.779Z,1539199820.779 [CBIT](CRITICAL): Environmental Failure. Press:14.722512 PSI. Humidity:40%. Temp:26 C. ABORTING MISSION 2018-10-10T19:30:20.780Z,1539199820.780 [CBIT](ERROR): Hardware Fault in component: MassServo 2018-10-10T19:30:20.835Z,1539199820.835 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:20.848Z,1539199820.848 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-10T19:30:20.849Z,1539199820.849 [MassServo](INFO): Powering down 2018-10-10T19:30:20.856Z,1539199820.856 [CBIT](INFO): Critical error at 20181010T193020 2018-10-10T19:30:21.242Z,1539199821.242 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:21.569Z,1539199821.569 [RudderServo](ERROR): getPosition uart error serial timeout 2018-10-10T19:30:21.570Z,1539199821.570 [RudderServo](FAULT): Rudder uart error - getPosition..serial timeout 2018-10-10T19:30:21.570Z,1539199821.570 [RudderServo] Communications Fault, FailCount= 3 2018-10-10T19:30:21.570Z,1539199821.570 [RudderServo](ERROR): Communications Fault 2018-10-10T19:30:21.738Z,1539199821.738 [CBIT](INFO): Clearing failed state for component PNI_TCM 2018-10-10T19:30:21.738Z,1539199821.738 [PNI_TCM] No Fault, FailCount= 1 2018-10-10T19:30:21.739Z,1539199821.739 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-10T19:30:21.739Z,1539199821.739 [BuoyancyServo] No Fault, FailCount= 2 2018-10-10T19:30:21.739Z,1539199821.739 [CBIT](ERROR): Communications Fault in component: RudderServo 2018-10-10T19:30:21.739Z,1539199821.739 [CBIT](CRITICAL): Communications Fault in component: RudderServo 2018-10-10T19:30:21.792Z,1539199821.792 [Aanderaa_O2](FAULT): Timed out starting 2018-10-10T19:30:21.792Z,1539199821.792 [Aanderaa_O2] Communications Fault, FailCount= 1 2018-10-10T19:30:21.792Z,1539199821.792 [Aanderaa_O2](ERROR): Communications Fault 2018-10-10T19:30:21.807Z,1539199821.807 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:21.830Z,1539199821.830 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:21.831Z,1539199821.831 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-10T19:30:21.833Z,1539199821.833 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:21.842Z,1539199821.842 [MassServo](DEBUG): Initializing MassServo. 2018-10-10T19:30:21.842Z,1539199821.842 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-10-10T19:30:21.843Z,1539199821.843 [RudderServo](INFO): Powering down 2018-10-10T19:30:21.854Z,1539199821.854 [CBIT](INFO): Critical error at 20181010T193021 2018-10-10T19:30:21.856Z,1539199821.856 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-10T19:30:21.857Z,1539199821.857 [CBIT](INFO): Clearing failed state for component MassServo 2018-10-10T19:30:21.857Z,1539199821.857 [MassServo] No Fault, FailCount= 2 2018-10-10T19:30:22.173Z,1539199822.173 [Aanderaa_O2](INFO): Powering down 2018-10-10T19:30:22.246Z,1539199822.246 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:22.629Z,1539199822.629 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:22.977Z,1539199822.977 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-10T19:30:22.978Z,1539199822.978 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-10T19:30:22.978Z,1539199822.978 [BuoyancyServo] Communications Fault, FailCount= 3 2018-10-10T19:30:22.978Z,1539199822.978 [BuoyancyServo](ERROR): Communications Fault 2018-10-10T19:30:22.980Z,1539199822.980 [RudderServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:22.980Z,1539199822.980 [RudderServo](DEBUG): Initializing RudderServo. 2018-10-10T19:30:22.987Z,1539199822.987 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-10T19:30:23.130Z,1539199823.130 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:23.145Z,1539199823.145 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-10T19:30:23.154Z,1539199823.154 [BuoyancyServo](INFO): Powering down 2018-10-10T19:30:23.469Z,1539199823.469 [ThrusterServo](FAULT): Thruster initialization uart error:serial timeout 2018-10-10T19:30:23.469Z,1539199823.469 [ThrusterServo] Communications Fault, FailCount= 4 2018-10-10T19:30:23.470Z,1539199823.470 [ThrusterServo](ERROR): Communications Fault 2018-10-10T19:30:23.474Z,1539199823.474 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-10T19:30:23.474Z,1539199823.474 [Aanderaa_O2] No Fault, FailCount= 1 2018-10-10T19:30:23.475Z,1539199823.475 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-10T19:30:23.543Z,1539199823.543 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:23.568Z,1539199823.568 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-10T19:30:23.568Z,1539199823.568 [ThrusterServo](INFO): Powering down 2018-10-10T19:30:23.977Z,1539199823.977 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:24.334Z,1539199824.334 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:24.408Z,1539199824.408 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-10T19:30:24.408Z,1539199824.408 [ThrusterServo] No Fault, FailCount= 4 2018-10-10T19:30:24.749Z,1539199824.749 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:24.765Z,1539199824.765 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:24.770Z,1539199824.770 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-10T19:30:25.134Z,1539199825.134 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:25.489Z,1539199825.489 [MassServo](ERROR): isCommunicating uart error serial timeout 2018-10-10T19:30:25.490Z,1539199825.490 [MassServo](FAULT): Invalid EZ Servo response:"" 2018-10-10T19:30:25.490Z,1539199825.490 [MassServo] Communications Fault, FailCount= 3 2018-10-10T19:30:25.490Z,1539199825.490 [MassServo](ERROR): Communications Fault 2018-10-10T19:30:25.490Z,1539199825.490 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: serial timeout 2018-10-10T19:30:25.490Z,1539199825.490 [MassServo] Hardware Fault, FailCount= 3 2018-10-10T19:30:25.490Z,1539199825.490 [MassServo](ERROR): Hardware Fault 2018-10-10T19:30:25.827Z,1539199825.827 [MassServo](FAULT): Invalid EZ Servo response:"" 2018-10-10T19:30:25.827Z,1539199825.827 [MassServo] Communications Fault, FailCount= 3 2018-10-10T19:30:25.828Z,1539199825.828 [MassServo](ERROR): Communications Fault 2018-10-10T19:30:25.942Z,1539199825.942 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-10T19:30:25.942Z,1539199825.942 [BuoyancyServo] No Fault, FailCount= 3 2018-10-10T19:30:25.942Z,1539199825.942 [CBIT](ERROR): Communications Fault in component: MassServo 2018-10-10T19:30:26.006Z,1539199826.006 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:26.017Z,1539199826.017 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:26.026Z,1539199826.026 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-10T19:30:26.027Z,1539199826.027 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-10T19:30:26.028Z,1539199826.028 [MassServo](INFO): Powering down 2018-10-10T19:30:26.387Z,1539199826.387 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:26.794Z,1539199826.794 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:26.905Z,1539199826.905 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-10T19:30:26.906Z,1539199826.906 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-10T19:30:26.906Z,1539199826.906 [BuoyancyServo] Communications Fault, FailCount= 4 2018-10-10T19:30:26.906Z,1539199826.906 [BuoyancyServo](ERROR): Communications Fault 2018-10-10T19:30:26.907Z,1539199826.907 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:26.908Z,1539199826.908 [MassServo](DEBUG): Initializing MassServo. 2018-10-10T19:30:26.913Z,1539199826.913 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-10T19:30:26.913Z,1539199826.913 [CBIT](INFO): Clearing failed state for component MassServo 2018-10-10T19:30:26.913Z,1539199826.913 [MassServo] No Fault, FailCount= 3 2018-10-10T19:30:27.222Z,1539199827.222 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:27.236Z,1539199827.236 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-10T19:30:27.237Z,1539199827.237 [BuoyancyServo](INFO): Powering down 2018-10-10T19:30:27.625Z,1539199827.625 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:27.999Z,1539199827.999 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:28.421Z,1539199828.421 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:28.757Z,1539199828.757 [ThrusterServo](ERROR): Thruster uart error: serial timeout 2018-10-10T19:30:28.758Z,1539199828.758 [ThrusterServo] Communications Fault, FailCount= 5 2018-10-10T19:30:28.758Z,1539199828.758 [ThrusterServo](ERROR): Communications Fault 2018-10-10T19:30:28.762Z,1539199828.762 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-10T19:30:28.763Z,1539199828.763 [CBIT](CRITICAL): Communications Fault in component: ThrusterServo 2018-10-10T19:30:28.823Z,1539199828.823 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:28.849Z,1539199828.849 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-10T19:30:28.849Z,1539199828.849 [ThrusterServo](INFO): Powering down 2018-10-10T19:30:28.860Z,1539199828.860 [CBIT](INFO): Critical error at 20181010T193028 2018-10-10T19:30:29.191Z,1539199829.191 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2018-10-10T19:30:29.191Z,1539199829.191 [PNI_TCM] Data Fault, FailCount= 2 2018-10-10T19:30:29.192Z,1539199829.192 [PNI_TCM](ERROR): Data Fault 2018-10-10T19:30:29.242Z,1539199829.242 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:29.318Z,1539199829.318 [CBIT](ERROR): Data Fault in component: PNI_TCM 2018-10-10T19:30:29.318Z,1539199829.318 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-10T19:30:29.318Z,1539199829.318 [BuoyancyServo] No Fault, FailCount= 4 2018-10-10T19:30:29.591Z,1539199829.591 [PNI_TCM](INFO): Powering down 2018-10-10T19:30:29.637Z,1539199829.637 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:29.656Z,1539199829.656 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:29.657Z,1539199829.657 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-10T19:30:30.037Z,1539199830.037 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:30.221Z,1539199830.221 [MassServo](ERROR): isCommunicating uart error serial timeout 2018-10-10T19:30:30.222Z,1539199830.222 [MassServo](FAULT): Invalid EZ Servo response:"\n" 2018-10-10T19:30:30.222Z,1539199830.222 [MassServo] Communications Fault, FailCount= 4 2018-10-10T19:30:30.222Z,1539199830.222 [MassServo](ERROR): Communications Fault 2018-10-10T19:30:30.222Z,1539199830.222 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: serial timeout 2018-10-10T19:30:30.222Z,1539199830.222 [MassServo] Hardware Fault, FailCount= 4 2018-10-10T19:30:30.222Z,1539199830.222 [MassServo](ERROR): Hardware Fault 2018-10-10T19:30:30.618Z,1539199830.618 [CBIT](ERROR): Hardware Fault in component: MassServo 2018-10-10T19:30:30.745Z,1539199830.745 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:31.101Z,1539199831.101 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-10T19:30:31.102Z,1539199831.102 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-10T19:30:31.102Z,1539199831.102 [BuoyancyServo] Communications Fault, FailCount= 5 2018-10-10T19:30:31.102Z,1539199831.102 [BuoyancyServo](ERROR): Communications Fault 2018-10-10T19:30:31.103Z,1539199831.103 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-10T19:30:31.103Z,1539199831.103 [MassServo](INFO): Powering down 2018-10-10T19:30:31.108Z,1539199831.108 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-10T19:30:31.190Z,1539199831.190 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:31.203Z,1539199831.203 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-10T19:30:31.204Z,1539199831.204 [BuoyancyServo](INFO): Powering down 2018-10-10T19:30:31.223Z,1539199831.223 [CBIT](INFO): Clearing failed state for component PNI_TCM 2018-10-10T19:30:31.223Z,1539199831.223 [PNI_TCM] No Fault, FailCount= 2 2018-10-10T19:30:31.579Z,1539199831.579 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:31.603Z,1539199831.603 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:31.603Z,1539199831.603 [MassServo](DEBUG): Initializing MassServo. 2018-10-10T19:30:31.616Z,1539199831.616 [CBIT](INFO): Clearing failed state for component MassServo 2018-10-10T19:30:31.616Z,1539199831.616 [MassServo] No Fault, FailCount= 4 2018-10-10T19:30:31.965Z,1539199831.965 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:32.429Z,1539199832.429 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:32.801Z,1539199832.801 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:33.169Z,1539199833.169 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:33.205Z,1539199833.205 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-10T19:30:33.205Z,1539199833.205 [BuoyancyServo] No Fault, FailCount= 5 2018-10-10T19:30:33.554Z,1539199833.554 [Aanderaa_O2](FAULT): Timed out starting 2018-10-10T19:30:33.554Z,1539199833.554 [Aanderaa_O2] Communications Fault, FailCount= 2 2018-10-10T19:30:33.554Z,1539199833.554 [Aanderaa_O2](ERROR): Communications Fault 2018-10-10T19:30:33.577Z,1539199833.577 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:33.599Z,1539199833.599 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:33.600Z,1539199833.600 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-10T19:30:33.614Z,1539199833.614 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-10T19:30:33.940Z,1539199833.940 [Aanderaa_O2](INFO): Powering down 2018-10-10T19:30:33.955Z,1539199833.955 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:34.349Z,1539199834.349 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:34.697Z,1539199834.697 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-10T19:30:34.698Z,1539199834.698 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-10T19:30:34.698Z,1539199834.698 [BuoyancyServo] Communications Fault, FailCount= 6 2018-10-10T19:30:34.698Z,1539199834.698 [BuoyancyServo](ERROR): Communications Fault 2018-10-10T19:30:34.703Z,1539199834.703 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-10T19:30:34.754Z,1539199834.754 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:34.769Z,1539199834.769 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-10T19:30:34.778Z,1539199834.778 [BuoyancyServo](INFO): Powering down 2018-10-10T19:30:35.093Z,1539199835.093 [MassServo](ERROR): isCommunicating uart error serial timeout 2018-10-10T19:30:35.094Z,1539199835.094 [MassServo](FAULT): Invalid EZ Servo response:"" 2018-10-10T19:30:35.094Z,1539199835.094 [MassServo] Communications Fault, FailCount= 5 2018-10-10T19:30:35.094Z,1539199835.094 [MassServo](ERROR): Communications Fault 2018-10-10T19:30:35.094Z,1539199835.094 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: serial timeout 2018-10-10T19:30:35.094Z,1539199835.094 [MassServo] Hardware Fault, FailCount= 5 2018-10-10T19:30:35.094Z,1539199835.094 [MassServo](ERROR): Hardware Fault 2018-10-10T19:30:35.430Z,1539199835.430 [MassServo](FAULT): Invalid EZ Servo response:"" 2018-10-10T19:30:35.430Z,1539199835.430 [MassServo] Communications Fault, FailCount= 5 2018-10-10T19:30:35.431Z,1539199835.431 [MassServo](ERROR): Communications Fault 2018-10-10T19:30:35.436Z,1539199835.436 [SBIT](IMPORTANT): Beginning Startup BIT 2018-10-10T19:30:35.448Z,1539199835.448 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-10T19:30:35.448Z,1539199835.448 [Aanderaa_O2] No Fault, FailCount= 2 2018-10-10T19:30:35.448Z,1539199835.448 [CBIT](ERROR): Communications Fault in component: MassServo 2018-10-10T19:30:35.449Z,1539199835.449 [CBIT](CRITICAL): Communications Fault in component: MassServo 2018-10-10T19:30:35.470Z,1539199835.470 [CBIT](IMPORTANT): Beginning ground fault scan 2018-10-10T19:30:35.567Z,1539199835.567 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:35.929Z,1539199835.929 [ElevatorServo](FAULT): Elevator uart error: serial timeout 2018-10-10T19:30:35.930Z,1539199835.930 [ElevatorServo] Communications Fault, FailCount= 2 2018-10-10T19:30:35.930Z,1539199835.930 [ElevatorServo](ERROR): Communications Fault 2018-10-10T19:30:35.930Z,1539199835.930 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-10T19:30:35.931Z,1539199835.931 [MassServo](INFO): Powering down 2018-10-10T19:30:35.934Z,1539199835.934 [CBIT](INFO): Critical error at 20181010T193035 2018-10-10T19:30:35.936Z,1539199835.936 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2018-10-10T19:30:36.061Z,1539199836.061 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:36.088Z,1539199836.088 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-10-10T19:30:36.088Z,1539199836.088 [ElevatorServo](INFO): Powering down 2018-10-10T19:30:36.407Z,1539199836.407 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:36.431Z,1539199836.431 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:36.431Z,1539199836.431 [MassServo](DEBUG): Initializing MassServo. 2018-10-10T19:30:36.759Z,1539199836.759 [NAL9602](INFO): Powering up NAL9602 2018-10-10T19:30:36.825Z,1539199836.825 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:36.848Z,1539199836.848 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:36.848Z,1539199836.848 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-10-10T19:30:36.854Z,1539199836.854 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-10T19:30:36.854Z,1539199836.854 [BuoyancyServo] No Fault, FailCount= 6 2018-10-10T19:30:36.854Z,1539199836.854 [CBIT](INFO): Clearing failed state for component ElevatorServo 2018-10-10T19:30:36.854Z,1539199836.854 [ElevatorServo] No Fault, FailCount= 2 2018-10-10T19:30:37.205Z,1539199837.205 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:37.212Z,1539199837.212 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:30:37.212Z,1539199837.212 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-10T19:30:37.605Z,1539199837.605 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:37.998Z,1539199837.998 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:38.337Z,1539199838.337 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-10T19:30:38.338Z,1539199838.338 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-10T19:30:38.338Z,1539199838.338 [BuoyancyServo] Communications Fault, FailCount= 7 2018-10-10T19:30:38.338Z,1539199838.338 [BuoyancyServo](ERROR): Communications Fault 2018-10-10T19:30:38.343Z,1539199838.343 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-10T19:30:38.559Z,1539199838.559 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:38.583Z,1539199838.583 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-10T19:30:38.583Z,1539199838.583 [BuoyancyServo](INFO): Powering down 2018-10-10T19:30:38.888Z,1539199838.888 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2018-10-10T19:30:38.888Z,1539199838.888 [PNI_TCM] Data Fault, FailCount= 3 2018-10-10T19:30:38.888Z,1539199838.888 [PNI_TCM](ERROR): Data Fault 2018-10-10T19:30:38.937Z,1539199838.937 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:38.971Z,1539199838.971 [CBIT](ERROR): Data Fault in component: PNI_TCM 2018-10-10T19:30:39.287Z,1539199839.287 [PNI_TCM](INFO): Powering down 2018-10-10T19:30:39.313Z,1539199839.313 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:39.729Z,1539199839.729 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:40.137Z,1539199840.137 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:40.497Z,1539199840.497 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:40.542Z,1539199840.542 [CBIT](INFO): Clearing failed state for component PNI_TCM 2018-10-10T19:30:40.542Z,1539199840.542 [PNI_TCM] No Fault, FailCount= 3 2018-10-10T19:30:40.542Z,1539199840.542 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-10T19:30:40.542Z,1539199840.542 [BuoyancyServo] No Fault, FailCount= 7 2018-10-10T19:30:40.933Z,1539199840.933 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:30:40.947Z,1539199840.947 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:31:11.066Z,1539199871.066 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-10T19:31:11.069Z,1539199871.069 [SBIT](ERROR): Could not read rudderAngleReader_. 2018-10-10T19:31:11.069Z,1539199871.069 [SBIT](ERROR): Could not read massPosReader_. 2018-10-10T19:31:11.073Z,1539199871.073 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-10T19:31:11.073Z,1539199871.073 [ThrusterServo] No Fault, FailCount= 5 2018-10-10T19:31:11.197Z,1539199871.197 [Aanderaa_O2](FAULT): Timed out starting 2018-10-10T19:31:11.197Z,1539199871.197 [Aanderaa_O2] Communications Fault, FailCount= 3 2018-10-10T19:31:11.197Z,1539199871.197 [Aanderaa_O2](ERROR): Communications Fault 2018-10-10T19:31:11.203Z,1539199871.203 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:31:11.243Z,1539199871.243 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:31:11.250Z,1539199871.250 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-10T19:31:11.259Z,1539199871.259 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-10T19:31:11.259Z,1539199871.259 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 2018-10-10T19:31:11.718Z,1539199871.718 [Aanderaa_O2](INFO): Powering down 2018-10-10T19:31:11.730Z,1539199871.730 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:31:12.077Z,1539199872.077 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-10T19:31:12.078Z,1539199872.078 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-10T19:31:12.078Z,1539199872.078 [BuoyancyServo] Communications Fault, FailCount= 8 2018-10-10T19:31:12.078Z,1539199872.078 [BuoyancyServo](ERROR): Communications Fault 2018-10-10T19:31:12.469Z,1539199872.469 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2018-10-10T19:31:12.469Z,1539199872.469 [ThrusterServo](FAULT): Thruster failed to initialize 2018-10-10T19:31:12.470Z,1539199872.470 [ThrusterServo] Communications Fault, FailCount= 1 2018-10-10T19:31:12.470Z,1539199872.470 [ThrusterServo](ERROR): Communications Fault 2018-10-10T19:31:12.475Z,1539199872.475 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-10T19:31:12.476Z,1539199872.476 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-10T19:31:12.581Z,1539199872.581 [NAL9602](INFO): NAL9602 initialized 2018-10-10T19:31:12.637Z,1539199872.637 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:31:12.644Z,1539199872.644 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-10T19:31:12.645Z,1539199872.645 [BuoyancyServo](INFO): Powering down 2018-10-10T19:31:12.666Z,1539199872.666 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-10T19:31:12.666Z,1539199872.666 [ThrusterServo](INFO): Powering down 2018-10-10T19:31:13.050Z,1539199873.050 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:31:13.418Z,1539199873.418 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:31:13.733Z,1539199873.733 [ElevatorServo](ERROR): getPosition uart error serial timeout 2018-10-10T19:31:13.734Z,1539199873.734 [ElevatorServo](FAULT): Elevator uart error - getPosition.serial timeout 2018-10-10T19:31:13.734Z,1539199873.734 [ElevatorServo] Communications Fault, FailCount= 1 2018-10-10T19:31:13.734Z,1539199873.734 [ElevatorServo](ERROR): Communications Fault 2018-10-10T19:31:13.854Z,1539199873.854 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2018-10-10T19:31:13.855Z,1539199873.855 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-10T19:31:13.855Z,1539199873.855 [ThrusterServo] No Fault, FailCount= 1 2018-10-10T19:31:14.015Z,1539199874.015 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:31:14.023Z,1539199874.023 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-10-10T19:31:14.023Z,1539199874.023 [ElevatorServo](INFO): Powering down 2018-10-10T19:31:14.024Z,1539199874.024 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:31:14.025Z,1539199874.025 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-10T19:31:14.390Z,1539199874.390 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:31:14.783Z,1539199874.783 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-10T19:31:14.790Z,1539199874.790 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-10-10T19:31:14.909Z,1539199874.909 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-10-10T19:31:15.233Z,1539199875.233 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-10-10T19:31:15.250Z,1539199875.250 [ThrusterServo](FAULT): Thruster failed to initialize 2018-10-10T19:31:15.251Z,1539199875.251 [ThrusterServo] Communications Fault, FailCount= 2 2018-10-10T19:31:15.251Z,1539199875.251 [ThrusterServo](ERROR): Communications Fault 2018-10-10T19:31:15.294Z,1539199875.294 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-10T19:31:15.294Z,1539199875.294 [BuoyancyServo] No Fault, FailCount= 8 2018-10-10T19:31:15.294Z,1539199875.294 [CBIT](INFO): Clearing failed state for component ElevatorServo 2018-10-10T19:31:15.295Z,1539199875.295 [Eleva