2017-11-03T09:35:21.800Z,1509701721.800 [Supervisor](DEBUG): Initializing supervisor. 2017-11-03T09:35:21.802Z,1509701721.802 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2017-11-03T09:35:21.803Z,1509701721.803 [SyncHandler](INFO): Protected caller Thread ID is 798 2017-11-03T09:35:21.803Z,1509701721.803 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2017-11-03T09:35:21.804Z,1509701721.804 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2017-11-03T09:35:21.804Z,1509701721.804 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 799 2017-11-03T09:35:21.807Z,1509701721.807 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2017-11-03T09:35:21.818Z,1509701721.818 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2017-11-03T09:35:21.819Z,1509701721.819 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2017-11-03T09:35:21.819Z,1509701721.819 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 800 2017-11-03T09:35:21.820Z,1509701721.820 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2017-11-03T09:35:21.821Z,1509701721.821 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2017-11-03T09:35:21.821Z,1509701721.821 [logger ThreadHandler](INFO): Protected caller Thread ID is 801 2017-11-03T09:35:21.823Z,1509701721.823 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2017-11-03T09:35:21.823Z,1509701721.823 [Supervisor](INFO): Looking for Config files in directory: Config/ 2017-11-03T09:35:21.827Z,1509701721.827 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2017-11-03T09:35:21.922Z,1509701721.922 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2017-11-03T09:35:21.924Z,1509701721.924 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2017-11-03T09:35:22.025Z,1509701722.025 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2017-11-03T09:35:22.027Z,1509701722.027 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2017-11-03T09:35:22.205Z,1509701722.205 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2017-11-03T09:35:22.206Z,1509701722.206 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2017-11-03T09:35:22.459Z,1509701722.459 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2017-11-03T09:35:22.461Z,1509701722.461 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2017-11-03T09:35:22.764Z,1509701722.764 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2017-11-03T09:35:22.765Z,1509701722.765 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2017-11-03T09:35:23.184Z,1509701723.184 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2017-11-03T09:35:23.185Z,1509701723.185 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2017-11-03T09:35:23.500Z,1509701723.500 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2017-11-03T09:35:23.500Z,1509701723.500 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2017-11-03T09:35:23.896Z,1509701723.896 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2017-11-03T09:35:23.898Z,1509701723.898 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2017-11-03T09:35:23.979Z,1509701723.979 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2017-11-03T09:35:24.253Z,1509701724.253 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2017-11-03T09:35:24.254Z,1509701724.254 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2017-11-03T09:35:24.380Z,1509701724.380 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2017-11-03T09:35:24.381Z,1509701724.381 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2017-11-03T09:35:24.576Z,1509701724.576 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2017-11-03T09:35:24.578Z,1509701724.578 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2017-11-03T09:35:24.766Z,1509701724.766 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2017-11-03T09:35:24.767Z,1509701724.767 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2017-11-03T09:35:24.862Z,1509701724.862 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2017-11-03T09:35:24.863Z,1509701724.863 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2017-11-03T09:35:24.998Z,1509701724.998 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2017-11-03T09:35:24.000Z,1509701725.000 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2017-11-03T09:35:25.002Z,1509701725.002 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2017-11-03T09:35:25.262Z,1509701725.262 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2017-11-03T09:35:25.263Z,1509701725.263 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2017-11-03T09:35:26.045Z,1509701726.045 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2017-11-03T09:35:26.179Z,1509701726.179 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2017-11-03T09:35:26.271Z,1509701726.271 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2017-11-03T09:35:26.355Z,1509701726.355 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2017-11-03T09:35:26.487Z,1509701726.487 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2017-11-03T09:35:26.643Z,1509701726.643 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2017-11-03T09:35:26.739Z,1509701726.739 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2017-11-03T09:35:26.830Z,1509701726.830 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2017-11-03T09:35:26.926Z,1509701726.926 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2017-11-03T09:35:27.008Z,1509701727.008 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg 2017-11-03T09:35:27.010Z,1509701727.010 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2017-11-03T09:35:27.134Z,1509701727.134 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2017-11-03T09:35:27.134Z,1509701727.134 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2017-11-03T09:35:27.157Z,1509701727.157 [Module Loader](CRITICAL): Could not find element LcmListener.loadAtStartup 2017-11-03T09:35:27.157Z,1509701727.157 [Module Loader](CRITICAL): Could not find element LcmPublisher.loadAtStartup 2017-11-03T09:35:27.158Z,1509701727.158 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2017-11-03T09:35:27.158Z,1509701727.158 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2017-11-03T09:35:27.194Z,1509701727.194 [DepthRateCalculator] Loaded 2017-11-03T09:35:27.194Z,1509701727.194 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2017-11-03T09:35:27.200Z,1509701727.200 [PitchRateCalculator] Loaded 2017-11-03T09:35:27.200Z,1509701727.200 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2017-11-03T09:35:27.215Z,1509701727.215 [SpeedCalculator] Loaded 2017-11-03T09:35:27.216Z,1509701727.216 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2017-11-03T09:35:27.236Z,1509701727.236 [TempGradientCalculator] Loaded 2017-11-03T09:35:27.236Z,1509701727.236 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2017-11-03T09:35:27.251Z,1509701727.251 [VerticalTemperatureHomogeneityIndexCalculator] Loaded 2017-11-03T09:35:27.251Z,1509701727.251 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread. 2017-11-03T09:35:27.257Z,1509701727.257 [YawRateCalculator] Loaded 2017-11-03T09:35:27.257Z,1509701727.257 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2017-11-03T09:35:27.257Z,1509701727.257 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2017-11-03T09:35:27.258Z,1509701727.258 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2017-11-03T09:35:27.294Z,1509701727.294 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2017-11-03T09:35:27.295Z,1509701727.295 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2017-11-03T09:35:27.738Z,1509701727.738 [AcousticModem_Benthos_ATM900] Loaded 2017-11-03T09:35:27.738Z,1509701727.738 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread. 2017-11-03T09:35:27.875Z,1509701727.875 [DataOverHttps] Loaded 2017-11-03T09:35:27.875Z,1509701727.875 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2017-11-03T09:35:27.888Z,1509701727.888 [Depth_Keller] Loaded 2017-11-03T09:35:27.889Z,1509701727.889 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2017-11-03T09:35:27.894Z,1509701727.894 [DropWeight] Loaded 2017-11-03T09:35:27.894Z,1509701727.894 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2017-11-03T09:35:27.990Z,1509701727.990 [NAL9602] Loaded 2017-11-03T09:35:27.990Z,1509701727.990 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2017-11-03T09:35:28.005Z,1509701728.005 [Onboard] Loaded 2017-11-03T09:35:28.006Z,1509701728.006 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2017-11-03T09:35:28.016Z,1509701728.016 [Radio_Surface] Loaded 2017-11-03T09:35:28.016Z,1509701728.016 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2017-11-03T09:35:28.017Z,1509701728.017 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407A44E0 2017-11-03T09:35:28.017Z,1509701728.017 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 880 2017-11-03T09:35:28.168Z,1509701728.168 [PNI_TCM] Loaded 2017-11-03T09:35:28.168Z,1509701728.168 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2017-11-03T09:35:28.227Z,1509701728.227 [Rowe_600LCM] Loaded 2017-11-03T09:35:28.227Z,1509701728.227 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread. 2017-11-03T09:35:28.228Z,1509701728.228 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 407D44E0 2017-11-03T09:35:28.228Z,1509701728.228 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 881 2017-11-03T09:35:29.912Z,1509701729.912 [BPC1] Loaded 2017-11-03T09:35:29.913Z,1509701729.913 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2017-11-03T09:35:29.913Z,1509701729.913 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2017-11-03T09:35:29.915Z,1509701729.915 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2017-11-03T09:35:30.065Z,1509701730.065 [SBIT](DEBUG): Construct Startup Built In Test. 2017-11-03T09:35:30.091Z,1509701730.091 [SBIT] Loaded 2017-11-03T09:35:30.091Z,1509701730.091 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2017-11-03T09:35:30.092Z,1509701730.092 [IBIT](DEBUG): Construct Initiated Built In Test. 2017-11-03T09:35:30.103Z,1509701730.103 [IBIT] Loaded 2017-11-03T09:35:30.103Z,1509701730.103 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2017-11-03T09:35:30.106Z,1509701730.106 [CBIT](DEBUG): Construct Continuous Built In Test. 2017-11-03T09:35:30.250Z,1509701730.250 [CBIT] Loaded 2017-11-03T09:35:30.251Z,1509701730.251 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2017-11-03T09:35:30.251Z,1509701730.251 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2017-11-03T09:35:30.252Z,1509701730.252 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2017-11-03T09:35:30.640Z,1509701730.640 [Aanderaa_O2] Loaded 2017-11-03T09:35:30.640Z,1509701730.640 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2017-11-03T09:35:30.715Z,1509701730.715 [CTD_NeilBrown] Loaded 2017-11-03T09:35:30.715Z,1509701730.715 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread. 2017-11-03T09:35:30.716Z,1509701730.716 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 408944E0 2017-11-03T09:35:30.717Z,1509701730.717 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 882 2017-11-03T09:35:30.733Z,1509701730.733 [ESPComponent] Loaded 2017-11-03T09:35:30.733Z,1509701730.733 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2017-11-03T09:35:30.747Z,1509701730.747 [PAR_Licor] Loaded 2017-11-03T09:35:30.747Z,1509701730.747 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2017-11-03T09:35:30.794Z,1509701730.794 [WetLabsBB2FL] Loaded 2017-11-03T09:35:30.794Z,1509701730.794 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2017-11-03T09:35:30.795Z,1509701730.795 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 408C44E0 2017-11-03T09:35:30.796Z,1509701730.796 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 883 2017-11-03T09:35:30.796Z,1509701730.796 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2017-11-03T09:35:30.797Z,1509701730.797 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2017-11-03T09:35:31.067Z,1509701731.067 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2017-11-03T09:35:31.067Z,1509701731.067 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2017-11-03T09:35:31.154Z,1509701731.154 [VerticalControl](DEBUG): Construct VerticalControl. 2017-11-03T09:35:31.249Z,1509701731.249 [VerticalControl] Loaded 2017-11-03T09:35:31.249Z,1509701731.249 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2017-11-03T09:35:31.250Z,1509701731.250 [HorizontalControl](DEBUG): Construct HorizontalControl. 2017-11-03T09:35:31.309Z,1509701731.309 [HorizontalControl] Loaded 2017-11-03T09:35:31.309Z,1509701731.309 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2017-11-03T09:35:31.310Z,1509701731.310 [SpeedControl](DEBUG): Construct SpeedControl. 2017-11-03T09:35:31.315Z,1509701731.315 [SpeedControl] Loaded 2017-11-03T09:35:31.315Z,1509701731.315 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2017-11-03T09:35:31.316Z,1509701731.316 [LoopControl](DEBUG): Construct LoopControl. 2017-11-03T09:35:31.317Z,1509701731.317 [LoopControl] Loaded 2017-11-03T09:35:31.317Z,1509701731.317 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2017-11-03T09:35:31.317Z,1509701731.317 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2017-11-03T09:35:31.318Z,1509701731.318 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2017-11-03T09:35:31.434Z,1509701731.434 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC 2017-11-03T09:35:31.435Z,1509701731.435 [StratificationFrontDetector](DEBUG): (re)initializing 2017-11-03T09:35:31.435Z,1509701731.435 [StratificationFrontDetector] Loaded 2017-11-03T09:35:31.435Z,1509701731.435 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread. 2017-11-03T09:35:31.436Z,1509701731.436 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2017-11-03T09:35:31.436Z,1509701731.436 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2017-11-03T09:35:31.552Z,1509701731.552 [BuoyancyServo] Loaded 2017-11-03T09:35:31.552Z,1509701731.552 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2017-11-03T09:35:31.563Z,1509701731.563 [ElevatorServo] Loaded 2017-11-03T09:35:31.563Z,1509701731.563 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2017-11-03T09:35:31.574Z,1509701731.574 [MassServo] Loaded 2017-11-03T09:35:31.574Z,1509701731.574 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2017-11-03T09:35:31.585Z,1509701731.585 [RudderServo] Loaded 2017-11-03T09:35:31.585Z,1509701731.585 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2017-11-03T09:35:31.596Z,1509701731.596 [ThrusterServo] Loaded 2017-11-03T09:35:31.596Z,1509701731.596 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2017-11-03T09:35:31.596Z,1509701731.596 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2017-11-03T09:35:31.598Z,1509701731.598 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2017-11-03T09:35:31.707Z,1509701731.707 [DeadReckonUsingMultipleVelocitySources] Loaded 2017-11-03T09:35:31.707Z,1509701731.707 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2017-11-03T09:35:31.761Z,1509701731.761 [DeadReckonUsingSpeedCalculator] Loaded 2017-11-03T09:35:31.761Z,1509701731.761 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2017-11-03T09:35:31.777Z,1509701731.777 [NavChart] Loaded 2017-11-03T09:35:31.777Z,1509701731.777 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2017-11-03T09:35:31.781Z,1509701731.781 [UniversalFixResidualReporter] Loaded 2017-11-03T09:35:31.781Z,1509701731.781 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2017-11-03T09:35:31.782Z,1509701731.782 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2017-11-03T09:35:31.785Z,1509701731.785 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2017-11-03T09:35:31.786Z,1509701731.786 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2017-11-03T09:35:31.792Z,1509701731.792 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2017-11-03T09:35:31.793Z,1509701731.793 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A154E0 2017-11-03T09:35:31.794Z,1509701731.794 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 884 2017-11-03T09:35:31.798Z,1509701731.798 [Supervisor](INFO): Main Thread ID is 794 2017-11-03T09:35:31.798Z,1509701731.798 [Supervisor](DEBUG): Running supervisor. 2017-11-03T09:35:31.799Z,1509701731.799 [CommandLine ThreadHandler](INFO): Handler Thread ID is 885 2017-11-03T09:35:31.802Z,1509701731.802 [controlThread ThreadHandler](INFO): Handler Thread ID is 886 2017-11-03T09:35:31.802Z,1509701731.802 [controlThread](DEBUG): Initializing ControlThread 2017-11-03T09:35:31.803Z,1509701731.803 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2017-11-03T09:35:31.803Z,1509701731.803 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2017-11-03T09:35:31.803Z,1509701731.803 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2017-11-03T09:35:31.804Z,1509701731.804 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2017-11-03T09:35:31.804Z,1509701731.804 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing 2017-11-03T09:35:31.805Z,1509701731.805 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2017-11-03T09:35:31.811Z,1509701731.811 [SBIT](INFO): Initialize SBIT Component. 2017-11-03T09:35:31.812Z,1509701731.812 [SBIT](IMPORTANT): git: 2017-10-16-91-g1cda494 2017-11-03T09:35:31.812Z,1509701731.812 [SBIT](INFO): git hash: 1cda4942dadce3e3c6eb9510eb040eaf1a2b49d6 2017-11-03T09:35:31.812Z,1509701731.812 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2017-11-03T09:35:31.813Z,1509701731.813 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 Kernel Reported: #17 PREEMPT Fri Oct 6 17:22:04 PDT 2017 2017-11-03T09:35:31.814Z,1509701731.814 [SBIT](INFO): Beginning SBIT in 63.000000 seconds. 2017-11-03T09:35:31.815Z,1509701731.815 [IBIT](INFO): Initialize IBIT Component. 2017-11-03T09:35:31.816Z,1509701731.816 [CBIT](DEBUG): Initialize CBIT Component. 2017-11-03T09:35:31.816Z,1509701731.816 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL. 2017-11-03T09:35:31.816Z,1509701731.816 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET. 2017-11-03T09:35:31.817Z,1509701731.817 [logger ThreadHandler](INFO): Handler Thread ID is 887 2017-11-03T09:35:31.837Z,1509701731.837 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 888 2017-11-03T09:35:31.843Z,1509701731.843 [Radio_Surface](INFO): Powering up 2017-11-03T09:35:31.849Z,1509701731.849 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 889 2017-11-03T09:35:31.850Z,1509701731.850 [Rowe_600LCM](INFO): Initializing 2017-11-03T09:35:31.850Z,1509701731.850 [Rowe_600LCM](INFO): Checking LCM 2017-11-03T09:35:31.905Z,1509701731.905 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2017-11-03T09:35:31.907Z,1509701731.907 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2017-11-03T09:35:31.961Z,1509701731.961 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2017-11-03T09:35:31.962Z,1509701731.962 [LoopControl](DEBUG): Initialize LoopControlComponent. 2017-11-03T09:35:31.963Z,1509701731.963 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2017-11-03T09:35:31.964Z,1509701731.964 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2017-11-03T09:35:31.964Z,1509701731.964 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2017-11-03T09:35:31.973Z,1509701731.973 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 890 2017-11-03T09:35:31.974Z,1509701731.974 [CTD_NeilBrown](INFO): Powering down 2017-11-03T09:35:31.993Z,1509701731.993 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2017-11-03T09:35:31.993Z,1509701731.993 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2017-11-03T09:35:31.994Z,1509701731.994 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2017-11-03T09:35:31.994Z,1509701731.994 [NavChart](DEBUG): Initialize NavChart Navigation. 2017-11-03T09:35:31.995Z,1509701731.995 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2017-11-03T09:35:31.995Z,1509701731.995 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2017-11-03T09:35:32.007Z,1509701732.007 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 891 2017-11-03T09:35:32.008Z,1509701732.008 [WetLabsBB2FL](INFO): Powering down 2017-11-03T09:35:32.117Z,1509701732.117 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 892 2017-11-03T09:35:32.119Z,1509701732.119 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2017-11-03T09:35:32.127Z,1509701732.127 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2017-11-03T09:35:32.128Z,1509701732.128 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2017-11-03T09:35:32.128Z,1509701732.128 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2017-11-03T09:35:32.128Z,1509701732.128 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2017-11-03T09:35:32.128Z,1509701732.128 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2017-11-03T09:35:32.128Z,1509701732.128 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2017-11-03T09:35:32.129Z,1509701732.129 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2017-11-03T09:35:32.129Z,1509701732.129 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2017-11-03T09:35:32.129Z,1509701732.129 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2017-11-03T09:35:32.129Z,1509701732.129 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2017-11-03T09:35:32.129Z,1509701732.129 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2017-11-03T09:35:32.130Z,1509701732.130 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2017-11-03T09:35:32.130Z,1509701732.130 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2017-11-03T09:35:32.130Z,1509701732.130 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2017-11-03T09:35:32.130Z,1509701732.130 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2017-11-03T09:35:32.130Z,1509701732.130 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2017-11-03T09:35:32.211Z,1509701732.211 [MissionManager](DEBUG): 2017-11-03T09:35:32.212Z,1509701732.212 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2017-11-03T09:35:32.322Z,1509701732.322 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2017-11-03T09:35:32.323Z,1509701732.323 [Default:A.Wait](DEBUG): Construct Wait. 2017-11-03T09:35:32.341Z,1509701732.341 [Rowe_600LCM](FAULT): LCM not connected 2017-11-03T09:35:32.341Z,1509701732.341 [Rowe_600LCM] Hardware Fault, FailCount= 1 2017-11-03T09:35:32.341Z,1509701732.341 [Rowe_600LCM](ERROR): Hardware Fault 2017-11-03T09:35:32.345Z,1509701732.345 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2017-11-03T09:35:32.371Z,1509701732.371 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2017-11-03T09:35:32.374Z,1509701732.374 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2017-11-03T09:35:32.401Z,1509701732.401 [Default:E.Execute](DEBUG): Construct Execute. 2017-11-03T09:35:32.427Z,1509701732.427 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn 300 Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2017-11-03T09:35:32.433Z,1509701732.433 [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,VerticalTemperatureHomogeneityIndexCalculator,YawRateCalculator,StratificationFrontDetector,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2017-11-03T09:35:32.449Z,1509701732.449 [AcousticModem_Benthos_ATM900](INFO): Powering up 2017-11-03T09:35:32.449Z,1509701732.449 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900. 2017-11-03T09:35:32.475Z,1509701732.475 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2017-11-03T09:35:32.773Z,1509701732.773 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2017-11-03T09:35:32.839Z,1509701732.839 [ESPComponent](INFO): powering down ESP 2017-11-03T09:35:33.015Z,1509701733.015 [Rowe_600LCM](INFO): Powering down 2017-11-03T09:35:33.387Z,1509701733.387 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:33.507Z,1509701733.507 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:33.610Z,1509701733.610 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2017-11-03T09:35:33.617Z,1509701733.617 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2017-11-03T09:35:33.623Z,1509701733.623 [ElevatorServo](DEBUG): Initializing EZServoServo. 2017-11-03T09:35:33.629Z,1509701733.629 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2017-11-03T09:35:33.651Z,1509701733.651 [MassServo](DEBUG): Initializing EZServoServo. 2017-11-03T09:35:33.657Z,1509701733.657 [MassServo](DEBUG): Initializing MassServo. 2017-11-03T09:35:33.679Z,1509701733.679 [RudderServo](DEBUG): Initializing EZServoServo. 2017-11-03T09:35:33.685Z,1509701733.685 [RudderServo](DEBUG): Initializing RudderServo. 2017-11-03T09:35:33.690Z,1509701733.690 [ThrusterServo](DEBUG): Initializing EZServoServo. 2017-11-03T09:35:33.697Z,1509701733.697 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2017-11-03T09:35:33.746Z,1509701733.746 [CommandLine](FAULT): Scheduling is paused 2017-11-03T09:35:33.746Z,1509701733.746 [CBIT](INFO): Critical error at 20171103T093531 2017-11-03T09:35:33.746Z,1509701733.746 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2017-11-03T09:35:33.750Z,1509701733.750 [CBIT](ERROR): Hardware Fault in component: Rowe_600LCM 2017-11-03T09:35:33.926Z,1509701733.926 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:33.927Z,1509701733.927 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:34.225Z,1509701734.225 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:34.241Z,1509701734.241 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:34.573Z,1509701734.573 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2017-11-03T09:35:34.573Z,1509701734.573 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2017-11-03T09:35:34.573Z,1509701734.573 [BuoyancyServo] Communications Fault, FailCount= 1 2017-11-03T09:35:34.573Z,1509701734.573 [BuoyancyServo](ERROR): Communications Fault 2017-11-03T09:35:34.780Z,1509701734.780 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2017-11-03T09:35:34.780Z,1509701734.780 [Rowe_600LCM] No Fault, FailCount= 1 2017-11-03T09:35:34.781Z,1509701734.781 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2017-11-03T09:35:34.834Z,1509701734.834 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:34.835Z,1509701734.835 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:34.846Z,1509701734.846 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2017-11-03T09:35:34.847Z,1509701734.847 [BuoyancyServo](INFO): Powering down 2017-11-03T09:35:35.053Z,1509701735.053 [Rowe_600LCM](INFO): Initializing 2017-11-03T09:35:35.053Z,1509701735.053 [Rowe_600LCM](INFO): Checking LCM 2017-11-03T09:35:35.053Z,1509701735.053 [Rowe_600LCM](FAULT): LCM not connected 2017-11-03T09:35:35.054Z,1509701735.054 [Rowe_600LCM] Hardware Fault, FailCount= 2 2017-11-03T09:35:35.054Z,1509701735.054 [Rowe_600LCM](ERROR): Hardware Fault 2017-11-03T09:35:35.272Z,1509701735.272 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:35.281Z,1509701735.281 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:35.299Z,1509701735.299 [CBIT](ERROR): Hardware Fault in component: Rowe_600LCM 2017-11-03T09:35:35.457Z,1509701735.457 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2017-11-03T09:35:35.677Z,1509701735.677 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:35.678Z,1509701735.678 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:35.735Z,1509701735.735 [Rowe_600LCM](INFO): Powering down 2017-11-03T09:35:36.025Z,1509701736.025 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:36.026Z,1509701736.026 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:36.429Z,1509701736.429 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:36.437Z,1509701736.437 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:36.821Z,1509701736.821 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:36.822Z,1509701736.822 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:36.941Z,1509701736.941 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2017-11-03T09:35:36.941Z,1509701736.941 [BuoyancyServo] No Fault, FailCount= 1 2017-11-03T09:35:37.221Z,1509701737.221 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:37.235Z,1509701737.235 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:37.247Z,1509701737.247 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2017-11-03T09:35:37.366Z,1509701737.366 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2017-11-03T09:35:37.569Z,1509701737.569 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2017-11-03T09:35:37.569Z,1509701737.569 [Rowe_600LCM] No Fault, FailCount= 2 2017-11-03T09:35:37.638Z,1509701737.638 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:37.640Z,1509701737.640 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:37.753Z,1509701737.753 [Rowe_600LCM](INFO): Initializing 2017-11-03T09:35:37.753Z,1509701737.753 [Rowe_600LCM](INFO): Checking LCM 2017-11-03T09:35:37.753Z,1509701737.753 [Rowe_600LCM](FAULT): LCM not connected 2017-11-03T09:35:37.754Z,1509701737.754 [Rowe_600LCM] Hardware Fault, FailCount= 3 2017-11-03T09:35:37.754Z,1509701737.754 [Rowe_600LCM](ERROR): Hardware Fault 2017-11-03T09:35:37.841Z,1509701737.841 [CBIT](ERROR): Hardware Fault in component: Rowe_600LCM 2017-11-03T09:35:38.046Z,1509701738.046 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:38.047Z,1509701738.047 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:38.157Z,1509701738.157 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2017-11-03T09:35:38.411Z,1509701738.411 [Rowe_600LCM](INFO): Powering down 2017-11-03T09:35:38.440Z,1509701738.440 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:38.441Z,1509701738.441 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:38.854Z,1509701738.854 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:38.855Z,1509701738.855 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:39.249Z,1509701739.249 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:39.250Z,1509701739.250 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:39.649Z,1509701739.649 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:39.661Z,1509701739.661 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:39.737Z,1509701739.737 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2017-11-03T09:35:39.737Z,1509701739.737 [Rowe_600LCM] No Fault, FailCount= 3 2017-11-03T09:35:40.025Z,1509701740.025 [Rowe_600LCM](INFO): Initializing 2017-11-03T09:35:40.025Z,1509701740.025 [Rowe_600LCM](INFO): Checking LCM 2017-11-03T09:35:40.026Z,1509701740.026 [Rowe_600LCM](FAULT): LCM not connected 2017-11-03T09:35:40.026Z,1509701740.026 [Rowe_600LCM] Hardware Fault, FailCount= 4 2017-11-03T09:35:40.026Z,1509701740.026 [Rowe_600LCM](ERROR): Hardware Fault 2017-11-03T09:35:40.034Z,1509701740.034 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:40.035Z,1509701740.035 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:40.090Z,1509701740.090 [CBIT](ERROR): Hardware Fault in component: Rowe_600LCM 2017-11-03T09:35:40.411Z,1509701740.411 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2017-11-03T09:35:40.411Z,1509701740.411 [PNI_TCM] Data Fault, FailCount= 1 2017-11-03T09:35:40.411Z,1509701740.411 [PNI_TCM](ERROR): Data Fault 2017-11-03T09:35:40.429Z,1509701740.429 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2017-11-03T09:35:40.503Z,1509701740.503 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:40.504Z,1509701740.504 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:40.634Z,1509701740.634 [CBIT](ERROR): Data Fault in component: PNI_TCM 2017-11-03T09:35:40.687Z,1509701740.687 [Rowe_600LCM](INFO): Powering down 2017-11-03T09:35:40.811Z,1509701740.811 [PNI_TCM](INFO): Powering down 2017-11-03T09:35:40.961Z,1509701740.961 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:40.962Z,1509701740.962 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:41.241Z,1509701741.241 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:41.243Z,1509701741.243 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:41.637Z,1509701741.637 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:41.639Z,1509701741.639 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:42.037Z,1509701742.037 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:42.038Z,1509701742.038 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:42.077Z,1509701742.077 [CBIT](INFO): Clearing failed state for component PNI_TCM 2017-11-03T09:35:42.077Z,1509701742.077 [PNI_TCM] No Fault, FailCount= 1 2017-11-03T09:35:42.078Z,1509701742.078 [CBIT](INFO): Clearing failed state for component Rowe_600LCM 2017-11-03T09:35:42.078Z,1509701742.078 [Rowe_600LCM] No Fault, FailCount= 4 2017-11-03T09:35:42.301Z,1509701742.301 [Rowe_600LCM](INFO): Initializing 2017-11-03T09:35:42.301Z,1509701742.301 [Rowe_600LCM](INFO): Checking LCM 2017-11-03T09:35:42.302Z,1509701742.302 [Rowe_600LCM](FAULT): LCM not connected 2017-11-03T09:35:42.302Z,1509701742.302 [Rowe_600LCM] Hardware Fault, FailCount= 5 2017-11-03T09:35:42.302Z,1509701742.302 [Rowe_600LCM](ERROR): Hardware Fault 2017-11-03T09:35:42.446Z,1509701742.446 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:42.447Z,1509701742.447 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:42.550Z,1509701742.550 [CBIT](ERROR): Hardware Fault in component: Rowe_600LCM 2017-11-03T09:35:42.551Z,1509701742.551 [CBIT](FAULT): Hardware Fault in component: Rowe_600LCM 2017-11-03T09:35:42.705Z,1509701742.705 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface 2017-11-03T09:35:42.847Z,1509701742.847 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:42.848Z,1509701742.848 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:42.979Z,1509701742.979 [Rowe_600LCM](INFO): Powering down 2017-11-03T09:35:43.250Z,1509701743.250 [Aanderaa_O2](FAULT): Timed out starting 2017-11-03T09:35:43.250Z,1509701743.250 [Aanderaa_O2] Communications Fault, FailCount= 1 2017-11-03T09:35:43.250Z,1509701743.250 [Aanderaa_O2](ERROR): Communications Fault 2017-11-03T09:35:43.285Z,1509701743.285 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:43.286Z,1509701743.286 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:43.330Z,1509701743.330 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2017-11-03T09:35:43.733Z,1509701743.733 [Aanderaa_O2](INFO): Powering down 2017-11-03T09:35:43.837Z,1509701743.837 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:43.838Z,1509701743.838 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:44.057Z,1509701744.057 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:44.058Z,1509701744.058 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:44.465Z,1509701744.465 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:44.466Z,1509701744.466 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:44.519Z,1509701744.519 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2017-11-03T09:35:44.519Z,1509701744.519 [Aanderaa_O2] No Fault, FailCount= 1 2017-11-03T09:35:44.842Z,1509701744.842 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:44.843Z,1509701744.843 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:45.247Z,1509701745.247 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:45.248Z,1509701745.248 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:45.661Z,1509701745.661 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:45.662Z,1509701745.662 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:46.034Z,1509701746.034 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:46.035Z,1509701746.035 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:46.457Z,1509701746.457 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:46.459Z,1509701746.459 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:46.865Z,1509701746.865 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:46.866Z,1509701746.866 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:47.234Z,1509701747.234 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:47.235Z,1509701747.235 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:47.642Z,1509701747.642 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:47.643Z,1509701747.643 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:48.017Z,1509701748.017 [BPC1](ERROR): Failed to parse bank A battery data 2017-11-03T09:35:48.017Z,1509701748.017 [BPC1] Data Fault, FailCount= 1 2017-11-03T09:35:48.017Z,1509701748.017 [BPC1](ERROR): Data Fault 2017-11-03T09:35:48.061Z,1509701748.061 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:48.062Z,1509701748.062 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:48.106Z,1509701748.106 [CBIT](ERROR): Data Fault in component: BPC1 2017-11-03T09:35:48.461Z,1509701748.461 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:48.462Z,1509701748.462 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:48.837Z,1509701748.837 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:48.838Z,1509701748.838 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:49.252Z,1509701749.252 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:49.261Z,1509701749.261 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:49.305Z,1509701749.305 [CBIT](INFO): Clearing failed state for component BPC1 2017-11-03T09:35:49.305Z,1509701749.305 [BPC1] No Fault, FailCount= 1 2017-11-03T09:35:49.610Z,1509701749.610 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2017-11-03T09:35:49.611Z,1509701749.611 [PNI_TCM] Data Fault, FailCount= 2 2017-11-03T09:35:49.611Z,1509701749.611 [PNI_TCM](ERROR): Data Fault 2017-11-03T09:35:49.686Z,1509701749.686 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:49.687Z,1509701749.687 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:49.733Z,1509701749.733 [CBIT](ERROR): Data Fault in component: PNI_TCM 2017-11-03T09:35:50.009Z,1509701750.009 [PNI_TCM](INFO): Powering down 2017-11-03T09:35:50.145Z,1509701750.145 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:50.146Z,1509701750.146 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:50.437Z,1509701750.437 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:50.454Z,1509701750.454 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:50.837Z,1509701750.837 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:50.838Z,1509701750.838 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:51.237Z,1509701751.237 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:51.238Z,1509701751.238 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:51.349Z,1509701751.349 [CBIT](INFO): Clearing failed state for component PNI_TCM 2017-11-03T09:35:51.349Z,1509701751.349 [PNI_TCM] No Fault, FailCount= 2 2017-11-03T09:35:51.657Z,1509701751.657 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:51.674Z,1509701751.674 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:52.037Z,1509701752.037 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:52.038Z,1509701752.038 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:52.472Z,1509701752.472 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:52.473Z,1509701752.473 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:52.788Z,1509701752.788 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface 2017-11-03T09:35:52.788Z,1509701752.788 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 1 2017-11-03T09:35:52.788Z,1509701752.788 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault 2017-11-03T09:35:52.841Z,1509701752.841 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:52.842Z,1509701752.842 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:52.898Z,1509701752.898 [CBIT](ERROR): Communications Fault in component: AcousticModem_Benthos_ATM900 2017-11-03T09:35:53.188Z,1509701753.188 [AcousticModem_Benthos_ATM900](INFO): Powering down 2017-11-03T09:35:53.386Z,1509701753.386 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:53.387Z,1509701753.387 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:53.660Z,1509701753.660 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:53.662Z,1509701753.662 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:54.053Z,1509701754.053 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:54.054Z,1509701754.054 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:54.113Z,1509701754.113 [CBIT](INFO): Clearing failed state for component AcousticModem_Benthos_ATM900 2017-11-03T09:35:54.113Z,1509701754.113 [AcousticModem_Benthos_ATM900] No Fault, FailCount= 1 2017-11-03T09:35:54.430Z,1509701754.430 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:54.431Z,1509701754.431 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:54.842Z,1509701754.842 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:54.843Z,1509701754.843 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:55.211Z,1509701755.211 [Aanderaa_O2](FAULT): Timed out starting 2017-11-03T09:35:55.211Z,1509701755.211 [Aanderaa_O2] Communications Fault, FailCount= 2 2017-11-03T09:35:55.211Z,1509701755.211 [Aanderaa_O2](ERROR): Communications Fault 2017-11-03T09:35:55.244Z,1509701755.244 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:55.257Z,1509701755.257 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:55.314Z,1509701755.314 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2017-11-03T09:35:55.729Z,1509701755.729 [Aanderaa_O2](INFO): Powering down 2017-11-03T09:35:55.753Z,1509701755.753 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:55.754Z,1509701755.754 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:56.042Z,1509701756.042 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:56.042Z,1509701756.042 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:56.388Z,1509701756.388 [AcousticModem_Benthos_ATM900](INFO): Powering up 2017-11-03T09:35:56.388Z,1509701756.388 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900. 2017-11-03T09:35:56.458Z,1509701756.458 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:56.460Z,1509701756.460 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:56.530Z,1509701756.530 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2017-11-03T09:35:56.530Z,1509701756.530 [Aanderaa_O2] No Fault, FailCount= 2 2017-11-03T09:35:56.841Z,1509701756.841 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:56.842Z,1509701756.842 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:57.260Z,1509701757.260 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:57.262Z,1509701757.262 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:57.638Z,1509701757.638 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:57.639Z,1509701757.639 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:57.995Z,1509701757.995 [NAL9602](INFO): Powering up NAL9602 2017-11-03T09:35:58.089Z,1509701758.089 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:58.090Z,1509701758.090 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:58.449Z,1509701758.449 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:58.453Z,1509701758.453 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:58.811Z,1509701758.811 [PNI_TCM](FAULT): Failed to set parameters during initialization. 2017-11-03T09:35:58.811Z,1509701758.811 [PNI_TCM] Data Fault, FailCount= 3 2017-11-03T09:35:58.811Z,1509701758.811 [PNI_TCM](ERROR): Data Fault 2017-11-03T09:35:58.875Z,1509701758.875 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:58.876Z,1509701758.876 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:58.933Z,1509701758.933 [CBIT](ERROR): Data Fault in component: PNI_TCM 2017-11-03T09:35:59.210Z,1509701759.210 [PNI_TCM](INFO): Powering down 2017-11-03T09:35:59.336Z,1509701759.336 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:59.337Z,1509701759.337 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:59.642Z,1509701759.642 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:35:59.643Z,1509701759.643 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:36:00.029Z,1509701760.029 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:36:00.030Z,1509701760.030 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:36:00.465Z,1509701760.465 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:36:00.466Z,1509701760.466 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:36:00.528Z,1509701760.528 [CBIT](INFO): Clearing failed state for component PNI_TCM 2017-11-03T09:36:00.528Z,1509701760.528 [PNI_TCM] No Fault, FailCount= 3 2017-11-03T09:36:00.857Z,1509701760.857 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:36:00.858Z,1509701760.858 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:36:01.229Z,1509701761.229 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:36:01.230Z,1509701761.230 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:36:01.660Z,1509701761.660 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:36:01.662Z,1509701761.662 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet. 2017-11-03T09:36:02.056Z,1509701762.056 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data