2018-10-11T16:34:59.578Z,1539275699.578 [Supervisor](DEBUG): Initializing supervisor. 2018-10-11T16:34:59.581Z,1539275699.581 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2018-10-11T16:34:59.582Z,1539275699.582 [SyncHandler](INFO): Protected caller Thread ID is 8540 2018-10-11T16:34:59.582Z,1539275699.582 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2018-10-11T16:34:59.583Z,1539275699.583 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2018-10-11T16:34:59.583Z,1539275699.583 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 8541 2018-10-11T16:34:59.586Z,1539275699.586 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2018-10-11T16:34:59.598Z,1539275699.598 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2018-10-11T16:34:59.599Z,1539275699.599 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2018-10-11T16:34:59.600Z,1539275699.600 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 8542 2018-10-11T16:34:59.601Z,1539275699.601 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2018-10-11T16:34:59.602Z,1539275699.602 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2018-10-11T16:34:59.602Z,1539275699.602 [logger ThreadHandler](INFO): Protected caller Thread ID is 8543 2018-10-11T16:34:59.604Z,1539275699.604 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2018-10-11T16:34:59.604Z,1539275699.604 [Supervisor](INFO): Looking for Config files in directory: Config/ 2018-10-11T16:34:59.606Z,1539275699.606 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2018-10-11T16:34:59.702Z,1539275699.702 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2018-10-11T16:34:59.703Z,1539275699.703 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2018-10-11T16:34:59.802Z,1539275699.802 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2018-10-11T16:34:59.802Z,1539275699.802 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2018-10-11T16:34:59.000Z,1539275700.000 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2018-10-11T16:35:00.000Z,1539275700.000 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2018-10-11T16:35:00.334Z,1539275700.334 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2018-10-11T16:35:00.335Z,1539275700.335 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2018-10-11T16:35:00.678Z,1539275700.678 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2018-10-11T16:35:00.678Z,1539275700.678 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2018-10-11T16:35:01.137Z,1539275701.137 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2018-10-11T16:35:01.137Z,1539275701.137 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2018-10-11T16:35:01.670Z,1539275701.670 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2018-10-11T16:35:01.670Z,1539275701.670 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2018-10-11T16:35:02.125Z,1539275702.125 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2018-10-11T16:35:02.125Z,1539275702.125 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2018-10-11T16:35:02.206Z,1539275702.206 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2018-10-11T16:35:02.527Z,1539275702.527 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2018-10-11T16:35:02.528Z,1539275702.528 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2018-10-11T16:35:02.675Z,1539275702.675 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2018-10-11T16:35:02.676Z,1539275702.676 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2018-10-11T16:35:02.889Z,1539275702.889 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2018-10-11T16:35:02.889Z,1539275702.889 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2018-10-11T16:35:03.094Z,1539275703.094 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2018-10-11T16:35:03.095Z,1539275703.095 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2018-10-11T16:35:03.191Z,1539275703.191 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2018-10-11T16:35:03.191Z,1539275703.191 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2018-10-11T16:35:03.335Z,1539275703.335 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2018-10-11T16:35:03.337Z,1539275703.337 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2018-10-11T16:35:03.338Z,1539275703.338 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2018-10-11T16:35:03.564Z,1539275703.564 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2018-10-11T16:35:03.565Z,1539275703.565 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2018-10-11T16:35:03.669Z,1539275703.669 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2018-10-11T16:35:03.818Z,1539275703.818 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2018-10-11T16:35:03.910Z,1539275703.910 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2018-10-11T16:35:03.994Z,1539275703.994 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2018-10-11T16:35:04.149Z,1539275704.149 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2018-10-11T16:35:04.345Z,1539275704.345 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2018-10-11T16:35:04.442Z,1539275704.442 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2018-10-11T16:35:04.537Z,1539275704.537 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2018-10-11T16:35:04.650Z,1539275704.650 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2018-10-11T16:35:04.797Z,1539275704.797 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2018-10-11T16:35:04.797Z,1539275704.797 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2018-10-11T16:35:04.799Z,1539275704.799 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2018-10-11T16:35:05.254Z,1539275705.254 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2018-10-11T16:35:05.255Z,1539275705.255 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2018-10-11T16:35:05.452Z,1539275705.452 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2018-10-11T16:35:05.453Z,1539275705.453 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2018-10-11T16:35:05.509Z,1539275705.509 [DepthRateCalculator] Loaded 2018-10-11T16:35:05.509Z,1539275705.509 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2018-10-11T16:35:05.515Z,1539275705.515 [PitchRateCalculator] Loaded 2018-10-11T16:35:05.516Z,1539275705.516 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2018-10-11T16:35:05.531Z,1539275705.531 [SpeedCalculator] Loaded 2018-10-11T16:35:05.532Z,1539275705.532 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2018-10-11T16:35:05.552Z,1539275705.552 [TempGradientCalculator] Loaded 2018-10-11T16:35:05.553Z,1539275705.553 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2018-10-11T16:35:05.559Z,1539275705.559 [YawRateCalculator] Loaded 2018-10-11T16:35:05.559Z,1539275705.559 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2018-10-11T16:35:05.598Z,1539275705.598 [ElevatorOffsetCalculator] Loaded 2018-10-11T16:35:05.599Z,1539275705.599 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2018-10-11T16:35:05.599Z,1539275705.599 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2018-10-11T16:35:05.600Z,1539275705.600 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2018-10-11T16:35:05.637Z,1539275705.637 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2018-10-11T16:35:05.638Z,1539275705.638 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2018-10-11T16:35:06.131Z,1539275706.131 [AcousticModem_Benthos_ATM900] Loaded 2018-10-11T16:35:06.131Z,1539275706.131 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread. 2018-10-11T16:35:06.431Z,1539275706.431 [DataOverHttps] Loaded 2018-10-11T16:35:06.432Z,1539275706.432 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2018-10-11T16:35:06.445Z,1539275706.445 [Depth_Keller] Loaded 2018-10-11T16:35:06.446Z,1539275706.446 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2018-10-11T16:35:06.450Z,1539275706.450 [DropWeight] Loaded 2018-10-11T16:35:06.450Z,1539275706.450 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2018-10-11T16:35:06.548Z,1539275706.548 [NAL9602] Loaded 2018-10-11T16:35:06.548Z,1539275706.548 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2018-10-11T16:35:06.564Z,1539275706.564 [Onboard] Loaded 2018-10-11T16:35:06.564Z,1539275706.564 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2018-10-11T16:35:06.574Z,1539275706.574 [Radio_Surface] Loaded 2018-10-11T16:35:06.574Z,1539275706.574 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2018-10-11T16:35:06.575Z,1539275706.575 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407C24E0 2018-10-11T16:35:06.576Z,1539275706.576 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 8623 2018-10-11T16:35:06.756Z,1539275706.756 [PNI_TCM] Loaded 2018-10-11T16:35:06.756Z,1539275706.756 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2018-10-11T16:35:06.817Z,1539275706.817 [Rowe_600LCM] Loaded 2018-10-11T16:35:06.817Z,1539275706.817 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread. 2018-10-11T16:35:06.818Z,1539275706.818 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 407F24E0 2018-10-11T16:35:06.819Z,1539275706.819 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 8624 2018-10-11T16:35:08.563Z,1539275708.563 [BPC1] Loaded 2018-10-11T16:35:08.563Z,1539275708.563 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2018-10-11T16:35:08.564Z,1539275708.564 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2018-10-11T16:35:08.565Z,1539275708.565 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2018-10-11T16:35:08.722Z,1539275708.722 [SBIT](DEBUG): Construct Startup Built In Test. 2018-10-11T16:35:08.745Z,1539275708.745 [SBIT] Loaded 2018-10-11T16:35:08.745Z,1539275708.745 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2018-10-11T16:35:08.746Z,1539275708.746 [IBIT](DEBUG): Construct Initiated Built In Test. 2018-10-11T16:35:08.757Z,1539275708.757 [IBIT] Loaded 2018-10-11T16:35:08.757Z,1539275708.757 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2018-10-11T16:35:08.760Z,1539275708.760 [CBIT](DEBUG): Construct Continuous Built In Test. 2018-10-11T16:35:08.909Z,1539275708.909 [CBIT] Loaded 2018-10-11T16:35:08.909Z,1539275708.909 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2018-10-11T16:35:08.910Z,1539275708.910 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2018-10-11T16:35:08.910Z,1539275708.910 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2018-10-11T16:35:09.119Z,1539275709.119 [Aanderaa_O2] Loaded 2018-10-11T16:35:09.119Z,1539275709.119 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2018-10-11T16:35:09.176Z,1539275709.176 [CTD_Seabird] Loaded 2018-10-11T16:35:09.176Z,1539275709.176 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2018-10-11T16:35:09.177Z,1539275709.177 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 408BD4E0 2018-10-11T16:35:09.177Z,1539275709.177 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 8625 2018-10-11T16:35:09.195Z,1539275709.195 [ESPComponent] Loaded 2018-10-11T16:35:09.195Z,1539275709.195 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2018-10-11T16:35:09.209Z,1539275709.209 [PAR_Licor] Loaded 2018-10-11T16:35:09.209Z,1539275709.209 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2018-10-11T16:35:09.258Z,1539275709.258 [WetLabsBB2FL] Loaded 2018-10-11T16:35:09.258Z,1539275709.258 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2018-10-11T16:35:09.259Z,1539275709.259 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 408ED4E0 2018-10-11T16:35:09.259Z,1539275709.259 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 8626 2018-10-11T16:35:09.260Z,1539275709.260 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2018-10-11T16:35:09.261Z,1539275709.261 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2018-10-11T16:35:09.544Z,1539275709.544 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2018-10-11T16:35:09.545Z,1539275709.545 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2018-10-11T16:35:09.632Z,1539275709.632 [VerticalControl](DEBUG): Construct VerticalControl. 2018-10-11T16:35:09.727Z,1539275709.727 [VerticalControl] Loaded 2018-10-11T16:35:09.728Z,1539275709.728 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2018-10-11T16:35:09.728Z,1539275709.728 [HorizontalControl](DEBUG): Construct HorizontalControl. 2018-10-11T16:35:09.788Z,1539275709.788 [HorizontalControl] Loaded 2018-10-11T16:35:09.789Z,1539275709.789 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2018-10-11T16:35:09.789Z,1539275709.789 [SpeedControl](DEBUG): Construct SpeedControl. 2018-10-11T16:35:09.794Z,1539275709.794 [SpeedControl] Loaded 2018-10-11T16:35:09.795Z,1539275709.795 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2018-10-11T16:35:09.795Z,1539275709.795 [LoopControl](DEBUG): Construct LoopControl. 2018-10-11T16:35:09.796Z,1539275709.796 [LoopControl] Loaded 2018-10-11T16:35:09.796Z,1539275709.796 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2018-10-11T16:35:09.797Z,1539275709.797 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2018-10-11T16:35:09.797Z,1539275709.797 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2018-10-11T16:35:09.994Z,1539275709.994 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2018-10-11T16:35:09.994Z,1539275709.994 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2018-10-11T16:35:10.114Z,1539275710.114 [BuoyancyServo] Loaded 2018-10-11T16:35:10.114Z,1539275710.114 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2018-10-11T16:35:10.125Z,1539275710.125 [ElevatorServo] Loaded 2018-10-11T16:35:10.126Z,1539275710.126 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2018-10-11T16:35:10.136Z,1539275710.136 [MassServo] Loaded 2018-10-11T16:35:10.137Z,1539275710.137 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2018-10-11T16:35:10.148Z,1539275710.148 [RudderServo] Loaded 2018-10-11T16:35:10.148Z,1539275710.148 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2018-10-11T16:35:10.159Z,1539275710.159 [ThrusterServo] Loaded 2018-10-11T16:35:10.160Z,1539275710.160 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2018-10-11T16:35:10.160Z,1539275710.160 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2018-10-11T16:35:10.161Z,1539275710.161 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2018-10-11T16:35:10.267Z,1539275710.267 [DeadReckonUsingSpeedCalculator] Loaded 2018-10-11T16:35:10.267Z,1539275710.267 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2018-10-11T16:35:10.284Z,1539275710.284 [NavChart] Loaded 2018-10-11T16:35:10.284Z,1539275710.284 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2018-10-11T16:35:10.288Z,1539275710.288 [UniversalFixResidualReporter] Loaded 2018-10-11T16:35:10.288Z,1539275710.288 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2018-10-11T16:35:10.289Z,1539275710.289 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2018-10-11T16:35:10.292Z,1539275710.292 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2018-10-11T16:35:10.293Z,1539275710.293 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2018-10-11T16:35:10.300Z,1539275710.300 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2018-10-11T16:35:10.301Z,1539275710.301 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A464E0 2018-10-11T16:35:10.301Z,1539275710.301 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 8627 2018-10-11T16:35:10.307Z,1539275710.307 [Supervisor](INFO): Main Thread ID is 8539 2018-10-11T16:35:10.307Z,1539275710.307 [Supervisor](DEBUG): Running supervisor. 2018-10-11T16:35:10.307Z,1539275710.307 [CommandLine ThreadHandler](INFO): Handler Thread ID is 8628 2018-10-11T16:35:10.310Z,1539275710.310 [controlThread ThreadHandler](INFO): Handler Thread ID is 8629 2018-10-11T16:35:10.310Z,1539275710.310 [controlThread](DEBUG): Initializing ControlThread 2018-10-11T16:35:10.311Z,1539275710.311 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-10-11T16:35:10.311Z,1539275710.311 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2018-10-11T16:35:10.312Z,1539275710.312 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2018-10-11T16:35:10.312Z,1539275710.312 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2018-10-11T16:35:10.313Z,1539275710.313 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2018-10-11T16:35:10.313Z,1539275710.313 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2018-10-11T16:35:10.319Z,1539275710.319 [SBIT](INFO): Initialize SBIT Component. 2018-10-11T16:35:10.320Z,1539275710.320 [SBIT](IMPORTANT): git: 2018-10-09-10-g9dace7a 2018-10-11T16:35:10.320Z,1539275710.320 [SBIT](INFO): git hash: 9dace7a2d6113b15f92a64275ecb2f59d2fdba4e 2018-10-11T16:35:10.320Z,1539275710.320 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2018-10-11T16:35:10.321Z,1539275710.321 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018 2018-10-11T16:35:10.341Z,1539275710.341 [logger ThreadHandler](INFO): Handler Thread ID is 8630 2018-10-11T16:35:10.341Z,1539275710.341 [SBIT](INFO): Beginning SBIT in 24.000000 seconds. 2018-10-11T16:35:10.342Z,1539275710.342 [IBIT](INFO): Initialize IBIT Component. 2018-10-11T16:35:10.357Z,1539275710.357 [CBIT](DEBUG): Initialize CBIT Component. 2018-10-11T16:35:10.357Z,1539275710.357 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2018-10-11T16:35:10.357Z,1539275710.357 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2018-10-11T16:35:10.358Z,1539275710.358 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 8631 2018-10-11T16:35:10.364Z,1539275710.364 [Radio_Surface](INFO): Powering up 2018-10-11T16:35:10.373Z,1539275710.373 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 8632 2018-10-11T16:35:10.374Z,1539275710.374 [Rowe_600LCM](INFO): Initializing 2018-10-11T16:35:10.374Z,1539275710.374 [Rowe_600LCM](INFO): Checking LCM 2018-10-11T16:35:10.469Z,1539275710.469 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2018-10-11T16:35:10.471Z,1539275710.471 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2018-10-11T16:35:10.472Z,1539275710.472 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2018-10-11T16:35:10.472Z,1539275710.472 [LoopControl](DEBUG): Initialize LoopControlComponent. 2018-10-11T16:35:10.474Z,1539275710.474 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-10-11T16:35:10.475Z,1539275710.475 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-10-11T16:35:10.481Z,1539275710.481 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-10-11T16:35:10.481Z,1539275710.481 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 8633 2018-10-11T16:35:10.482Z,1539275710.482 [CTD_Seabird](INFO): Initializing 2018-10-11T16:35:10.483Z,1539275710.483 [CTD_Seabird](INFO): Checking LCM 2018-10-11T16:35:10.483Z,1539275710.483 [NavChart](DEBUG): Initialize NavChart Navigation. 2018-10-11T16:35:10.484Z,1539275710.484 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2018-10-11T16:35:10.484Z,1539275710.484 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2018-10-11T16:35:10.489Z,1539275710.489 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 8634 2018-10-11T16:35:10.491Z,1539275710.491 [WetLabsBB2FL](INFO): Powering down 2018-10-11T16:35:10.615Z,1539275710.615 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2018-10-11T16:35:10.617Z,1539275710.617 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 8635 2018-10-11T16:35:10.625Z,1539275710.625 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2018-10-11T16:35:10.625Z,1539275710.625 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2018-10-11T16:35:10.625Z,1539275710.625 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2018-10-11T16:35:10.625Z,1539275710.625 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2018-10-11T16:35:10.626Z,1539275710.626 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2018-10-11T16:35:10.626Z,1539275710.626 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2018-10-11T16:35:10.626Z,1539275710.626 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2018-10-11T16:35:10.626Z,1539275710.626 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2018-10-11T16:35:10.626Z,1539275710.626 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2018-10-11T16:35:10.626Z,1539275710.626 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2018-10-11T16:35:10.627Z,1539275710.627 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2018-10-11T16:35:10.627Z,1539275710.627 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2018-10-11T16:35:10.627Z,1539275710.627 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2018-10-11T16:35:10.627Z,1539275710.627 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2018-10-11T16:35:10.627Z,1539275710.627 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2018-10-11T16:35:10.628Z,1539275710.628 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2018-10-11T16:35:10.711Z,1539275710.711 [MissionManager](DEBUG): 2018-10-11T16:35:10.718Z,1539275710.718 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2018-10-11T16:35:10.840Z,1539275710.840 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2018-10-11T16:35:10.846Z,1539275710.846 [Default:A.Wait](DEBUG): Construct Wait. 2018-10-11T16:35:10.848Z,1539275710.848 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2018-10-11T16:35:10.861Z,1539275710.861 [CTD_Seabird](INFO): LCM OK 2018-10-11T16:35:10.861Z,1539275710.861 [CTD_Seabird](INFO): Powering up 2018-10-11T16:35:10.861Z,1539275710.861 [Rowe_600LCM](INFO): LCM OK 2018-10-11T16:35:10.861Z,1539275710.861 [Rowe_600LCM](INFO): Powering up 2018-10-11T16:35:10.901Z,1539275710.901 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2018-10-11T16:35:10.903Z,1539275710.903 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2018-10-11T16:35:10.925Z,1539275710.925 [Default:E.Execute](DEBUG): Construct Execute. 2018-10-11T16:35:10.949Z,1539275710.949 [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-11T16:35:10.954Z,1539275710.954 [controlThread](DEBUG): Component order: CycleStarter,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,Aanderaa_O2,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2018-10-11T16:35:10.981Z,1539275710.981 [AcousticModem_Benthos_ATM900](INFO): Powering up 2018-10-11T16:35:10.982Z,1539275710.982 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900. 2018-10-11T16:35:11.003Z,1539275711.003 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2018-10-11T16:35:11.074Z,1539275711.074 [Depth_Keller](ERROR): Pressure reading out of range: 1895.684326 decibar 2018-10-11T16:35:11.225Z,1539275711.225 [ESPComponent](INFO): powering down ESP 2018-10-11T16:35:11.536Z,1539275711.536 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-10-11T16:35:11.627Z,1539275711.627 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:11.842Z,1539275711.842 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:11.849Z,1539275711.849 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-11T16:35:11.864Z,1539275711.864 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:11.869Z,1539275711.869 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-10-11T16:35:11.875Z,1539275711.875 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:11.881Z,1539275711.881 [MassServo](DEBUG): Initializing MassServo. 2018-10-11T16:35:11.887Z,1539275711.887 [RudderServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:11.893Z,1539275711.893 [RudderServo](DEBUG): Initializing RudderServo. 2018-10-11T16:35:11.899Z,1539275711.899 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:11.905Z,1539275711.905 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-11T16:35:12.175Z,1539275712.175 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2018-10-11T16:35:12.175Z,1539275712.175 [DropWeight] Hardware Fault, FailCount= 1 2018-10-11T16:35:12.175Z,1539275712.175 [DropWeight](ERROR): Hardware Fault 2018-10-11T16:35:12.221Z,1539275712.221 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:12.246Z,1539275712.246 [CommandLine](FAULT): Scheduling is paused 2018-10-11T16:35:12.246Z,1539275712.246 [CBIT](INFO): Critical error at 20181011T163512 2018-10-11T16:35:12.247Z,1539275712.247 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2018-10-11T16:35:12.249Z,1539275712.249 [CBIT](ERROR): Hardware Fault in component: DropWeight 2018-10-11T16:35:12.250Z,1539275712.250 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2018-10-11T16:35:12.451Z,1539275712.451 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:12.817Z,1539275712.817 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-11T16:35:12.817Z,1539275712.817 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-11T16:35:12.817Z,1539275712.817 [BuoyancyServo] Communications Fault, FailCount= 1 2018-10-11T16:35:12.817Z,1539275712.817 [BuoyancyServo](ERROR): Communications Fault 2018-10-11T16:35:13.169Z,1539275713.169 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2018-10-11T16:35:13.169Z,1539275713.169 [RudderServo](FAULT): Rudder failed to initialize 2018-10-11T16:35:13.169Z,1539275713.169 [RudderServo] Communications Fault, FailCount= 1 2018-10-11T16:35:13.169Z,1539275713.169 [RudderServo](ERROR): Communications Fault 2018-10-11T16:35:13.275Z,1539275713.275 [CBIT](INFO): Critical error at 20181011T163512 2018-10-11T16:35:13.277Z,1539275713.277 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-11T16:35:13.278Z,1539275713.278 [CBIT](ERROR): Communications Fault in component: RudderServo 2018-10-11T16:35:13.380Z,1539275713.380 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:13.402Z,1539275713.402 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-11T16:35:13.403Z,1539275713.403 [BuoyancyServo](INFO): Powering down 2018-10-11T16:35:13.470Z,1539275713.470 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-10-11T16:35:13.470Z,1539275713.470 [RudderServo](INFO): Powering down 2018-10-11T16:35:13.735Z,1539275713.735 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:14.120Z,1539275714.120 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:14.144Z,1539275714.144 [RudderServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:14.262Z,1539275714.262 [RudderServo](DEBUG): Initializing RudderServo. 2018-10-11T16:35:14.266Z,1539275714.266 [CBIT](INFO): Clearing failed state for component RudderServo 2018-10-11T16:35:14.267Z,1539275714.267 [RudderServo] No Fault, FailCount= 1 2018-10-11T16:35:14.550Z,1539275714.550 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:14.921Z,1539275714.921 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:14.929Z,1539275714.929 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface 2018-10-11T16:35:15.160Z,1539275715.160 [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-11T16:35:15.370Z,1539275715.370 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track 2018-10-11T16:35:15.371Z,1539275715.371 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity 2018-10-11T16:35:15.371Z,1539275715.371 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe 2018-10-11T16:35:16.097Z,1539275716.097 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-11T16:35:16.236Z,1539275716.236 [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-11T16:35:16.237Z,1539275716.237 [CTD_Seabird](INFO): LCM subscribed to channel:seabird_gpctd_t.seabird-gpctd 2018-10-11T16:35:16.603Z,1539275716.603 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-10-11T16:35:16.603Z,1539275716.603 [CTD_Seabird](INFO): Powering down 2018-10-11T16:35:24.320Z,1539275724.320 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2018-10-11T16:35:24.320Z,1539275724.320 [PNI_TCM] Data Fault, FailCount= 1 2018-10-11T16:35:24.321Z,1539275724.321 [PNI_TCM](ERROR): Data Fault 2018-10-11T16:35:24.322Z,1539275724.322 [Aanderaa_O2](FAULT): Timed out starting 2018-10-11T16:35:24.322Z,1539275724.322 [Aanderaa_O2] Communications Fault, FailCount= 1 2018-10-11T16:35:24.322Z,1539275724.322 [Aanderaa_O2](ERROR): Communications Fault 2018-10-11T16:35:24.361Z,1539275724.361 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:24.709Z,1539275724.709 [MassServo](ERROR): isCommunicating uart error serial timeout 2018-10-11T16:35:24.709Z,1539275724.709 [MassServo](FAULT): Invalid EZ Servo response:"" 2018-10-11T16:35:24.709Z,1539275724.709 [MassServo] Communications Fault, FailCount= 1 2018-10-11T16:35:24.710Z,1539275724.710 [MassServo](ERROR): Communications Fault 2018-10-11T16:35:24.710Z,1539275724.710 [MassServo](FAULT): Mass Shifter error waiting for homing. Uart error: serial timeout 2018-10-11T16:35:24.710Z,1539275724.710 [MassServo] Hardware Fault, FailCount= 1 2018-10-11T16:35:24.710Z,1539275724.710 [MassServo](ERROR): Hardware Fault 2018-10-11T16:35:25.117Z,1539275725.117 [MassServo](ERROR): getPosition uart error serial timeout 2018-10-11T16:35:25.117Z,1539275725.117 [MassServo](FAULT): Invalid EZ Servo response:"\n" 2018-10-11T16:35:25.117Z,1539275725.117 [MassServo] Communications Fault, FailCount= 1 2018-10-11T16:35:25.117Z,1539275725.117 [MassServo](ERROR): Communications Fault 2018-10-11T16:35:25.123Z,1539275725.123 [CBIT](CRITICAL): Environmental Failure. Press:14.632651 PSI. Humidity:37%. Temp:26 C. ABORTING MISSION 2018-10-11T16:35:25.124Z,1539275725.124 [CBIT](ERROR): Data Fault in component: PNI_TCM 2018-10-11T16:35:25.124Z,1539275725.124 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-11T16:35:25.124Z,1539275725.124 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-11T16:35:25.124Z,1539275725.124 [BuoyancyServo] No Fault, FailCount= 1 2018-10-11T16:35:25.125Z,1539275725.125 [CBIT](ERROR): Communications Fault in component: MassServo 2018-10-11T16:35:25.131Z,1539275725.131 [AcousticModem_Benthos_ATM900](DEBUG): equency Band 2018-10-11T16:35:25.132Z,1539275725.132 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.6.3 2018-10-11T16:35:25.133Z,1539275725.133 [AcousticModem_Benthos_ATM900](DEBUG): Oct 5 2018 22:37:52 2018-10-11T16:35:25.133Z,1539275725.133 [AcousticModem_Benthos_ATM900](DEBUG): WARNING: battery low 2018-10-11T16:35:25.170Z,1539275725.170 [PNI_TCM](INFO): Powering down 2018-10-11T16:35:25.230Z,1539275725.230 [Aanderaa_O2](INFO): Powering down 2018-10-11T16:35:25.306Z,1539275725.306 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:25.319Z,1539275725.319 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:25.319Z,1539275725.319 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-11T16:35:25.321Z,1539275725.321 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-11T16:35:25.321Z,1539275725.321 [MassServo](INFO): Powering down 2018-10-11T16:35:25.709Z,1539275725.709 [RudderServo](FAULT): Rudder initialization uart error:serial timeout 2018-10-11T16:35:25.709Z,1539275725.709 [RudderServo] Communications Fault, FailCount= 2 2018-10-11T16:35:25.709Z,1539275725.709 [RudderServo](ERROR): Communications Fault 2018-10-11T16:35:26.021Z,1539275726.021 [ThrusterServo](ERROR): Thruster uart error: serial timeout 2018-10-11T16:35:26.021Z,1539275726.021 [ThrusterServo] Communications Fault, FailCount= 1 2018-10-11T16:35:26.021Z,1539275726.021 [ThrusterServo](ERROR): Communications Fault 2018-10-11T16:35:26.023Z,1539275726.023 [CBIT](INFO): Critical error at 20181011T163525 2018-10-11T16:35:26.026Z,1539275726.026 [CBIT](ERROR): Communications Fault in component: RudderServo 2018-10-11T16:35:26.026Z,1539275726.026 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-11T16:35:26.081Z,1539275726.081 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:26.425Z,1539275726.425 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-11T16:35:26.425Z,1539275726.425 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-11T16:35:26.425Z,1539275726.425 [BuoyancyServo] Communications Fault, FailCount= 2 2018-10-11T16:35:26.425Z,1539275726.425 [BuoyancyServo](ERROR): Communications Fault 2018-10-11T16:35:26.427Z,1539275726.427 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-10-11T16:35:26.427Z,1539275726.427 [RudderServo](INFO): Powering down 2018-10-11T16:35:26.428Z,1539275726.428 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-11T16:35:26.428Z,1539275726.428 [ThrusterServo](INFO): Powering down 2018-10-11T16:35:26.468Z,1539275726.468 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-11T16:35:26.502Z,1539275726.502 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.011906 2018-10-11T16:35:26.574Z,1539275726.574 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:26.580Z,1539275726.580 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-11T16:35:26.581Z,1539275726.581 [BuoyancyServo](INFO): Powering down 2018-10-11T16:35:26.594Z,1539275726.594 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:26.594Z,1539275726.594 [MassServo](DEBUG): Initializing MassServo. 2018-10-11T16:35:26.607Z,1539275726.607 [CBIT](INFO): Clearing failed state for component PNI_TCM 2018-10-11T16:35:26.608Z,1539275726.608 [PNI_TCM] No Fault, FailCount= 1 2018-10-11T16:35:26.608Z,1539275726.608 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-10-11T16:35:26.608Z,1539275726.608 [Aanderaa_O2] No Fault, FailCount= 1 2018-10-11T16:35:26.608Z,1539275726.608 [CBIT](INFO): Clearing failed state for component MassServo 2018-10-11T16:35:26.608Z,1539275726.608 [MassServo] No Fault, FailCount= 1 2018-10-11T16:35:26.940Z,1539275726.940 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:26.947Z,1539275726.947 [RudderServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:26.948Z,1539275726.948 [RudderServo](DEBUG): Initializing RudderServo. 2018-10-11T16:35:26.969Z,1539275726.969 [CBIT](INFO): Clearing failed state for component RudderServo 2018-10-11T16:35:26.969Z,1539275726.969 [RudderServo] No Fault, FailCount= 2 2018-10-11T16:35:26.969Z,1539275726.969 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-11T16:35:26.969Z,1539275726.969 [ThrusterServo] No Fault, FailCount= 1 2018-10-11T16:35:27.328Z,1539275727.328 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:27.385Z,1539275727.385 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:27.386Z,1539275727.386 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-11T16:35:27.731Z,1539275727.731 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:28.053Z,1539275728.053 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2018-10-11T16:35:28.053Z,1539275728.053 [RudderServo](FAULT): Rudder failed to initialize 2018-10-11T16:35:28.053Z,1539275728.053 [RudderServo] Communications Fault, FailCount= 3 2018-10-11T16:35:28.053Z,1539275728.053 [RudderServo](ERROR): Communications Fault 2018-10-11T16:35:28.621Z,1539275728.621 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2018-10-11T16:35:28.621Z,1539275728.621 [ThrusterServo](FAULT): Thruster failed to initialize 2018-10-11T16:35:28.621Z,1539275728.621 [ThrusterServo] Communications Fault, FailCount= 2 2018-10-11T16:35:28.621Z,1539275728.621 [ThrusterServo](ERROR): Communications Fault 2018-10-11T16:35:28.625Z,1539275728.625 [CBIT](ERROR): Communications Fault in component: RudderServo 2018-10-11T16:35:28.626Z,1539275728.626 [CBIT](CRITICAL): Communications Fault in component: RudderServo 2018-10-11T16:35:28.626Z,1539275728.626 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-11T16:35:28.702Z,1539275728.702 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:28.726Z,1539275728.726 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-10-11T16:35:28.726Z,1539275728.726 [RudderServo](INFO): Powering down 2018-10-11T16:35:28.727Z,1539275728.727 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-11T16:35:28.728Z,1539275728.728 [ThrusterServo](INFO): Powering down 2018-10-11T16:35:28.738Z,1539275728.738 [CBIT](INFO): Critical error at 20181011T163528 2018-10-11T16:35:29.104Z,1539275729.104 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:29.385Z,1539275729.385 [MassServo](FAULT): Mass initialization uart error:serial timeout 2018-10-11T16:35:29.385Z,1539275729.385 [MassServo] Communications Fault, FailCount= 2 2018-10-11T16:35:29.385Z,1539275729.385 [MassServo](ERROR): Communications Fault 2018-10-11T16:35:29.390Z,1539275729.390 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-11T16:35:29.390Z,1539275729.390 [BuoyancyServo] No Fault, FailCount= 2 2018-10-11T16:35:29.390Z,1539275729.390 [CBIT](ERROR): Communications Fault in component: MassServo 2018-10-11T16:35:29.499Z,1539275729.499 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:29.513Z,1539275729.513 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:29.513Z,1539275729.513 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-11T16:35:29.515Z,1539275729.515 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-11T16:35:29.515Z,1539275729.515 [MassServo](INFO): Powering down 2018-10-11T16:35:29.516Z,1539275729.516 [RudderServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:29.525Z,1539275729.525 [RudderServo](DEBUG): Initializing RudderServo. 2018-10-11T16:35:29.541Z,1539275729.541 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-11T16:35:29.541Z,1539275729.541 [ThrusterServo] No Fault, FailCount= 2 2018-10-11T16:35:29.884Z,1539275729.884 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:29.905Z,1539275729.905 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:29.905Z,1539275729.905 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-11T16:35:30.284Z,1539275730.284 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:30.387Z,1539275730.387 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-11T16:35:30.387Z,1539275730.387 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-11T16:35:30.387Z,1539275730.387 [BuoyancyServo] Communications Fault, FailCount= 3 2018-10-11T16:35:30.387Z,1539275730.387 [BuoyancyServo](ERROR): Communications Fault 2018-10-11T16:35:30.389Z,1539275730.389 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:30.389Z,1539275730.389 [MassServo](DEBUG): Initializing MassServo. 2018-10-11T16:35:30.394Z,1539275730.394 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-11T16:35:30.394Z,1539275730.394 [CBIT](INFO): Clearing failed state for component MassServo 2018-10-11T16:35:30.394Z,1539275730.394 [MassServo] No Fault, FailCount= 2 2018-10-11T16:35:30.665Z,1539275730.665 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:30.679Z,1539275730.679 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-11T16:35:30.679Z,1539275730.679 [BuoyancyServo](INFO): Powering down 2018-10-11T16:35:31.021Z,1539275731.021 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-10-11T16:35:31.046Z,1539275731.046 [ThrusterServo](FAULT): Thruster failed to initialize 2018-10-11T16:35:31.046Z,1539275731.046 [ThrusterServo] Communications Fault, FailCount= 3 2018-10-11T16:35:31.047Z,1539275731.047 [ThrusterServo](ERROR): Communications Fault 2018-10-11T16:35:31.062Z,1539275731.062 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-11T16:35:31.099Z,1539275731.099 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize; deviceResponse_ loaded: WARNING: battery low , available: MGP Y@Ø 2018-10-11T16:35:31.099Z,1539275731.099 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 1 2018-10-11T16:35:31.099Z,1539275731.099 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault 2018-10-11T16:35:31.158Z,1539275731.158 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:31.192Z,1539275731.192 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-11T16:35:31.193Z,1539275731.193 [ThrusterServo](INFO): Powering down 2018-10-11T16:35:31.219Z,1539275731.219 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900 2018-10-11T16:35:31.477Z,1539275731.477 [AcousticModem_Benthos_ATM900](INFO): Powering down 2018-10-11T16:35:31.532Z,1539275731.532 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:31.929Z,1539275731.929 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:31.965Z,1539275731.965 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-11T16:35:31.965Z,1539275731.965 [ThrusterServo] No Fault, FailCount= 3 2018-10-11T16:35:32.380Z,1539275732.380 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:32.556Z,1539275732.556 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:32.556Z,1539275732.556 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-11T16:35:32.560Z,1539275732.560 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900 2018-10-11T16:35:32.560Z,1539275732.560 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 1 2018-10-11T16:35:32.728Z,1539275732.728 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:33.037Z,1539275733.037 [MassServo](FAULT): Mass initialization uart error:serial timeout 2018-10-11T16:35:33.037Z,1539275733.037 [MassServo] Communications Fault, FailCount= 3 2018-10-11T16:35:33.037Z,1539275733.037 [MassServo](ERROR): Communications Fault 2018-10-11T16:35:33.042Z,1539275733.042 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-11T16:35:33.042Z,1539275733.042 [BuoyancyServo] No Fault, FailCount= 3 2018-10-11T16:35:33.042Z,1539275733.042 [CBIT](ERROR): Communications Fault in component: MassServo 2018-10-11T16:35:33.110Z,1539275733.110 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:33.124Z,1539275733.124 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:33.124Z,1539275733.124 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-11T16:35:33.134Z,1539275733.134 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-11T16:35:33.134Z,1539275733.134 [MassServo](INFO): Powering down 2018-10-11T16:35:33.453Z,1539275733.453 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-10-11T16:35:33.773Z,1539275733.773 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2018-10-11T16:35:33.773Z,1539275733.773 [ThrusterServo](FAULT): Thruster failed to initialize 2018-10-11T16:35:33.773Z,1539275733.773 [ThrusterServo] Communications Fault, FailCount= 4 2018-10-11T16:35:33.773Z,1539275733.773 [ThrusterServo](ERROR): Communications Fault 2018-10-11T16:35:33.777Z,1539275733.777 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-11T16:35:33.851Z,1539275733.851 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:34.185Z,1539275734.185 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-11T16:35:34.185Z,1539275734.185 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-11T16:35:34.185Z,1539275734.185 [BuoyancyServo] Communications Fault, FailCount= 4 2018-10-11T16:35:34.185Z,1539275734.185 [BuoyancyServo](ERROR): Communications Fault 2018-10-11T16:35:34.187Z,1539275734.187 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-11T16:35:34.187Z,1539275734.187 [ThrusterServo](INFO): Powering down 2018-10-11T16:35:34.191Z,1539275734.191 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-11T16:35:34.286Z,1539275734.286 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:34.300Z,1539275734.300 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-11T16:35:34.300Z,1539275734.300 [BuoyancyServo](INFO): Powering down 2018-10-11T16:35:34.326Z,1539275734.326 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:34.326Z,1539275734.326 [MassServo](DEBUG): Initializing MassServo. 2018-10-11T16:35:34.331Z,1539275734.331 [CBIT](INFO): Clearing failed state for component MassServo 2018-10-11T16:35:34.331Z,1539275734.331 [MassServo] No Fault, FailCount= 3 2018-10-11T16:35:34.605Z,1539275734.605 [AcousticModem_Benthos_ATM900](INFO): Powering up 2018-10-11T16:35:34.605Z,1539275734.605 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900. 2018-10-11T16:35:34.643Z,1539275734.643 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2018-10-11T16:35:34.644Z,1539275734.644 [PNI_TCM] Data Fault, FailCount= 2 2018-10-11T16:35:34.644Z,1539275734.644 [PNI_TCM](ERROR): Data Fault 2018-10-11T16:35:34.681Z,1539275734.681 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:34.716Z,1539275734.716 [CBIT](ERROR): Data Fault in component: PNI_TCM 2018-10-11T16:35:34.716Z,1539275734.716 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-10-11T16:35:34.716Z,1539275734.716 [ThrusterServo] No Fault, FailCount= 4 2018-10-11T16:35:35.023Z,1539275735.023 [PNI_TCM](INFO): Powering down 2018-10-11T16:35:35.053Z,1539275735.053 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:35.082Z,1539275735.082 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:35.083Z,1539275735.083 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-10-11T16:35:35.105Z,1539275735.105 [SBIT](IMPORTANT): Beginning Startup BIT 2018-10-11T16:35:35.129Z,1539275735.129 [CBIT](IMPORTANT): Beginning ground fault scan 2018-10-11T16:35:35.460Z,1539275735.460 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:35.817Z,1539275735.817 [ElevatorServo](ERROR): getPosition uart error serial timeout 2018-10-11T16:35:35.817Z,1539275735.817 [ElevatorServo](FAULT): Elevator uart error - getPosition.serial timeout 2018-10-11T16:35:35.817Z,1539275735.817 [ElevatorServo] Communications Fault, FailCount= 1 2018-10-11T16:35:35.817Z,1539275735.817 [ElevatorServo](ERROR): Communications Fault 2018-10-11T16:35:36.141Z,1539275736.141 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-10-11T16:35:36.166Z,1539275736.166 [ThrusterServo](FAULT): Thruster failed to initialize 2018-10-11T16:35:36.166Z,1539275736.166 [ThrusterServo] Communications Fault, FailCount= 5 2018-10-11T16:35:36.167Z,1539275736.167 [ThrusterServo](ERROR): Communications Fault 2018-10-11T16:35:36.184Z,1539275736.184 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2018-10-11T16:35:36.186Z,1539275736.186 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-10-11T16:35:36.188Z,1539275736.188 [CBIT](CRITICAL): Communications Fault in component: ThrusterServo 2018-10-11T16:35:36.346Z,1539275736.346 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:36.356Z,1539275736.356 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-10-11T16:35:36.356Z,1539275736.356 [ElevatorServo](INFO): Powering down 2018-10-11T16:35:36.442Z,1539275736.442 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-10-11T16:35:36.442Z,1539275736.442 [ThrusterServo](INFO): Powering down 2018-10-11T16:35:36.449Z,1539275736.449 [CBIT](INFO): Critical error at 20181011T163536 2018-10-11T16:35:36.638Z,1539275736.638 [NAL9602](INFO): Powering up NAL9602 2018-10-11T16:35:36.675Z,1539275736.675 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:37.085Z,1539275737.085 [MassServo](FAULT): Mass initialization uart error:serial timeout 2018-10-11T16:35:37.085Z,1539275737.085 [MassServo] Communications Fault, FailCount= 4 2018-10-11T16:35:37.085Z,1539275737.085 [MassServo](ERROR): Communications Fault 2018-10-11T16:35:37.090Z,1539275737.090 [CBIT](INFO): Clearing failed state for component PNI_TCM 2018-10-11T16:35:37.090Z,1539275737.090 [PNI_TCM] No Fault, FailCount= 2 2018-10-11T16:35:37.090Z,1539275737.090 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-10-11T16:35:37.091Z,1539275737.091 [BuoyancyServo] No Fault, FailCount= 4 2018-10-11T16:35:37.091Z,1539275737.091 [CBIT](ERROR): Communications Fault in component: MassServo 2018-10-11T16:35:37.133Z,1539275737.133 [Aanderaa_O2](FAULT): Timed out starting 2018-10-11T16:35:37.133Z,1539275737.133 [Aanderaa_O2] Communications Fault, FailCount= 2 2018-10-11T16:35:37.133Z,1539275737.133 [Aanderaa_O2](ERROR): Communications Fault 2018-10-11T16:35:37.166Z,1539275737.166 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:37.175Z,1539275737.175 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:37.176Z,1539275737.176 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-10-11T16:35:37.177Z,1539275737.177 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:37.178Z,1539275737.178 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-10-11T16:35:37.179Z,1539275737.179 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-10-11T16:35:37.179Z,1539275737.179 [MassServo](INFO): Powering down 2018-10-11T16:35:37.205Z,1539275737.205 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-10-11T16:35:37.205Z,1539275737.205 [CBIT](INFO): Clearing failed state for component ElevatorServo 2018-10-11T16:35:37.205Z,1539275737.205 [ElevatorServo] No Fault, FailCount= 1 2018-10-11T16:35:37.527Z,1539275737.527 [Aanderaa_O2](INFO): Powering down 2018-10-11T16:35:37.556Z,1539275737.556 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:37.985Z,1539275737.985 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:38.321Z,1539275738.321 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-10-11T16:35:38.321Z,1539275738.321 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-10-11T16:35:38.321Z,1539275738.321 [BuoyancyServo] Communications Fault, FailCount= 5 2018-10-11T16:35:38.321Z,1539275738.321 [BuoyancyServo](ERROR): Communications Fault 2018-10-11T16:35:38.633Z,1539275738.633 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2018-10-11T16:35:38.633Z,1539275738.633 [ElevatorServo](FAULT): Elevator failed to initialize 2018-10-11T16:35:38.633Z,1539275738.633 [ElevatorServo] Communications Fault, FailCount= 2 2018-10-11T16:35:38.633Z,1539275738.633 [ElevatorServo](ERROR): Communications Fault 2018-10-11T16:35:38.634Z,1539275738.634 [MassServo](DEBUG): Initializing EZServoServo. 2018-10-11T16:35:38.634Z,1539275738.634 [MassServo](DEBUG): Initializing MassServo. 2018-10-11T16:35:38.639Z,1539275738.639 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-10-11T16:35:38.639Z,1539275738.639 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2018-10-11T16:35:38.640Z,1539275738.640 [CBIT](INFO): Clearing failed state for component MassServo 2018-10-11T16:35:38.640Z,1539275738.640 [MassServo] No Fault, FailCount= 4 2018-10-11T16:35:38.788Z,1539275738.788 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2018-10-11T16:35:38.805Z,1539275738.805 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-10-11T16:35:38.806Z,1539275738.806 [BuoyancyServo](INFO): Powering down 2018-10-11T16:35:38.821Z,1539275738.821 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-10-11T16:35:38.821Z,1539275738