2016-05-19T21:29:54.018Z,1463693394.018 [Supervisor](DEBUG): Initializing supervisor.
2016-05-19T21:29:54.020Z,1463693394.020 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2016-05-19T21:29:54.021Z,1463693394.021 [SyncHandler](INFO): Protected caller Thread ID is 6636
2016-05-19T21:29:54.021Z,1463693394.021 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2016-05-19T21:29:54.022Z,1463693394.022 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 4037C4E0
2016-05-19T21:29:54.023Z,1463693394.023 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6637
2016-05-19T21:29:54.025Z,1463693394.025 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2016-05-19T21:29:54.037Z,1463693394.037 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2016-05-19T21:29:54.038Z,1463693394.038 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 403AC4E0
2016-05-19T21:29:54.039Z,1463693394.039 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6638
2016-05-19T21:29:54.039Z,1463693394.039 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2016-05-19T21:29:54.040Z,1463693394.040 [logger ThreadHandler](DEBUG): Created PCaller Thread at 403DC4E0
2016-05-19T21:29:54.041Z,1463693394.041 [logger ThreadHandler](INFO): Protected caller Thread ID is 6639
2016-05-19T21:29:54.043Z,1463693394.043 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2016-05-19T21:29:54.043Z,1463693394.043 [Supervisor](INFO): Looking for Config files in directory: Config/
2016-05-19T21:29:54.044Z,1463693394.044 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2016-05-19T21:29:54.565Z,1463693394.565 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2016-05-19T21:29:54.566Z,1463693394.566 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2016-05-19T21:29:54.734Z,1463693394.734 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2016-05-19T21:29:54.735Z,1463693394.735 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2016-05-19T21:29:54.861Z,1463693394.861 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2016-05-19T21:29:54.862Z,1463693394.862 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2016-05-19T21:29:54.995Z,1463693394.995 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2016-05-19T21:29:54.996Z,1463693394.996 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2016-05-19T21:29:55.082Z,1463693395.082 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2016-05-19T21:29:55.273Z,1463693395.273 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2016-05-19T21:29:55.274Z,1463693395.274 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2016-05-19T21:29:55.361Z,1463693395.361 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2016-05-19T21:29:55.361Z,1463693395.361 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2016-05-19T21:29:55.636Z,1463693395.636 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2016-05-19T21:29:55.637Z,1463693395.637 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2016-05-19T21:29:55.977Z,1463693395.977 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2016-05-19T21:29:55.978Z,1463693395.978 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2016-05-19T21:29:56.281Z,1463693396.281 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2016-05-19T21:29:56.282Z,1463693396.282 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2016-05-19T21:29:56.871Z,1463693396.871 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2016-05-19T21:29:56.872Z,1463693396.872 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2016-05-19T21:29:57.076Z,1463693397.076 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2016-05-19T21:29:57.077Z,1463693397.077 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2016-05-19T21:29:57.181Z,1463693397.181 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2016-05-19T21:29:57.182Z,1463693397.182 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2016-05-19T21:29:57.616Z,1463693397.616 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2016-05-19T21:29:57.616Z,1463693397.616 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2016-05-19T21:29:57.729Z,1463693397.729 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2016-05-19T21:29:57.731Z,1463693397.731 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2016-05-19T21:29:57.732Z,1463693397.732 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2016-05-19T21:29:57.970Z,1463693397.970 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2016-05-19T21:29:57.970Z,1463693397.970 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2016-05-19T21:29:58.089Z,1463693398.089 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2016-05-19T21:29:58.188Z,1463693398.188 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2016-05-19T21:29:58.286Z,1463693398.286 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2016-05-19T21:29:58.378Z,1463693398.378 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2016-05-19T21:29:58.526Z,1463693398.526 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2016-05-19T21:29:58.688Z,1463693398.688 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2016-05-19T21:29:58.792Z,1463693398.792 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2016-05-19T21:29:58.876Z,1463693398.876 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2016-05-19T21:29:58.968Z,1463693398.968 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2016-05-19T21:29:59.148Z,1463693399.148 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2016-05-19T21:29:59.148Z,1463693399.148 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2016-05-19T21:29:59.149Z,1463693399.149 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2016-05-19T21:29:59.261Z,1463693399.261 [SBIT](DEBUG): Construct Startup Built In Test.
2016-05-19T21:29:59.291Z,1463693399.291 [SBIT] Loaded
2016-05-19T21:29:59.291Z,1463693399.291 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2016-05-19T21:29:59.292Z,1463693399.292 [IBIT](DEBUG): Construct Initiated Built In Test.
2016-05-19T21:29:59.319Z,1463693399.319 [IBIT] Loaded
2016-05-19T21:29:59.319Z,1463693399.319 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2016-05-19T21:29:59.322Z,1463693399.322 [CBIT](DEBUG): Construct Continuous Built In Test.
2016-05-19T21:29:59.457Z,1463693399.457 [CBIT] Loaded
2016-05-19T21:29:59.457Z,1463693399.457 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2016-05-19T21:29:59.458Z,1463693399.458 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2016-05-19T21:29:59.458Z,1463693399.458 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2016-05-19T21:29:59.503Z,1463693399.503 [VerticalControl](DEBUG): Construct VerticalControl.
2016-05-19T21:29:59.602Z,1463693399.602 [VerticalControl] Loaded
2016-05-19T21:29:59.603Z,1463693399.603 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2016-05-19T21:29:59.603Z,1463693399.603 [HorizontalControl](DEBUG): Construct HorizontalControl.
2016-05-19T21:29:59.664Z,1463693399.664 [HorizontalControl] Loaded
2016-05-19T21:29:59.664Z,1463693399.664 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2016-05-19T21:29:59.665Z,1463693399.665 [SpeedControl](DEBUG): Construct SpeedControl.
2016-05-19T21:29:59.670Z,1463693399.670 [SpeedControl] Loaded
2016-05-19T21:29:59.670Z,1463693399.670 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2016-05-19T21:29:59.671Z,1463693399.671 [LoopControl](DEBUG): Construct LoopControl.
2016-05-19T21:29:59.671Z,1463693399.671 [LoopControl] Loaded
2016-05-19T21:29:59.672Z,1463693399.672 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2016-05-19T21:29:59.672Z,1463693399.672 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2016-05-19T21:29:59.673Z,1463693399.673 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2016-05-19T21:29:59.737Z,1463693399.737 [DepthRateCalculator] Loaded
2016-05-19T21:29:59.738Z,1463693399.738 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2016-05-19T21:29:59.743Z,1463693399.743 [PitchRateCalculator] Loaded
2016-05-19T21:29:59.743Z,1463693399.743 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2016-05-19T21:29:59.767Z,1463693399.767 [SpeedCalculator] Loaded
2016-05-19T21:29:59.767Z,1463693399.767 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2016-05-19T21:29:59.806Z,1463693399.806 [TempGradientCalculator] Loaded
2016-05-19T21:29:59.807Z,1463693399.807 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2016-05-19T21:29:59.858Z,1463693399.858 [VerticalTemperatureHomogeneityIndexCalculator] Loaded
2016-05-19T21:29:59.858Z,1463693399.858 [ComponentRegistry](DEBUG): SyncComponent "VerticalTemperatureHomogeneityIndexCalculator" handled in the control thread.
2016-05-19T21:29:59.863Z,1463693399.863 [YawRateCalculator] Loaded
2016-05-19T21:29:59.863Z,1463693399.863 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2016-05-19T21:29:59.864Z,1463693399.864 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2016-05-19T21:29:59.864Z,1463693399.864 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2016-05-19T21:29:59.934Z,1463693399.934 [StratificationFrontDetector](INFO): threshold set to: 0.399988 degC
2016-05-19T21:29:59.934Z,1463693399.934 [StratificationFrontDetector](DEBUG): (re)initializing
2016-05-19T21:29:59.934Z,1463693399.934 [StratificationFrontDetector] Loaded
2016-05-19T21:29:59.935Z,1463693399.935 [ComponentRegistry](DEBUG): SyncComponent "StratificationFrontDetector" handled in the control thread.
2016-05-19T21:29:59.935Z,1463693399.935 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2016-05-19T21:29:59.936Z,1463693399.936 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2016-05-19T21:30:00.142Z,1463693400.142 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2016-05-19T21:30:00.142Z,1463693400.142 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2016-05-19T21:30:00.234Z,1463693400.234 [DeadReckonUsingMultipleVelocitySources] Loaded
2016-05-19T21:30:00.235Z,1463693400.235 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2016-05-19T21:30:00.288Z,1463693400.288 [DeadReckonUsingSpeedCalculator] Loaded
2016-05-19T21:30:00.288Z,1463693400.288 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2016-05-19T21:30:00.305Z,1463693400.305 [NavChart] Loaded
2016-05-19T21:30:00.305Z,1463693400.305 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2016-05-19T21:30:00.309Z,1463693400.309 [UniversalFixResidualReporter] Loaded
2016-05-19T21:30:00.309Z,1463693400.309 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2016-05-19T21:30:00.310Z,1463693400.310 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2016-05-19T21:30:00.310Z,1463693400.310 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2016-05-19T21:30:00.316Z,1463693400.316 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2016-05-19T21:30:00.317Z,1463693400.317 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2016-05-19T21:30:00.489Z,1463693400.489 [Aanderaa_O2] Loaded
2016-05-19T21:30:00.489Z,1463693400.489 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread.
2016-05-19T21:30:00.564Z,1463693400.564 [CTD_NeilBrown] Loaded
2016-05-19T21:30:00.564Z,1463693400.564 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread.
2016-05-19T21:30:00.566Z,1463693400.566 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 4059E4E0
2016-05-19T21:30:00.566Z,1463693400.566 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 6718
2016-05-19T21:30:00.581Z,1463693400.581 [PAR_Licor] Loaded
2016-05-19T21:30:00.581Z,1463693400.581 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2016-05-19T21:30:00.629Z,1463693400.629 [WetLabsBB2FL] Loaded
2016-05-19T21:30:00.629Z,1463693400.629 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2016-05-19T21:30:00.630Z,1463693400.630 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 405CE4E0
2016-05-19T21:30:00.631Z,1463693400.631 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6719
2016-05-19T21:30:00.631Z,1463693400.631 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2016-05-19T21:30:00.632Z,1463693400.632 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2016-05-19T21:30:00.876Z,1463693400.876 [AcousticModem_Benthos_ATM900] Loaded
2016-05-19T21:30:00.876Z,1463693400.876 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2016-05-19T21:30:00.949Z,1463693400.949 [DataOverHttps] Loaded
2016-05-19T21:30:00.949Z,1463693400.949 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2016-05-19T21:30:00.963Z,1463693400.963 [Depth_Keller] Loaded
2016-05-19T21:30:00.963Z,1463693400.963 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2016-05-19T21:30:00.968Z,1463693400.968 [DropWeight] Loaded
2016-05-19T21:30:00.968Z,1463693400.968 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2016-05-19T21:30:01.058Z,1463693401.058 [NAL9602] Loaded
2016-05-19T21:30:01.058Z,1463693401.058 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2016-05-19T21:30:01.099Z,1463693401.099 [Onboard] Loaded
2016-05-19T21:30:01.100Z,1463693401.100 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2016-05-19T21:30:01.107Z,1463693401.107 [Radio_Surface] Loaded
2016-05-19T21:30:01.107Z,1463693401.107 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2016-05-19T21:30:01.109Z,1463693401.109 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409E44E0
2016-05-19T21:30:01.110Z,1463693401.110 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6720
2016-05-19T21:30:01.156Z,1463693401.156 [PNI_TCM] Loaded
2016-05-19T21:30:01.156Z,1463693401.156 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2016-05-19T21:30:02.990Z,1463693402.990 [BPC1] Loaded
2016-05-19T21:30:02.990Z,1463693402.990 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2016-05-19T21:30:02.991Z,1463693402.991 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2016-05-19T21:30:02.991Z,1463693402.991 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2016-05-19T21:30:03.083Z,1463693403.083 [BuoyancyServo] Loaded
2016-05-19T21:30:03.084Z,1463693403.084 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2016-05-19T21:30:03.096Z,1463693403.096 [ElevatorServo] Loaded
2016-05-19T21:30:03.096Z,1463693403.096 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2016-05-19T21:30:03.107Z,1463693403.107 [MassServo] Loaded
2016-05-19T21:30:03.108Z,1463693403.108 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2016-05-19T21:30:03.119Z,1463693403.119 [RudderServo] Loaded
2016-05-19T21:30:03.119Z,1463693403.119 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2016-05-19T21:30:03.131Z,1463693403.131 [ThrusterServo] Loaded
2016-05-19T21:30:03.131Z,1463693403.131 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2016-05-19T21:30:03.131Z,1463693403.131 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2016-05-19T21:30:03.132Z,1463693403.132 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2016-05-19T21:30:03.223Z,1463693403.223 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2016-05-19T21:30:03.223Z,1463693403.223 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2016-05-19T21:30:03.246Z,1463693403.246 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2016-05-19T21:30:03.249Z,1463693403.249 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2016-05-19T21:30:03.250Z,1463693403.250 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2016-05-19T21:30:03.257Z,1463693403.257 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2016-05-19T21:30:03.260Z,1463693403.260 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A924E0
2016-05-19T21:30:03.260Z,1463693403.260 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6721
2016-05-19T21:30:03.265Z,1463693403.265 [Supervisor](INFO): Main Thread ID is 6635
2016-05-19T21:30:03.265Z,1463693403.265 [Supervisor](DEBUG): Running supervisor.
2016-05-19T21:30:03.266Z,1463693403.266 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6722
2016-05-19T21:30:03.269Z,1463693403.269 [controlThread ThreadHandler](INFO): Handler Thread ID is 6723
2016-05-19T21:30:03.269Z,1463693403.269 [controlThread](DEBUG): Initializing ControlThread
2016-05-19T21:30:03.270Z,1463693403.270 [SBIT](INFO): Initialize SBIT Component.
2016-05-19T21:30:03.271Z,1463693403.271 [SBIT](IMPORTANT): git: 2015-11-13-11-g036008f
2016-05-19T21:30:03.271Z,1463693403.271 [SBIT](INFO): git hash: 036008fb27dd1443c9c6898c567944386f491f02
2016-05-19T21:30:03.271Z,1463693403.271 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2016-05-19T21:30:03.272Z,1463693403.272 [SBIT](IMPORTANT): Kernel Version:#639 PREEMPT Wed Mar 12 12:53:33 PDT 2014
2016-05-19T21:30:03.273Z,1463693403.273 [SBIT](INFO): Beginning SBIT in 63.000000 seconds.
2016-05-19T21:30:03.273Z,1463693403.273 [IBIT](INFO): Initialize IBIT Component.
2016-05-19T21:30:03.274Z,1463693403.274 [CBIT](DEBUG): Initialize CBIT Component.
2016-05-19T21:30:03.274Z,1463693403.274 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2016-05-19T21:30:03.274Z,1463693403.274 [CBIT](CRITICAL): Watchdog Timer failed to initialize.
2016-05-19T21:30:03.275Z,1463693403.275 [CBIT] Hardware Fault, FailCount= 1
2016-05-19T21:30:03.275Z,1463693403.275 [CBIT](ERROR): Hardware Fault
2016-05-19T21:30:03.276Z,1463693403.276 [logger ThreadHandler](INFO): Handler Thread ID is 6724
2016-05-19T21:30:03.295Z,1463693403.295 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 6725
2016-05-19T21:30:03.296Z,1463693403.296 [CTD_NeilBrown](INFO): Powering down
2016-05-19T21:30:03.299Z,1463693403.299 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2016-05-19T21:30:03.301Z,1463693403.301 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2016-05-19T21:30:03.302Z,1463693403.302 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2016-05-19T21:30:03.302Z,1463693403.302 [LoopControl](DEBUG): Initialize LoopControlComponent.
2016-05-19T21:30:03.302Z,1463693403.302 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2016-05-19T21:30:03.307Z,1463693403.307 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2016-05-19T21:30:03.307Z,1463693403.307 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2016-05-19T21:30:03.307Z,1463693403.307 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2016-05-19T21:30:03.308Z,1463693403.308 [VerticalTemperatureHomogeneityIndexCalculator](DEBUG): (re)initializing
2016-05-19T21:30:03.308Z,1463693403.308 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2016-05-19T21:30:03.309Z,1463693403.309 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component.
2016-05-19T21:30:03.310Z,1463693403.310 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s.
2016-05-19T21:30:03.310Z,1463693403.310 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s.
2016-05-19T21:30:03.311Z,1463693403.311 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2016-05-19T21:30:03.311Z,1463693403.311 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2016-05-19T21:30:03.311Z,1463693403.311 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2016-05-19T21:30:03.312Z,1463693403.312 [NavChart](DEBUG): Initialize NavChart Navigation.
2016-05-19T21:30:03.312Z,1463693403.312 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2016-05-19T21:30:03.324Z,1463693403.324 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2016-05-19T21:30:03.337Z,1463693403.337 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2016-05-19T21:30:03.345Z,1463693403.345 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6726
2016-05-19T21:30:03.346Z,1463693403.346 [WetLabsBB2FL](INFO): Powering down
2016-05-19T21:30:03.395Z,1463693403.395 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6727
2016-05-19T21:30:03.401Z,1463693403.401 [Radio_Surface](INFO): Powering up
2016-05-19T21:30:03.402Z,1463693403.402 [MissionManager](DEBUG):
2016-05-19T21:30:03.407Z,1463693403.407 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2016-05-19T21:30:03.415Z,1463693403.415 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6728
2016-05-19T21:30:03.419Z,1463693403.419 [NavChartDb](INFO): Looking for Electronic Nav Chart files in directory: Resources/ElectronicNavigationCharts
2016-05-19T21:30:03.420Z,1463693403.420 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2016-05-19T21:30:03.421Z,1463693403.421 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2016-05-19T21:30:03.421Z,1463693403.421 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2016-05-19T21:30:03.421Z,1463693403.421 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2016-05-19T21:30:03.421Z,1463693403.421 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2016-05-19T21:30:03.422Z,1463693403.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2016-05-19T21:30:03.422Z,1463693403.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2016-05-19T21:30:03.422Z,1463693403.422 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2016-05-19T21:30:03.492Z,1463693403.492 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2016-05-19T21:30:03.493Z,1463693403.493 [Default:A.Wait](DEBUG): Construct Wait.
2016-05-19T21:30:03.495Z,1463693403.495 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2016-05-19T21:30:03.537Z,1463693403.537 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2016-05-19T21:30:03.540Z,1463693403.540 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2016-05-19T21:30:03.561Z,1463693403.561 [Default:E.Execute](DEBUG): Construct Execute.
2016-05-19T21:30:03.569Z,1463693403.569 [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
2016-05-19T21:30:03.574Z,1463693403.574 [controlThread](DEBUG): Component order: CycleStarter,Aanderaa_O2,PAR_Licor,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,PNI_TCM,BPC1,PAR_Licor,Depth_Keller,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,
2016-05-19T21:30:03.643Z,1463693403.643 [AcousticModem_Benthos_ATM900](INFO): Powering up
2016-05-19T21:30:03.643Z,1463693403.643 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2016-05-19T21:30:04.257Z,1463693404.257 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:04.264Z,1463693404.264 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:04.377Z,1463693404.377 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2016-05-19T21:30:04.385Z,1463693404.385 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2016-05-19T21:30:04.399Z,1463693404.399 [ElevatorServo](DEBUG): Initializing EZServoServo.
2016-05-19T21:30:04.405Z,1463693404.405 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2016-05-19T21:30:04.426Z,1463693404.426 [MassServo](DEBUG): Initializing EZServoServo.
2016-05-19T21:30:04.433Z,1463693404.433 [MassServo](DEBUG): Initializing MassServo.
2016-05-19T21:30:04.446Z,1463693404.446 [RudderServo](DEBUG): Initializing EZServoServo.
2016-05-19T21:30:04.453Z,1463693404.453 [RudderServo](DEBUG): Initializing RudderServo.
2016-05-19T21:30:04.466Z,1463693404.466 [ThrusterServo](DEBUG): Initializing EZServoServo.
2016-05-19T21:30:04.473Z,1463693404.473 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2016-05-19T21:30:04.521Z,1463693404.521 [CBIT](DEBUG): Uninitialize CBIT Component.
2016-05-19T21:30:04.709Z,1463693404.709 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:04.710Z,1463693404.710 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:05.020Z,1463693405.020 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:05.021Z,1463693405.021 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:05.370Z,1463693405.370 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout
2016-05-19T21:30:05.370Z,1463693405.370 [BuoyancyServo](FAULT): Buoyancy failed to initialize
2016-05-19T21:30:05.370Z,1463693405.370 [BuoyancyServo] Communications Fault, FailCount= 1
2016-05-19T21:30:05.370Z,1463693405.370 [BuoyancyServo](ERROR): Communications Fault
2016-05-19T21:30:05.682Z,1463693405.682 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout
2016-05-19T21:30:05.682Z,1463693405.682 [ElevatorServo](FAULT): Elevator failed to initialize
2016-05-19T21:30:05.683Z,1463693405.683 [ElevatorServo] Communications Fault, FailCount= 1
2016-05-19T21:30:05.683Z,1463693405.683 [ElevatorServo](ERROR): Communications Fault
2016-05-19T21:30:05.987Z,1463693405.987 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2016-05-19T21:30:05.987Z,1463693405.987 [RudderServo](FAULT): Rudder failed to initialize
2016-05-19T21:30:05.987Z,1463693405.987 [RudderServo] Communications Fault, FailCount= 1
2016-05-19T21:30:05.987Z,1463693405.987 [RudderServo](ERROR): Communications Fault
2016-05-19T21:30:06.299Z,1463693406.299 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout
2016-05-19T21:30:06.612Z,1463693406.612 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout
2016-05-19T21:30:06.613Z,1463693406.613 [ThrusterServo](FAULT): Thruster failed to initialize
2016-05-19T21:30:06.613Z,1463693406.613 [ThrusterServo] Communications Fault, FailCount= 1
2016-05-19T21:30:06.613Z,1463693406.613 [ThrusterServo](ERROR): Communications Fault
2016-05-19T21:30:06.634Z,1463693406.634 [NAL9602](INFO): Powering up NAL9602
2016-05-19T21:30:06.692Z,1463693406.692 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:06.693Z,1463693406.693 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:06.710Z,1463693406.710 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2016-05-19T21:30:06.710Z,1463693406.710 [BuoyancyServo](INFO): Powering down
2016-05-19T21:30:06.781Z,1463693406.781 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2016-05-19T21:30:06.781Z,1463693406.781 [ElevatorServo](INFO): Powering down
2016-05-19T21:30:07.153Z,1463693407.153 [MassServo](FAULT): Mass shifter EEPROM initialization uart error serial timeout
2016-05-19T21:30:07.153Z,1463693407.153 [MassServo] Communications Fault, FailCount= 1
2016-05-19T21:30:07.153Z,1463693407.153 [MassServo](ERROR): Communications Fault
2016-05-19T21:30:07.153Z,1463693407.153 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2016-05-19T21:30:07.154Z,1463693407.154 [RudderServo](INFO): Powering down
2016-05-19T21:30:07.187Z,1463693407.187 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2016-05-19T21:30:07.187Z,1463693407.187 [ThrusterServo](INFO): Powering down
2016-05-19T21:30:07.549Z,1463693407.549 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:07.551Z,1463693407.551 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:07.564Z,1463693407.564 [MassServo](DEBUG): Uninitialize Mass Servo.
2016-05-19T21:30:07.564Z,1463693407.564 [MassServo](INFO): Powering down
2016-05-19T21:30:07.682Z,1463693407.682 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:07.683Z,1463693407.683 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:07.690Z,1463693407.690 [ElevatorServo](DEBUG): Initializing EZServoServo.
2016-05-19T21:30:07.811Z,1463693407.811 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2016-05-19T21:30:07.813Z,1463693407.813 [RudderServo](DEBUG): Initializing EZServoServo.
2016-05-19T21:30:07.931Z,1463693407.931 [RudderServo](DEBUG): Initializing RudderServo.
2016-05-19T21:30:08.280Z,1463693408.280 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:08.282Z,1463693408.282 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:08.308Z,1463693408.308 [MassServo](DEBUG): Initializing EZServoServo.
2016-05-19T21:30:08.428Z,1463693408.428 [MassServo](DEBUG): Initializing MassServo.
2016-05-19T21:30:08.482Z,1463693408.482 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:08.483Z,1463693408.483 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:09.056Z,1463693409.056 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:09.057Z,1463693409.057 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:09.371Z,1463693409.371 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:09.372Z,1463693409.372 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:09.913Z,1463693409.913 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:09.914Z,1463693409.914 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:10.103Z,1463693410.103 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:10.104Z,1463693410.104 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:10.734Z,1463693410.734 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:10.735Z,1463693410.735 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:10.993Z,1463693410.993 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:11.011Z,1463693411.011 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:11.345Z,1463693411.345 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:11.346Z,1463693411.346 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:11.707Z,1463693411.707 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:11.716Z,1463693411.716 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:12.093Z,1463693412.093 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:12.094Z,1463693412.094 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:12.565Z,1463693412.565 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:12.575Z,1463693412.575 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:13.089Z,1463693413.089 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:13.103Z,1463693413.103 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:13.342Z,1463693413.342 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:13.343Z,1463693413.343 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:13.658Z,1463693413.658 [Aanderaa_O2](FAULT): Timed out starting
2016-05-19T21:30:13.658Z,1463693413.658 [Aanderaa_O2] Communications Fault, FailCount= 1
2016-05-19T21:30:13.659Z,1463693413.659 [Aanderaa_O2](ERROR): Communications Fault
2016-05-19T21:30:13.810Z,1463693413.810 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:13.811Z,1463693413.811 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:14.180Z,1463693414.180 [Aanderaa_O2](INFO): Powering down
2016-05-19T21:30:14.409Z,1463693414.409 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:14.410Z,1463693414.410 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:14.527Z,1463693414.527 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:14.528Z,1463693414.528 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:15.067Z,1463693415.067 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:15.069Z,1463693415.069 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:15.324Z,1463693415.324 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:15.325Z,1463693415.325 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:15.711Z,1463693415.711 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:15.712Z,1463693415.712 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:16.087Z,1463693416.087 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:16.088Z,1463693416.088 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:16.496Z,1463693416.496 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:16.497Z,1463693416.497 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:16.944Z,1463693416.944 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:16.945Z,1463693416.945 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:17.324Z,1463693417.324 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:17.326Z,1463693417.326 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:17.681Z,1463693417.681 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2016-05-19T21:30:17.681Z,1463693417.681 [PNI_TCM] Data Fault, FailCount= 1
2016-05-19T21:30:17.681Z,1463693417.681 [PNI_TCM](ERROR): Data Fault
2016-05-19T21:30:17.709Z,1463693417.709 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:17.711Z,1463693417.711 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:18.080Z,1463693418.080 [PNI_TCM](INFO): Powering down
2016-05-19T21:30:18.253Z,1463693418.253 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:18.270Z,1463693418.270 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:18.519Z,1463693418.519 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:18.520Z,1463693418.520 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:18.983Z,1463693418.983 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:18.984Z,1463693418.984 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:19.328Z,1463693419.328 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:19.329Z,1463693419.329 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:19.695Z,1463693419.695 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:19.704Z,1463693419.704 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:20.115Z,1463693420.115 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:20.116Z,1463693420.116 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:20.500Z,1463693420.500 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:20.501Z,1463693420.501 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:20.909Z,1463693420.909 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:20.918Z,1463693420.918 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:21.294Z,1463693421.294 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:21.303Z,1463693421.303 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:21.702Z,1463693421.702 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:21.703Z,1463693421.703 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:22.111Z,1463693422.111 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:22.117Z,1463693422.117 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:22.496Z,1463693422.496 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:22.505Z,1463693422.505 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:22.891Z,1463693422.891 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:22.893Z,1463693422.893 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:23.289Z,1463693423.289 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:23.298Z,1463693423.298 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:23.693Z,1463693423.693 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:23.703Z,1463693423.703 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:24.060Z,1463693424.060 [AcousticModem_Benthos_ATM900](FAULT): failed to initialize, no bytes available on serial interface
2016-05-19T21:30:24.060Z,1463693424.060 [AcousticModem_Benthos_ATM900] Communications Fault, FailCount= 1
2016-05-19T21:30:24.060Z,1463693424.060 [AcousticModem_Benthos_ATM900](ERROR): Communications Fault
2016-05-19T21:30:24.207Z,1463693424.207 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:24.209Z,1463693424.209 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:24.460Z,1463693424.460 [AcousticModem_Benthos_ATM900](INFO): Powering down
2016-05-19T21:30:24.622Z,1463693424.622 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:24.623Z,1463693424.623 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:24.821Z,1463693424.821 [CommandLine](IMPORTANT): got command failComponent
2016-05-19T21:30:24.821Z,1463693424.821 [CommandLine](IMPORTANT): Failed components:
2016-05-19T21:30:24.821Z,1463693424.821 [CommandLine](IMPORTANT): CBIT: Hardware Fault
2016-05-19T21:30:24.822Z,1463693424.822 [CommandLine](IMPORTANT): Aanderaa_O2: Communications Fault
2016-05-19T21:30:24.822Z,1463693424.822 [CommandLine](IMPORTANT): AcousticModem_Benthos_ATM900: Communications Fault
2016-05-19T21:30:24.822Z,1463693424.822 [CommandLine](IMPORTANT): PNI_TCM: Data Fault
2016-05-19T21:30:24.822Z,1463693424.822 [CommandLine](IMPORTANT): BuoyancyServo: Communications Fault
2016-05-19T21:30:24.823Z,1463693424.823 [CommandLine](IMPORTANT): ElevatorServo: Communications Fault
2016-05-19T21:30:24.823Z,1463693424.823 [CommandLine](IMPORTANT): MassServo: Communications Fault
2016-05-19T21:30:24.823Z,1463693424.823 [CommandLine](IMPORTANT): RudderServo: Communications Fault
2016-05-19T21:30:24.823Z,1463693424.823 [CommandLine](IMPORTANT): ThrusterServo: Communications Fault
2016-05-19T21:30:24.885Z,1463693424.885 [AcousticModem_Benthos_ATM900](FAULT): LCB fault: Current Limiter Activated.
2016-05-19T21:30:24.885Z,1463693424.885 [AcousticModem_Benthos_ATM900] Hardware Fault, FailCount= 1
2016-05-19T21:30:24.886Z,1463693424.886 [AcousticModem_Benthos_ATM900](ERROR): Hardware Fault
2016-05-19T21:30:24.949Z,1463693424.949 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:24.950Z,1463693424.950 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:25.279Z,1463693425.279 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:25.280Z,1463693425.280 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:25.704Z,1463693425.704 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:25.710Z,1463693425.710 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:26.093Z,1463693426.093 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:26.099Z,1463693426.099 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:26.524Z,1463693426.524 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:26.525Z,1463693426.525 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:26.891Z,1463693426.891 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:26.896Z,1463693426.896 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:27.305Z,1463693427.305 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:27.306Z,1463693427.306 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:27.549Z,1463693427.549 [CommandLine](IMPORTANT): got command restart application
2016-05-19T21:30:27.670Z,1463693427.670 [NAL9602](ERROR): NAL9602 initialization error.
2016-05-19T21:30:27.671Z,1463693427.671 [NAL9602] Communications Fault, FailCount= 1
2016-05-19T21:30:27.671Z,1463693427.671 [NAL9602](ERROR): Communications Fault
2016-05-19T21:30:27.734Z,1463693427.734 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:27.735Z,1463693427.735 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:28.068Z,1463693428.068 [NAL9602](INFO): Powering down
2016-05-19T21:30:28.089Z,1463693428.089 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:28.093Z,1463693428.093 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:28.535Z,1463693428.535 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:28.536Z,1463693428.536 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:28.557Z,1463693428.557 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-19T21:30:28.557Z,1463693428.557 [CommandLine ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:28.702Z,1463693428.702 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2016-05-19T21:30:28.702Z,1463693428.702 [CommandLine ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:28.704Z,1463693428.704 [CommandLine](INFO): Join timeout helper Thread ID is 6740
2016-05-19T21:30:28.713Z,1463693428.713 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2016-05-19T21:30:28.714Z,1463693428.714 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:28.714Z,1463693428.714 [NavChartDb](INFO): Join timeout helper Thread ID is 6741
2016-05-19T21:30:28.898Z,1463693428.898 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:28.900Z,1463693428.900 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-19T21:30:28.900Z,1463693428.900 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:28.901Z,1463693428.901 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:28.914Z,1463693428.914 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2016-05-19T21:30:28.914Z,1463693428.914 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:28.915Z,1463693428.915 [Radio_Surface](INFO): Join timeout helper Thread ID is 6742
2016-05-19T21:30:29.239Z,1463693429.239 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-19T21:30:29.239Z,1463693429.239 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:29.243Z,1463693429.243 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2016-05-19T21:30:29.243Z,1463693429.243 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:29.243Z,1463693429.243 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6743
2016-05-19T21:30:29.291Z,1463693429.291 [DeadReckonUsingMultipleVelocitySources](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:29.292Z,1463693429.292 [DeadReckonUsingSpeedCalculator](DEBUG): Starting up and don't have orientation data yet.
2016-05-19T21:30:29.319Z,1463693429.319 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-19T21:30:29.319Z,1463693429.319 [WetLabsBB2FL](INFO): Powering down
2016-05-19T21:30:29.320Z,1463693429.320 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:29.335Z,1463693429.335 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler
2016-05-19T21:30:29.335Z,1463693429.335 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:29.336Z,1463693429.336 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 6744
2016-05-19T21:30:29.496Z,1463693429.496 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-19T21:30:29.496Z,1463693429.496 [CTD_NeilBrown](INFO): Powering down
2016-05-19T21:30:29.497Z,1463693429.497 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:29.504Z,1463693429.504 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2016-05-19T21:30:29.504Z,1463693429.504 [logger ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:29.505Z,1463693429.505 [logger](INFO): Join timeout helper Thread ID is 6745
2016-05-19T21:30:29.519Z,1463693429.519 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-19T21:30:29.520Z,1463693429.520 [logger ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:29.524Z,1463693429.524 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2016-05-19T21:30:29.524Z,1463693429.524 [CommandLine ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:29.524Z,1463693429.524 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2016-05-19T21:30:29.525Z,1463693429.525 [controlThread ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:29.525Z,1463693429.525 [controlThread](INFO): Join timeout helper Thread ID is 6746
2016-05-19T21:30:29.656Z,1463693429.656 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2016-05-19T21:30:29.656Z,1463693429.656 [controlThread](DEBUG): Uninitializing ControlThread
2016-05-19T21:30:29.656Z,1463693429.656 [Aanderaa_O2](INFO): Powering down
2016-05-19T21:30:29.658Z,1463693429.658 [AcousticModem_Benthos_ATM900](INFO): Powering down
2016-05-19T21:30:29.659Z,1463693429.659 [NAL9602](INFO): Powering down
2016-05-19T21:30:29.660Z,1463693429.660 [PNI_TCM](INFO): Powering down
2016-05-19T21:30:29.662Z,1463693429.662 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2016-05-19T21:30:29.663Z,1463693429.663 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2016-05-19T21:30:29.666Z,1463693429.666 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2016-05-19T21:30:29.666Z,1463693429.666 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2016-05-19T21:30:29.666Z,1463693429.666 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2016-05-19T21:30:29.667Z,1463693429.667 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2016-05-19T21:30:29.667Z,1463693429.667 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2016-05-19T21:30:29.667Z,1463693429.667 [BuoyancyServo](INFO): Powering down
2016-05-19T21:30:29.684Z,1463693429.684 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2016-05-19T21:30:29.684Z,1463693429.684 [ElevatorServo](INFO): Powering down
2016-05-19T21:30:29.685Z,1463693429.685 [MassServo](DEBUG): Uninitialize Mass Servo.
2016-05-19T21:30:29.685Z,1463693429.685 [MassServo](INFO): Powering down
2016-05-19T21:30:29.685Z,1463693429.685 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2016-05-19T21:30:29.686Z,1463693429.686 [RudderServo](INFO): Powering down
2016-05-19T21:30:29.686Z,1463693429.686 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2016-05-19T21:30:29.686Z,1463693429.686 [ThrusterServo](INFO): Powering down
2016-05-19T21:30:29.687Z,1463693429.687 [SBIT](DEBUG): Uninitialize SBIT Component.
2016-05-19T21:30:29.688Z,1463693429.688 [IBIT](DEBUG): Uninitialize IBIT Component.
2016-05-19T21:30:29.688Z,1463693429.688 [CBIT](DEBUG): Uninitialize CBIT Component.
2016-05-19T21:30:29.729Z,1463693429.729 [CBIT](CRITICAL): run-time exception #7
2016-05-19T21:30:29.729Z,1463693429.729 [CBIT](CRITICAL): Bad address: 0x40319004
2016-05-19T21:30:29.729Z,1463693429.729 [CBIT](CRITICAL): Backtrace:
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x1737f4]
/lib/libc.so.6(__default_rt_sa_restorer+0) [0x40212510]
2016-05-19T21:30:29.729Z,1463693429.729 [CBIT] Software Fault, FailCount= 1
2016-05-19T21:30:29.729Z,1463693429.729 [CBIT](ERROR): Software Fault
2016-05-19T21:30:29.731Z,1463693429.731 [SyncHandler](DEBUG): Created PCaller Thread at 4034C4E0
2016-05-19T21:30:29.732Z,1463693429.732 [SyncHandler](INFO): Protected caller Thread ID is 6747
2016-05-19T21:30:29.732Z,1463693429.732 [controlThread ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:29.791Z,1463693429.791 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:29.795Z,1463693429.795 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:29.858Z,1463693429.858 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:30.380Z,1463693430.380 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2016-05-19T21:30:30.433Z,1463693430.433 [logger ThreadHandler](INFO): Thread cancelled.