2018-11-12T19:05:56.777Z,1542049556.777 [Supervisor](DEBUG): Initializing supervisor. 2018-11-12T19:05:56.780Z,1542049556.780 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2018-11-12T19:05:56.781Z,1542049556.781 [SyncHandler](INFO): Protected caller Thread ID is 918 2018-11-12T19:05:56.781Z,1542049556.781 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2018-11-12T19:05:56.782Z,1542049556.782 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2018-11-12T19:05:56.783Z,1542049556.783 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 919 2018-11-12T19:05:56.786Z,1542049556.786 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2018-11-12T19:05:56.798Z,1542049556.798 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2018-11-12T19:05:56.799Z,1542049556.799 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2018-11-12T19:05:56.800Z,1542049556.800 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 920 2018-11-12T19:05:56.800Z,1542049556.800 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2018-11-12T19:05:56.801Z,1542049556.801 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2018-11-12T19:05:56.802Z,1542049556.802 [logger ThreadHandler](INFO): Protected caller Thread ID is 921 2018-11-12T19:05:56.804Z,1542049556.804 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2018-11-12T19:05:56.804Z,1542049556.804 [Supervisor](INFO): Looking for Config files in directory: Config/ 2018-11-12T19:05:56.806Z,1542049556.806 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2018-11-12T19:05:57.267Z,1542049557.267 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2018-11-12T19:05:57.268Z,1542049557.268 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2018-11-12T19:05:57.743Z,1542049557.743 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2018-11-12T19:05:57.744Z,1542049557.744 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2018-11-12T19:05:57.948Z,1542049557.948 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2018-11-12T19:05:57.948Z,1542049557.948 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2018-11-12T19:05:58.098Z,1542049558.098 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2018-11-12T19:05:58.099Z,1542049558.099 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2018-11-12T19:05:58.563Z,1542049558.563 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2018-11-12T19:05:58.564Z,1542049558.564 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2018-11-12T19:05:58.661Z,1542049558.661 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2018-11-12T19:05:58.661Z,1542049558.661 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2018-11-12T19:05:58.807Z,1542049558.807 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2018-11-12T19:05:58.808Z,1542049558.808 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2018-11-12T19:05:58.910Z,1542049558.910 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2018-11-12T19:05:58.910Z,1542049558.910 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2018-11-12T19:05:59.016Z,1542049559.016 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2018-11-12T19:05:59.016Z,1542049559.016 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2018-11-12T19:05:59.379Z,1542049559.379 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2018-11-12T19:05:59.380Z,1542049559.380 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2018-11-12T19:05:59.595Z,1542049559.595 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2018-11-12T19:05:59.596Z,1542049559.596 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2018-11-12T19:05:59.819Z,1542049559.819 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2018-11-12T19:05:59.820Z,1542049559.820 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2018-11-12T19:05:59.901Z,1542049559.901 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2018-11-12T19:06:00.277Z,1542049560.277 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2018-11-12T19:06:00.278Z,1542049560.278 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2018-11-12T19:06:00.616Z,1542049560.616 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2018-11-12T19:06:00.618Z,1542049560.618 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2018-11-12T19:06:00.619Z,1542049560.619 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2018-11-12T19:06:00.705Z,1542049560.705 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2018-11-12T19:06:00.896Z,1542049560.896 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2018-11-12T19:06:01.183Z,1542049561.183 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2018-11-12T19:06:01.615Z,1542049561.615 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2018-11-12T19:06:01.756Z,1542049561.756 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2018-11-12T19:06:01.986Z,1542049561.986 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2018-11-12T19:06:01.986Z,1542049561.986 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2018-11-12T19:06:02.105Z,1542049562.105 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2018-11-12T19:06:02.208Z,1542049562.208 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2018-11-12T19:06:02.305Z,1542049562.305 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2018-11-12T19:06:02.411Z,1542049562.411 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2018-11-12T19:06:02.528Z,1542049562.528 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/ 2018-11-12T19:06:02.528Z,1542049562.528 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2018-11-12T19:06:02.534Z,1542049562.534 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2018-11-12T19:06:02.578Z,1542049562.578 [DepthRateCalculator] Loaded 2018-11-12T19:06:02.578Z,1542049562.578 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2018-11-12T19:06:02.584Z,1542049562.584 [PitchRateCalculator] Loaded 2018-11-12T19:06:02.585Z,1542049562.585 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2018-11-12T19:06:02.601Z,1542049562.601 [SpeedCalculator] Loaded 2018-11-12T19:06:02.601Z,1542049562.601 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2018-11-12T19:06:02.622Z,1542049562.622 [TempGradientCalculator] Loaded 2018-11-12T19:06:02.622Z,1542049562.622 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2018-11-12T19:06:02.629Z,1542049562.629 [YawRateCalculator] Loaded 2018-11-12T19:06:02.629Z,1542049562.629 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2018-11-12T19:06:02.670Z,1542049562.670 [ElevatorOffsetCalculator] Loaded 2018-11-12T19:06:02.670Z,1542049562.670 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2018-11-12T19:06:02.671Z,1542049562.671 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2018-11-12T19:06:02.671Z,1542049562.671 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2018-11-12T19:06:02.915Z,1542049562.915 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2018-11-12T19:06:02.915Z,1542049562.915 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2018-11-12T19:06:03.214Z,1542049563.214 [DataOverHttps] Loaded 2018-11-12T19:06:03.215Z,1542049563.215 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2018-11-12T19:06:03.242Z,1542049563.242 [Depth_Keller] Loaded 2018-11-12T19:06:03.242Z,1542049563.242 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2018-11-12T19:06:03.247Z,1542049563.247 [DropWeight] Loaded 2018-11-12T19:06:03.248Z,1542049563.248 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2018-11-12T19:06:03.381Z,1542049563.381 [DVL_micro] Loaded 2018-11-12T19:06:03.381Z,1542049563.381 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2018-11-12T19:06:03.480Z,1542049563.480 [NAL9602] Loaded 2018-11-12T19:06:03.480Z,1542049563.480 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2018-11-12T19:06:03.496Z,1542049563.496 [Onboard] Loaded 2018-11-12T19:06:03.497Z,1542049563.497 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2018-11-12T19:06:03.507Z,1542049563.507 [Radio_Surface] Loaded 2018-11-12T19:06:03.507Z,1542049563.507 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2018-11-12T19:06:03.508Z,1542049563.508 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407C34E0 2018-11-12T19:06:03.509Z,1542049563.509 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 1000 2018-11-12T19:06:03.515Z,1542049563.515 [SCPI] Loaded 2018-11-12T19:06:03.516Z,1542049563.516 [ComponentRegistry](DEBUG): SyncComponent "SCPI" handled in the control thread. 2018-11-12T19:06:03.562Z,1542049563.562 [PNI_TCM] Loaded 2018-11-12T19:06:03.563Z,1542049563.563 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 2018-11-12T19:06:05.351Z,1542049565.351 [BPC1] Loaded 2018-11-12T19:06:05.351Z,1542049565.351 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2018-11-12T19:06:05.351Z,1542049565.351 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2018-11-12T19:06:05.352Z,1542049565.352 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2018-11-12T19:06:05.418Z,1542049565.418 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2018-11-12T19:06:05.419Z,1542049565.419 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2018-11-12T19:06:05.515Z,1542049565.515 [DeadReckonUsingMultipleVelocitySources] Loaded 2018-11-12T19:06:05.515Z,1542049565.515 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2018-11-12T19:06:05.570Z,1542049565.570 [DeadReckonUsingSpeedCalculator] Loaded 2018-11-12T19:06:05.571Z,1542049565.571 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2018-11-12T19:06:05.587Z,1542049565.587 [NavChart] Loaded 2018-11-12T19:06:05.587Z,1542049565.587 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2018-11-12T19:06:05.591Z,1542049565.591 [UniversalFixResidualReporter] Loaded 2018-11-12T19:06:05.592Z,1542049565.592 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2018-11-12T19:06:05.592Z,1542049565.592 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2018-11-12T19:06:05.593Z,1542049565.593 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2018-11-12T19:06:05.752Z,1542049565.752 [Aanderaa_O2] Loaded 2018-11-12T19:06:05.753Z,1542049565.753 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 2018-11-12T19:06:05.838Z,1542049565.838 [CTD_NeilBrown] Loaded 2018-11-12T19:06:05.838Z,1542049565.838 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread. 2018-11-12T19:06:05.839Z,1542049565.839 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 408CE4E0 2018-11-12T19:06:05.839Z,1542049565.839 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 1001 2018-11-12T19:06:05.890Z,1542049565.890 [WetLabsBB2FL] Loaded 2018-11-12T19:06:05.890Z,1542049565.890 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2018-11-12T19:06:05.891Z,1542049565.891 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 408FE4E0 2018-11-12T19:06:05.891Z,1542049565.891 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 1002 2018-11-12T19:06:05.892Z,1542049565.892 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2018-11-12T19:06:05.893Z,1542049565.893 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2018-11-12T19:06:06.075Z,1542049566.075 [VerticalControl](DEBUG): Construct VerticalControl. 2018-11-12T19:06:06.179Z,1542049566.179 [VerticalControl] Loaded 2018-11-12T19:06:06.179Z,1542049566.179 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2018-11-12T19:06:06.180Z,1542049566.180 [HorizontalControl](DEBUG): Construct HorizontalControl. 2018-11-12T19:06:06.250Z,1542049566.250 [HorizontalControl] Loaded 2018-11-12T19:06:06.250Z,1542049566.250 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2018-11-12T19:06:06.251Z,1542049566.251 [SpeedControl](DEBUG): Construct SpeedControl. 2018-11-12T19:06:06.256Z,1542049566.256 [SpeedControl] Loaded 2018-11-12T19:06:06.257Z,1542049566.257 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2018-11-12T19:06:06.257Z,1542049566.257 [LoopControl](DEBUG): Construct LoopControl. 2018-11-12T19:06:06.258Z,1542049566.258 [LoopControl] Loaded 2018-11-12T19:06:06.258Z,1542049566.258 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2018-11-12T19:06:06.259Z,1542049566.259 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2018-11-12T19:06:06.259Z,1542049566.259 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2018-11-12T19:06:06.272Z,1542049566.272 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2018-11-12T19:06:06.273Z,1542049566.273 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2018-11-12T19:06:06.405Z,1542049566.405 [SBIT](DEBUG): Construct Startup Built In Test. 2018-11-12T19:06:06.417Z,1542049566.417 [SBIT] Loaded 2018-11-12T19:06:06.417Z,1542049566.417 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2018-11-12T19:06:06.418Z,1542049566.418 [IBIT](DEBUG): Construct Initiated Built In Test. 2018-11-12T19:06:06.430Z,1542049566.430 [IBIT] Loaded 2018-11-12T19:06:06.430Z,1542049566.430 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2018-11-12T19:06:06.433Z,1542049566.433 [CBIT](DEBUG): Construct Continuous Built In Test. 2018-11-12T19:06:06.586Z,1542049566.586 [CBIT] Loaded 2018-11-12T19:06:06.586Z,1542049566.586 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2018-11-12T19:06:06.586Z,1542049566.586 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2018-11-12T19:06:06.587Z,1542049566.587 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2018-11-12T19:06:06.689Z,1542049566.689 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2018-11-12T19:06:06.690Z,1542049566.690 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2018-11-12T19:06:06.715Z,1542049566.715 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2018-11-12T19:06:06.716Z,1542049566.716 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2018-11-12T19:06:06.815Z,1542049566.815 [BuoyancyServo] Loaded 2018-11-12T19:06:06.816Z,1542049566.816 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2018-11-12T19:06:06.827Z,1542049566.827 [ElevatorServo] Loaded 2018-11-12T19:06:06.827Z,1542049566.827 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2018-11-12T19:06:06.838Z,1542049566.838 [MassServo] Loaded 2018-11-12T19:06:06.839Z,1542049566.839 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2018-11-12T19:06:06.850Z,1542049566.850 [RudderServo] Loaded 2018-11-12T19:06:06.850Z,1542049566.850 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2018-11-12T19:06:06.862Z,1542049566.862 [ThrusterServo] Loaded 2018-11-12T19:06:06.862Z,1542049566.862 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2018-11-12T19:06:06.862Z,1542049566.862 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2018-11-12T19:06:06.866Z,1542049566.866 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2018-11-12T19:06:06.867Z,1542049566.867 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2018-11-12T19:06:06.874Z,1542049566.874 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2018-11-12T19:06:06.875Z,1542049566.875 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A164E0 2018-11-12T19:06:06.875Z,1542049566.875 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 1003 2018-11-12T19:06:06.880Z,1542049566.880 [Supervisor](INFO): Main Thread ID is 789 2018-11-12T19:06:06.880Z,1542049566.880 [Supervisor](DEBUG): Running supervisor. 2018-11-12T19:06:06.881Z,1542049566.881 [CommandLine ThreadHandler](INFO): Handler Thread ID is 1004 2018-11-12T19:06:06.883Z,1542049566.883 [controlThread ThreadHandler](INFO): Handler Thread ID is 1005 2018-11-12T19:06:06.884Z,1542049566.884 [controlThread](DEBUG): Initializing ControlThread 2018-11-12T19:06:06.885Z,1542049566.885 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-11-12T19:06:06.885Z,1542049566.885 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2018-11-12T19:06:06.885Z,1542049566.885 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2018-11-12T19:06:06.886Z,1542049566.886 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2018-11-12T19:06:06.886Z,1542049566.886 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2018-11-12T19:06:06.887Z,1542049566.887 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2018-11-12T19:06:06.894Z,1542049566.894 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-12T19:06:06.895Z,1542049566.895 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-12T19:06:06.895Z,1542049566.895 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-12T19:06:06.896Z,1542049566.896 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-12T19:06:06.896Z,1542049566.896 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-12T19:06:06.896Z,1542049566.896 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-12T19:06:06.897Z,1542049566.897 [NavChart](DEBUG): Initialize NavChart Navigation. 2018-11-12T19:06:06.897Z,1542049566.897 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2018-11-12T19:06:06.898Z,1542049566.898 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2018-11-12T19:06:06.900Z,1542049566.900 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2018-11-12T19:06:06.900Z,1542049566.900 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2018-11-12T19:06:06.901Z,1542049566.901 [LoopControl](DEBUG): Initialize LoopControlComponent. 2018-11-12T19:06:06.901Z,1542049566.901 [SBIT](INFO): Initialize SBIT Component. 2018-11-12T19:06:06.902Z,1542049566.902 [SBIT](IMPORTANT): git: 2018-10-09-34-gf593050 2018-11-12T19:06:06.902Z,1542049566.902 [SBIT](INFO): git hash: f5930504aac459d36ba66e787e98c9e35813b4f6 2018-11-12T19:06:06.902Z,1542049566.902 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2018-11-12T19:06:06.903Z,1542049566.903 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018 2018-11-12T19:06:06.904Z,1542049566.904 [SBIT](INFO): Beginning SBIT in 28.000000 seconds. 2018-11-12T19:06:06.904Z,1542049566.904 [IBIT](INFO): Initialize IBIT Component. 2018-11-12T19:06:06.905Z,1542049566.905 [CBIT](DEBUG): Initialize CBIT Component. 2018-11-12T19:06:06.905Z,1542049566.905 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2018-11-12T19:06:06.906Z,1542049566.906 [logger ThreadHandler](INFO): Handler Thread ID is 1006 2018-11-12T19:06:06.923Z,1542049566.923 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 1007 2018-11-12T19:06:06.929Z,1542049566.929 [Radio_Surface](INFO): Powering up 2018-11-12T19:06:06.935Z,1542049566.935 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 1008 2018-11-12T19:06:06.947Z,1542049566.947 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 1009 2018-11-12T19:06:06.949Z,1542049566.949 [WetLabsBB2FL](INFO): Powering down 2018-11-12T19:06:06.976Z,1542049566.976 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 1010 2018-11-12T19:06:06.979Z,1542049566.979 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2018-11-12T19:06:06.979Z,1542049566.979 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2018-11-12T19:06:06.980Z,1542049566.980 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2018-11-12T19:06:06.980Z,1542049566.980 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2018-11-12T19:06:06.980Z,1542049566.980 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2018-11-12T19:06:06.980Z,1542049566.980 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2018-11-12T19:06:06.980Z,1542049566.980 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2018-11-12T19:06:06.980Z,1542049566.980 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2018-11-12T19:06:06.981Z,1542049566.981 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2018-11-12T19:06:06.981Z,1542049566.981 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2018-11-12T19:06:06.981Z,1542049566.981 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2018-11-12T19:06:06.981Z,1542049566.981 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2018-11-12T19:06:06.981Z,1542049566.981 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2018-11-12T19:06:06.982Z,1542049566.982 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2018-11-12T19:06:06.982Z,1542049566.982 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2018-11-12T19:06:06.982Z,1542049566.982 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2018-11-12T19:06:07.012Z,1542049567.012 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2018-11-12T19:06:07.024Z,1542049567.024 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2018-11-12T19:06:07.051Z,1542049567.051 [MissionManager](DEBUG): 2018-11-12T19:06:07.052Z,1542049567.052 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2018-11-12T19:06:07.127Z,1542049567.127 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2018-11-12T19:06:07.128Z,1542049567.128 [Default:A.Wait](DEBUG): Construct Wait. 2018-11-12T19:06:07.130Z,1542049567.130 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2018-11-12T19:06:07.165Z,1542049567.165 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2018-11-12T19:06:07.187Z,1542049567.187 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2018-11-12T19:06:07.193Z,1542049567.193 [Default:E.Execute](DEBUG): Construct Execute. 2018-11-12T19:06:07.213Z,1542049567.213 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2018-11-12T19:06:07.218Z,1542049567.218 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,DVL_micro,NAL9602,Onboard,SCPI,PNI_TCM,BPC1,Aanderaa_O2,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2018-11-12T19:06:07.243Z,1542049567.243 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2018-11-12T19:06:07.267Z,1542049567.267 [Depth_Keller](ERROR): Pressure reading out of range: 1628.471313 decibar 2018-11-12T19:06:07.339Z,1542049567.339 [DVL_micro](INFO): Initializing 2018-11-12T19:06:07.524Z,1542049567.524 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-11-12T19:06:07.743Z,1542049567.743 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:07.751Z,1542049567.751 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-12T19:06:07.765Z,1542049567.765 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:07.771Z,1542049567.771 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-11-12T19:06:07.793Z,1542049567.793 [MassServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:07.799Z,1542049567.799 [MassServo](DEBUG): Initializing MassServo. 2018-11-12T19:06:07.813Z,1542049567.813 [RudderServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:07.819Z,1542049567.819 [RudderServo](DEBUG): Initializing RudderServo. 2018-11-12T19:06:07.827Z,1542049567.827 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:07.835Z,1542049567.835 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-12T19:06:07.992Z,1542049567.992 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2018-11-12T19:06:07.992Z,1542049567.992 [DropWeight] Hardware Fault, FailCount= 1 2018-11-12T19:06:07.992Z,1542049567.992 [DropWeight](ERROR): Hardware Fault 2018-11-12T19:06:08.039Z,1542049568.039 [DepthRateCalculator](ERROR): Depth measurement is not active 2018-11-12T19:06:08.067Z,1542049568.067 [CommandLine](FAULT): Scheduling is paused 2018-11-12T19:06:08.068Z,1542049568.068 [CBIT](INFO): Critical error at 20181112T190607 2018-11-12T19:06:08.068Z,1542049568.068 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2018-11-12T19:06:08.070Z,1542049568.070 [CBIT](ERROR): Hardware Fault in component: DropWeight 2018-11-12T19:06:08.083Z,1542049568.083 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2018-11-12T19:06:08.695Z,1542049568.695 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-12T19:06:08.695Z,1542049568.695 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-12T19:06:08.695Z,1542049568.695 [BuoyancyServo] Communications Fault, FailCount= 1 2018-11-12T19:06:08.695Z,1542049568.695 [BuoyancyServo](ERROR): Communications Fault 2018-11-12T19:06:09.007Z,1542049569.007 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2018-11-12T19:06:09.007Z,1542049569.007 [ElevatorServo](FAULT): Elevator failed to initialize 2018-11-12T19:06:09.007Z,1542049569.007 [ElevatorServo] Communications Fault, FailCount= 1 2018-11-12T19:06:09.007Z,1542049569.007 [ElevatorServo](ERROR): Communications Fault 2018-11-12T19:06:09.315Z,1542049569.315 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2018-11-12T19:06:09.315Z,1542049569.315 [RudderServo](FAULT): Rudder failed to initialize 2018-11-12T19:06:09.315Z,1542049569.315 [RudderServo] Communications Fault, FailCount= 1 2018-11-12T19:06:09.315Z,1542049569.315 [RudderServo](ERROR): Communications Fault 2018-11-12T19:06:09.639Z,1542049569.639 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-11-12T19:06:09.664Z,1542049569.664 [ThrusterServo](FAULT): Thruster failed to initialize 2018-11-12T19:06:09.664Z,1542049569.664 [ThrusterServo] Communications Fault, FailCount= 1 2018-11-12T19:06:09.665Z,1542049569.665 [ThrusterServo](ERROR): Communications Fault 2018-11-12T19:06:09.674Z,1542049569.674 [CBIT](INFO): Critical error at 20181112T190608 2018-11-12T19:06:09.682Z,1542049569.682 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-12T19:06:09.689Z,1542049569.689 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2018-11-12T19:06:09.690Z,1542049569.690 [CBIT](ERROR): Communications Fault in component: RudderServo 2018-11-12T19:06:09.691Z,1542049569.691 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-11-12T19:06:09.793Z,1542049569.793 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-11-12T19:06:09.793Z,1542049569.793 [BuoyancyServo](INFO): Powering down 2018-11-12T19:06:09.875Z,1542049569.875 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-11-12T19:06:09.875Z,1542049569.875 [ElevatorServo](INFO): Powering down 2018-11-12T19:06:09.932Z,1542049569.932 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-11-12T19:06:09.932Z,1542049569.932 [RudderServo](INFO): Powering down 2018-11-12T19:06:09.983Z,1542049569.983 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-12T19:06:09.983Z,1542049569.983 [ThrusterServo](INFO): Powering down 2018-11-12T19:06:10.573Z,1542049570.573 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:10.692Z,1542049570.692 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-11-12T19:06:10.947Z,1542049570.947 [MassServo](FAULT): Mass initialization uart error:serial timeout 2018-11-12T19:06:10.947Z,1542049570.947 [MassServo] Communications Fault, FailCount= 1 2018-11-12T19:06:10.947Z,1542049570.947 [MassServo](ERROR): Communications Fault 2018-11-12T19:06:10.948Z,1542049570.948 [RudderServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:11.068Z,1542049571.068 [RudderServo](DEBUG): Initializing RudderServo. 2018-11-12T19:06:11.191Z,1542049571.191 [CBIT](INFO): Clearing failed state for component ElevatorServo 2018-11-12T19:06:11.191Z,1542049571.191 [ElevatorServo] No Fault, FailCount= 1 2018-11-12T19:06:11.191Z,1542049571.191 [CBIT](ERROR): Communications Fault in component: MassServo 2018-11-12T19:06:11.192Z,1542049571.192 [CBIT](INFO): Clearing failed state for component RudderServo 2018-11-12T19:06:11.192Z,1542049571.192 [RudderServo] No Fault, FailCount= 1 2018-11-12T19:06:11.192Z,1542049571.192 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-11-12T19:06:11.192Z,1542049571.192 [ThrusterServo] No Fault, FailCount= 1 2018-11-12T19:06:11.587Z,1542049571.587 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2018-11-12T19:06:11.587Z,1542049571.587 [ElevatorServo](FAULT): Elevator failed to initialize 2018-11-12T19:06:11.587Z,1542049571.587 [ElevatorServo] Communications Fault, FailCount= 2 2018-11-12T19:06:11.587Z,1542049571.587 [ElevatorServo](ERROR): Communications Fault 2018-11-12T19:06:11.588Z,1542049571.588 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-11-12T19:06:11.588Z,1542049571.588 [MassServo](INFO): Powering down 2018-11-12T19:06:11.951Z,1542049571.951 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2018-11-12T19:06:11.951Z,1542049571.951 [RudderServo](FAULT): Rudder failed to initialize 2018-11-12T19:06:11.951Z,1542049571.951 [RudderServo] Communications Fault, FailCount= 2 2018-11-12T19:06:11.951Z,1542049571.951 [RudderServo](ERROR): Communications Fault 2018-11-12T19:06:11.952Z,1542049571.952 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:11.959Z,1542049571.959 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-12T19:06:11.964Z,1542049571.964 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2018-11-12T19:06:11.964Z,1542049571.964 [CBIT](ERROR): Communications Fault in component: RudderServo 2018-11-12T19:06:12.050Z,1542049572.050 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-11-12T19:06:12.050Z,1542049572.050 [ElevatorServo](INFO): Powering down 2018-11-12T19:06:12.052Z,1542049572.052 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-11-12T19:06:12.052Z,1542049572.052 [RudderServo](INFO): Powering down 2018-11-12T19:06:12.434Z,1542049572.434 [MassServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:12.553Z,1542049572.553 [MassServo](DEBUG): Initializing MassServo. 2018-11-12T19:06:12.879Z,1542049572.879 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-11-12T19:06:13.199Z,1542049573.199 [ThrusterServo](ERROR): Thruster initialization uart error serial timeout 2018-11-12T19:06:13.199Z,1542049573.199 [ThrusterServo](FAULT): Thruster failed to initialize 2018-11-12T19:06:13.199Z,1542049573.199 [ThrusterServo] Communications Fault, FailCount= 2 2018-11-12T19:06:13.199Z,1542049573.199 [ThrusterServo](ERROR): Communications Fault 2018-11-12T19:06:13.203Z,1542049573.203 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-11-12T19:06:13.204Z,1542049573.204 [BuoyancyServo] No Fault, FailCount= 1 2018-11-12T19:06:13.204Z,1542049573.204 [CBIT](INFO): Clearing failed state for component MassServo 2018-11-12T19:06:13.204Z,1542049573.204 [MassServo] No Fault, FailCount= 1 2018-11-12T19:06:13.204Z,1542049573.204 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-11-12T19:06:13.285Z,1542049573.285 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:13.408Z,1542049573.408 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-12T19:06:13.409Z,1542049573.409 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:13.528Z,1542049573.528 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-11-12T19:06:13.531Z,1542049573.531 [RudderServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:13.652Z,1542049573.652 [RudderServo](DEBUG): Initializing RudderServo. 2018-11-12T19:06:13.653Z,1542049573.653 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-12T19:06:13.653Z,1542049573.653 [ThrusterServo](INFO): Powering down 2018-11-12T19:06:13.658Z,1542049573.658 [CBIT](INFO): Clearing failed state for component ElevatorServo 2018-11-12T19:06:13.658Z,1542049573.658 [ElevatorServo] No Fault, FailCount= 2 2018-11-12T19:06:13.658Z,1542049573.658 [CBIT](INFO): Clearing failed state for component RudderServo 2018-11-12T19:06:13.658Z,1542049573.658 [RudderServo] No Fault, FailCount= 2 2018-11-12T19:06:14.447Z,1542049574.447 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-12T19:06:14.447Z,1542049574.447 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-12T19:06:14.447Z,1542049574.447 [BuoyancyServo] Communications Fault, FailCount= 2 2018-11-12T19:06:14.447Z,1542049574.447 [BuoyancyServo](ERROR): Communications Fault 2018-11-12T19:06:14.759Z,1542049574.759 [ElevatorServo](ERROR): Elevator initialization uart error I:serial timeout 2018-11-12T19:06:14.759Z,1542049574.759 [ElevatorServo](FAULT): Elevator failed to initialize 2018-11-12T19:06:14.759Z,1542049574.759 [ElevatorServo] Communications Fault, FailCount= 3 2018-11-12T19:06:14.759Z,1542049574.759 [ElevatorServo](ERROR): Communications Fault 2018-11-12T19:06:15.071Z,1542049575.071 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2018-11-12T19:06:15.071Z,1542049575.071 [RudderServo](FAULT): Rudder failed to initialize 2018-11-12T19:06:15.071Z,1542049575.071 [RudderServo] Communications Fault, FailCount= 3 2018-11-12T19:06:15.071Z,1542049575.071 [RudderServo](ERROR): Communications Fault 2018-11-12T19:06:15.195Z,1542049575.195 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-12T19:06:15.196Z,1542049575.196 [CBIT](ERROR): Communications Fault in component: ElevatorServo 2018-11-12T19:06:15.196Z,1542049575.196 [CBIT](CRITICAL): Communications Fault in component: ElevatorServo 2018-11-12T19:06:15.196Z,1542049575.196 [CBIT](ERROR): Communications Fault in component: RudderServo 2018-11-12T19:06:15.197Z,1542049575.197 [CBIT](CRITICAL): Communications Fault in component: RudderServo 2018-11-12T19:06:15.197Z,1542049575.197 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-11-12T19:06:15.197Z,1542049575.197 [ThrusterServo] No Fault, FailCount= 2 2018-11-12T19:06:15.252Z,1542049575.252 [PNI_TCM](FAULT): Failed to acquire valid data within timeout. 2018-11-12T19:06:15.252Z,1542049575.252 [PNI_TCM] Data Fault, FailCount= 1 2018-11-12T19:06:15.252Z,1542049575.252 [PNI_TCM](ERROR): Data Fault 2018-11-12T19:06:15.285Z,1542049575.285 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-11-12T19:06:15.286Z,1542049575.286 [BuoyancyServo](INFO): Powering down 2018-11-12T19:06:15.307Z,1542049575.307 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-11-12T19:06:15.307Z,1542049575.307 [ElevatorServo](INFO): Powering down 2018-11-12T19:06:15.563Z,1542049575.563 [MassServo](FAULT): Mass initialization uart error:serial timeout 2018-11-12T19:06:15.563Z,1542049575.563 [MassServo] Communications Fault, FailCount= 2 2018-11-12T19:06:15.563Z,1542049575.563 [MassServo](ERROR): Communications Fault 2018-11-12T19:06:15.564Z,1542049575.564 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-11-12T19:06:15.564Z,1542049575.564 [RudderServo](INFO): Powering down 2018-11-12T19:06:15.565Z,1542049575.565 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:15.576Z,1542049575.576 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-12T19:06:15.578Z,1542049575.578 [CBIT](INFO): Critical error at 20181112T190615 2018-11-12T19:06:15.581Z,1542049575.581 [CBIT](ERROR): Data Fault in component: PNI_TCM 2018-11-12T19:06:15.582Z,1542049575.582 [CBIT](CRITICAL): Data Fault in component: PNI_TCM 2018-11-12T19:06:15.582Z,1542049575.582 [CBIT](ERROR): Communications Fault in component: MassServo 2018-11-12T19:06:15.676Z,1542049575.676 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-11-12T19:06:15.676Z,1542049575.676 [MassServo](INFO): Powering down 2018-11-12T19:06:15.680Z,1542049575.680 [CBIT](INFO): Critical error at 20181112T190615 2018-11-12T19:06:16.037Z,1542049576.037 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:16.156Z,1542049576.156 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-11-12T19:06:16.157Z,1542049576.157 [RudderServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:16.276Z,1542049576.276 [RudderServo](DEBUG): Initializing RudderServo. 2018-11-12T19:06:16.603Z,1542049576.603 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-11-12T19:06:16.628Z,1542049576.628 [ThrusterServo](FAULT): Thruster failed to initialize 2018-11-12T19:06:16.628Z,1542049576.628 [ThrusterServo] Communications Fault, FailCount= 3 2018-11-12T19:06:16.629Z,1542049576.629 [ThrusterServo](ERROR): Communications Fault 2018-11-12T19:06:16.649Z,1542049576.649 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-11-12T19:06:16.727Z,1542049576.727 [MassServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:16.848Z,1542049576.848 [MassServo](DEBUG): Initializing MassServo. 2018-11-12T19:06:16.849Z,1542049576.849 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-12T19:06:16.849Z,1542049576.849 [ThrusterServo](INFO): Powering down 2018-11-12T19:06:16.854Z,1542049576.854 [CBIT](INFO): Clearing failed state for component MassServo 2018-11-12T19:06:16.854Z,1542049576.854 [MassServo] No Fault, FailCount= 2 2018-11-12T19:06:17.635Z,1542049577.635 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-11-12T19:06:17.635Z,1542049577.635 [BuoyancyServo] No Fault, FailCount= 2 2018-11-12T19:06:17.636Z,1542049577.636 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-11-12T19:06:17.636Z,1542049577.636 [ThrusterServo] No Fault, FailCount= 3 2018-11-12T19:06:17.886Z,1542049577.886 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-12T19:06:17.886Z,1542049577.886 [Aanderaa_O2] Communications Fault, FailCount= 1 2018-11-12T19:06:17.886Z,1542049577.886 [Aanderaa_O2](ERROR): Communications Fault 2018-11-12T19:06:17.897Z,1542049577.897 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:18.016Z,1542049578.016 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-12T19:06:18.018Z,1542049578.018 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:18.023Z,1542049578.023 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-12T19:06:18.028Z,1542049578.028 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-12T19:06:48.403Z,1542049608.403 [Aanderaa_O2](INFO): Powering down 2018-11-12T19:06:48.693Z,1542049608.693 [NAL9602](INFO): Powering up NAL9602 2018-11-12T19:06:48.809Z,1542049608.809 [SBIT](IMPORTANT): Beginning Startup BIT 2018-11-12T19:06:48.814Z,1542049608.814 [CBIT](IMPORTANT): Beginning ground fault scan 2018-11-12T19:06:49.147Z,1542049609.147 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-11-12T19:06:49.147Z,1542049609.147 [Aanderaa_O2] No Fault, FailCount= 1 2018-11-12T19:06:50.279Z,1542049610.279 [MassServo](ERROR): getPosition uart error serial timeout 2018-11-12T19:06:50.280Z,1542049610.280 [MassServo](FAULT): Invalid EZ Servo response:"" 2018-11-12T19:06:50.280Z,1542049610.280 [MassServo] Communications Fault, FailCount= 3 2018-11-12T19:06:50.280Z,1542049610.280 [MassServo](ERROR): Communications Fault 2018-11-12T19:06:50.285Z,1542049610.285 [CBIT](ERROR): Communications Fault in component: MassServo 2018-11-12T19:06:50.771Z,1542049610.771 [BuoyancyServo](FAULT): Buoyancy initialization uart error:serial timeout 2018-11-12T19:06:50.771Z,1542049610.771 [BuoyancyServo] Communications Fault, FailCount= 3 2018-11-12T19:06:50.771Z,1542049610.771 [BuoyancyServo](ERROR): Communications Fault 2018-11-12T19:06:50.772Z,1542049610.772 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-11-12T19:06:50.772Z,1542049610.772 [MassServo](INFO): Powering down 2018-11-12T19:06:51.079Z,1542049611.079 [ThrusterServo](FAULT): Thruster initialization uart error:serial timeout 2018-11-12T19:06:51.079Z,1542049611.079 [ThrusterServo] Communications Fault, FailCount= 4 2018-11-12T19:06:51.079Z,1542049611.079 [ThrusterServo](ERROR): Communications Fault 2018-11-12T19:06:51.084Z,1542049611.084 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-12T19:06:51.084Z,1542049611.084 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-11-12T19:06:51.193Z,1542049611.193 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-11-12T19:06:51.194Z,1542049611.194 [BuoyancyServo](INFO): Powering down 2018-11-12T19:06:51.216Z,1542049611.216 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-12T19:06:51.216Z,1542049611.216 [ThrusterServo](INFO): Powering down 2018-11-12T19:06:51.551Z,1542049611.551 [MassServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:51.673Z,1542049611.673 [MassServo](DEBUG): Initializing MassServo. 2018-11-12T19:06:51.679Z,1542049611.679 [CBIT](INFO): Clearing failed state for component MassServo 2018-11-12T19:06:51.679Z,1542049611.679 [MassServo] No Fault, FailCount= 3 2018-11-12T19:06:52.068Z,1542049612.068 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-11-12T19:06:52.068Z,1542049612.068 [ThrusterServo] No Fault, FailCount= 4 2018-11-12T19:06:52.364Z,1542049612.364 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:52.387Z,1542049612.387 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-12T19:06:53.451Z,1542049613.451 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-11-12T19:06:53.511Z,1542049613.511 [ThrusterServo](FAULT): Thruster failed to initialize 2018-11-12T19:06:53.511Z,1542049613.511 [ThrusterServo] Communications Fault, FailCount= 5 2018-11-12T19:06:53.511Z,1542049613.511 [ThrusterServo](ERROR): Communications Fault 2018-11-12T19:06:53.516Z,1542049613.516 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-11-12T19:06:53.516Z,1542049613.516 [BuoyancyServo] No Fault, FailCount= 3 2018-11-12T19:06:53.516Z,1542049613.516 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-11-12T19:06:53.517Z,1542049613.517 [CBIT](CRITICAL): Communications Fault in component: ThrusterServo 2018-11-12T19:06:53.670Z,1542049613.670 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:53.788Z,1542049613.788 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-12T19:06:53.790Z,1542049613.790 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-12T19:06:53.790Z,1542049613.790 [ThrusterServo](INFO): Powering down 2018-11-12T19:06:53.793Z,1542049613.793 [CBIT](INFO): Critical error at 20181112T190653 2018-11-12T19:06:54.299Z,1542049614.299 [MassServo](FAULT): Mass initialization uart error:serial timeout 2018-11-12T19:06:54.299Z,1542049614.299 [MassServo] Communications Fault, FailCount= 4 2018-11-12T19:06:54.299Z,1542049614.299 [MassServo](ERROR): Communications Fault 2018-11-12T19:06:54.304Z,1542049614.304 [CBIT](ERROR): Communications Fault in component: MassServo 2018-11-12T19:06:54.803Z,1542049614.803 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-12T19:06:54.803Z,1542049614.803 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-12T19:06:54.803Z,1542049614.803 [BuoyancyServo] Communications Fault, FailCount= 4 2018-11-12T19:06:54.803Z,1542049614.803 [BuoyancyServo](ERROR): Communications Fault 2018-11-12T19:06:54.804Z,1542049614.804 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-11-12T19:06:54.804Z,1542049614.804 [MassServo](INFO): Powering down 2018-11-12T19:06:54.934Z,1542049614.934 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-12T19:06:55.099Z,1542049615.099 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-11-12T19:06:55.101Z,1542049615.101 [BuoyancyServo](INFO): Powering down 2018-11-12T19:06:55.473Z,1542049615.473 [MassServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:55.588Z,1542049615.588 [MassServo](DEBUG): Initializing MassServo. 2018-11-12T19:06:55.593Z,1542049615.593 [CBIT](INFO): Clearing failed state for component MassServo 2018-11-12T19:06:55.593Z,1542049615.593 [MassServo] No Fault, FailCount= 4 2018-11-12T19:06:57.071Z,1542049617.071 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-11-12T19:06:57.071Z,1542049617.071 [BuoyancyServo] No Fault, FailCount= 4 2018-11-12T19:06:57.474Z,1542049617.474 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:57.588Z,1542049617.588 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-12T19:06:58.127Z,1542049618.127 [MassServo](FAULT): Mass initialization uart error:serial timeout 2018-11-12T19:06:58.127Z,1542049618.127 [MassServo] Communications Fault, FailCount= 5 2018-11-12T19:06:58.127Z,1542049618.127 [MassServo](ERROR): Communications Fault 2018-11-12T19:06:58.132Z,1542049618.132 [CBIT](ERROR): Communications Fault in component: MassServo 2018-11-12T19:06:58.132Z,1542049618.132 [CBIT](CRITICAL): Communications Fault in component: MassServo 2018-11-12T19:06:58.595Z,1542049618.595 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-12T19:06:58.595Z,1542049618.595 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-12T19:06:58.595Z,1542049618.595 [BuoyancyServo] Communications Fault, FailCount= 5 2018-11-12T19:06:58.595Z,1542049618.595 [BuoyancyServo](ERROR): Communications Fault 2018-11-12T19:06:58.615Z,1542049618.615 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-11-12T19:06:58.615Z,1542049618.615 [MassServo](INFO): Powering down 2018-11-12T19:06:58.618Z,1542049618.618 [CBIT](INFO): Critical error at 20181112T190658 2018-11-12T19:06:58.621Z,1542049618.621 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-12T19:06:58.696Z,1542049618.696 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-11-12T19:06:58.698Z,1542049618.698 [BuoyancyServo](INFO): Powering down 2018-11-12T19:06:59.075Z,1542049619.075 [MassServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:06:59.192Z,1542049619.192 [MassServo](DEBUG): Initializing MassServo. 2018-11-12T19:06:59.837Z,1542049619.837 [NAL9602](INFO): NAL9602 initialized 2018-11-12T19:06:59.854Z,1542049619.854 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 2018-11-12T19:06:59.854Z,1542049619.854 [Aanderaa_O2] Communications Fault, FailCount= 2 2018-11-12T19:06:59.854Z,1542049619.854 [Aanderaa_O2](ERROR): Communications Fault 2018-11-12T19:06:59.902Z,1542049619.902 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 2018-11-12T19:07:27.236Z,1542049647.236 [CommandLine](IMPORTANT): got command failComponent 2018-11-12T19:07:27.236Z,1542049647.236 [CommandLine](IMPORTANT): Failed components: 2018-11-12T19:07:27.236Z,1542049647.236 [CommandLine](IMPORTANT): DropWeight: Hardware Fault 2018-11-12T19:07:27.237Z,1542049647.237 [CommandLine](IMPORTANT): PNI_TCM: Data Fault 2018-11-12T19:07:27.237Z,1542049647.237 [CommandLine](IMPORTANT): Aanderaa_O2: Communications Fault 2018-11-12T19:07:27.237Z,1542049647.237 [CommandLine](IMPORTANT): BuoyancyServo: Communications Fault 2018-11-12T19:07:27.237Z,1542049647.237 [CommandLine](IMPORTANT): ElevatorServo: Communications Fault 2018-11-12T19:07:27.238Z,1542049647.238 [CommandLine](IMPORTANT): MassServo: Communications Fault 2018-11-12T19:07:27.238Z,1542049647.238 [CommandLine](IMPORTANT): RudderServo: Communications Fault 2018-11-12T19:07:27.238Z,1542049647.238 [CommandLine](IMPORTANT): ThrusterServo: Communications Fault 2018-11-12T19:07:30.407Z,1542049650.407 [Aanderaa_O2](INFO): Powering down 2018-11-12T19:07:30.437Z,1542049650.437 [SBIT](ERROR): Could not read elevatorAngleReader_. 2018-11-12T19:07:30.437Z,1542049650.437 [SBIT](ERROR): Could not read rudderAngleReader_. 2018-11-12T19:07:30.437Z,1542049650.437 [SBIT](ERROR): Could not read massPosReader_. 2018-11-12T19:07:30.441Z,1542049650.441 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-11-12T19:07:30.441Z,1542049650.441 [ThrusterServo] No Fault, FailCount= 5 2018-11-12T19:07:30.445Z,1542049650.445 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.020088 CHAN A1 (24V): 0.001379 CHAN A2 (12V): -0.005197 CHAN A3 (5V): -0.002895 CHAN B0 (3.3V): -0.000749 CHAN B1 (3.15aV): -0.001658 CHAN B2 (3.15bV): -0.001082 CHAN B3 (GND): -0.000182 OPEN: -0.001351 Full Scale Calc: 4.765 mA, -1.589 mA 2018-11-12T19:07:30.573Z,1542049650.573 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:07:30.592Z,1542049650.592 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-12T19:07:30.598Z,1542049650.598 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-11-12T19:07:30.598Z,1542049650.598 [BuoyancyServo] No Fault, FailCount= 5 2018-11-12T19:07:30.958Z,1542049650.958 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:07:31.076Z,1542049651.076 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-12T19:07:31.081Z,1542049651.081 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 2018-11-12T19:07:31.081Z,1542049651.081 [Aanderaa_O2] No Fault, FailCount= 2 2018-11-12T19:07:32.051Z,1542049652.051 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-12T19:07:32.051Z,1542049652.051 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-12T19:07:32.051Z,1542049652.051 [BuoyancyServo] Communications Fault, FailCount= 6 2018-11-12T19:07:32.051Z,1542049652.051 [BuoyancyServo](ERROR): Communications Fault 2018-11-12T19:07:32.056Z,1542049652.056 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-12T19:07:32.146Z,1542049652.146 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-11-12T19:07:32.147Z,1542049652.147 [BuoyancyServo](INFO): Powering down 2018-11-12T19:07:33.235Z,1542049653.235 [ThrusterServo](FAULT): Thruster initialization uart error:serial timeout 2018-11-12T19:07:33.235Z,1542049653.235 [ThrusterServo] Communications Fault, FailCount= 1 2018-11-12T19:07:33.235Z,1542049653.235 [ThrusterServo](ERROR): Communications Fault 2018-11-12T19:07:33.242Z,1542049653.242 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-11-12T19:07:33.344Z,1542049653.344 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-12T19:07:33.344Z,1542049653.344 [ThrusterServo](INFO): Powering down 2018-11-12T19:07:34.234Z,1542049654.234 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-11-12T19:07:34.234Z,1542049654.234 [BuoyancyServo] No Fault, FailCount= 6 2018-11-12T19:07:34.235Z,1542049654.235 [CBIT](INFO): Clearing failed state for component ThrusterServo 2018-11-12T19:07:34.235Z,1542049654.235 [ThrusterServo] No Fault, FailCount= 1 2018-11-12T19:07:34.509Z,1542049654.509 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:07:34.624Z,1542049654.624 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-12T19:07:34.625Z,1542049654.625 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-12T19:07:34.626Z,1542049654.626 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-12T19:07:34.708Z,1542049654.708 [CommandLine](IMPORTANT): got command restart application 2018-11-12T19:07:35.635Z,1542049655.635 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-12T19:07:35.635Z,1542049655.635 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-12T19:07:35.635Z,1542049655.635 [BuoyancyServo] Communications Fault, FailCount= 7 2018-11-12T19:07:35.635Z,1542049655.635 [BuoyancyServo](ERROR): Communications Fault 2018-11-12T19:07:35.714Z,1542049655.714 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-12T19:07:35.714Z,1542049655.714 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-11-12T19:07:35.803Z,1542049655.803 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2018-11-12T19:07:35.803Z,1542049655.803 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-11-12T19:07:35.804Z,1542049655.804 [CommandLine](INFO): Join timeout helper Thread ID is 1042 2018-11-12T19:07:35.804Z,1542049655.804 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2018-11-12T19:07:35.804Z,1542049655.804 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-11-12T19:07:35.805Z,1542049655.805 [NavChartDb](INFO): Join timeout helper Thread ID is 1043 2018-11-12T19:07:35.955Z,1542049655.955 [ThrusterServo](ERROR): Thruster halt for initialization uart error serial timeout 2018-11-12T19:07:35.972Z,1542049655.972 [ThrusterServo](FAULT): Thruster failed to initialize 2018-11-12T19:07:35.972Z,1542049655.972 [ThrusterServo] Communications Fault, FailCount= 2 2018-11-12T19:07:35.973Z,1542049655.973 [ThrusterServo](ERROR): Communications Fault 2018-11-12T19:07:36.004Z,1542049656.004 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-12T19:07:36.006Z,1542049656.006 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-11-12T19:07:36.008Z,1542049656.008 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2018-11-12T19:07:36.008Z,1542049656.008 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-11-12T19:07:36.009Z,1542049656.009 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1044 2018-11-12T19:07:36.015Z,1542049656.015 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-12T19:07:36.016Z,1542049656.016 [CBIT](ERROR): Communications Fault in component: ThrusterServo 2018-11-12T19:07:36.073Z,1542049656.073 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-11-12T19:07:36.074Z,1542049656.074 [BuoyancyServo](INFO): Powering down 2018-11-12T19:07:36.091Z,1542049656.091 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-12T19:07:36.091Z,1542049656.091 [ThrusterServo](INFO): Powering down 2018-11-12T19:07:36.219Z,1542049656.219 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-12T19:07:36.219Z,1542049656.219 [WetLabsBB2FL](INFO): Powering down 2018-11-12T19:07:36.220Z,1542049656.220 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-11-12T19:07:36.223Z,1542049656.223 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler 2018-11-12T19:07:36.223Z,1542049656.223 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2018-11-12T19:07:36.223Z,1542049656.223 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 1045 2018-11-12T19:07:36.311Z,1542049656.311 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-12T19:07:36.312Z,1542049656.312 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2018-11-12T19:07:36.323Z,1542049656.323 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2018-11-12T19:07:36.323Z,1542049656.323 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-11-12T19:07:36.324Z,1542049656.324 [Radio_Surface](INFO): Join timeout helper Thread ID is 1046