2018-11-19T22:50:06.394Z,1542667806.394 [Supervisor](DEBUG): Initializing supervisor. 2018-11-19T22:50:06.397Z,1542667806.397 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2018-11-19T22:50:06.398Z,1542667806.398 [SyncHandler](INFO): Protected caller Thread ID is 800 2018-11-19T22:50:06.398Z,1542667806.398 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2018-11-19T22:50:06.399Z,1542667806.399 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2018-11-19T22:50:06.399Z,1542667806.399 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 801 2018-11-19T22:50:06.402Z,1542667806.402 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2018-11-19T22:50:06.414Z,1542667806.414 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2018-11-19T22:50:06.415Z,1542667806.415 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2018-11-19T22:50:06.415Z,1542667806.415 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 802 2018-11-19T22:50:06.416Z,1542667806.416 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2018-11-19T22:50:06.417Z,1542667806.417 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2018-11-19T22:50:06.417Z,1542667806.417 [logger ThreadHandler](INFO): Protected caller Thread ID is 803 2018-11-19T22:50:06.419Z,1542667806.419 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2018-11-19T22:50:06.419Z,1542667806.419 [Supervisor](INFO): Looking for Config files in directory: Config/ 2018-11-19T22:50:06.422Z,1542667806.422 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2018-11-19T22:50:06.850Z,1542667806.850 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2018-11-19T22:50:06.852Z,1542667806.852 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2018-11-19T22:50:07.290Z,1542667807.290 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2018-11-19T22:50:07.290Z,1542667807.290 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2018-11-19T22:50:07.482Z,1542667807.482 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2018-11-19T22:50:07.484Z,1542667807.484 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2018-11-19T22:50:07.629Z,1542667807.629 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2018-11-19T22:50:07.629Z,1542667807.629 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2018-11-19T22:50:08.060Z,1542667808.060 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2018-11-19T22:50:08.061Z,1542667808.061 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2018-11-19T22:50:08.157Z,1542667808.157 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2018-11-19T22:50:08.158Z,1542667808.158 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2018-11-19T22:50:08.298Z,1542667808.298 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2018-11-19T22:50:08.299Z,1542667808.299 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2018-11-19T22:50:08.400Z,1542667808.400 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample 2018-11-19T22:50:08.400Z,1542667808.400 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2018-11-19T22:50:08.504Z,1542667808.504 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2018-11-19T22:50:08.504Z,1542667808.504 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2018-11-19T22:50:08.844Z,1542667808.844 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2018-11-19T22:50:08.844Z,1542667808.844 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2018-11-19T22:50:09.041Z,1542667809.041 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2018-11-19T22:50:09.041Z,1542667809.041 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2018-11-19T22:50:09.251Z,1542667809.251 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2018-11-19T22:50:09.252Z,1542667809.252 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2018-11-19T22:50:09.334Z,1542667809.334 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2018-11-19T22:50:09.683Z,1542667809.683 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2018-11-19T22:50:09.683Z,1542667809.683 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2018-11-19T22:50:09.000Z,1542667810.000 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2018-11-19T22:50:10.002Z,1542667810.002 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2018-11-19T22:50:10.962Z,1542667810.962 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2018-11-19T22:50:11.048Z,1542667811.048 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2018-11-19T22:50:11.199Z,1542667811.199 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2018-11-19T22:50:11.299Z,1542667811.299 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2018-11-19T22:50:11.469Z,1542667811.469 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2018-11-19T22:50:11.553Z,1542667811.553 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2018-11-19T22:50:11.781Z,1542667811.781 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2018-11-19T22:50:11.781Z,1542667811.781 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2018-11-19T22:50:11.925Z,1542667811.925 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2018-11-19T22:50:12.079Z,1542667812.079 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2018-11-19T22:50:12.176Z,1542667812.176 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2018-11-19T22:50:12.280Z,1542667812.280 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2018-11-19T22:50:12.391Z,1542667812.391 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2018-11-19T22:50:12.398Z,1542667812.398 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2018-11-19T22:50:12.455Z,1542667812.455 [DepthRateCalculator] Loaded 2018-11-19T22:50:12.455Z,1542667812.455 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2018-11-19T22:50:12.461Z,1542667812.461 [PitchRateCalculator] Loaded 2018-11-19T22:50:12.461Z,1542667812.461 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2018-11-19T22:50:12.477Z,1542667812.477 [SpeedCalculator] Loaded 2018-11-19T22:50:12.477Z,1542667812.477 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2018-11-19T22:50:12.497Z,1542667812.497 [TempGradientCalculator] Loaded 2018-11-19T22:50:12.498Z,1542667812.498 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2018-11-19T22:50:12.503Z,1542667812.503 [YawRateCalculator] Loaded 2018-11-19T22:50:12.503Z,1542667812.503 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2018-11-19T22:50:12.543Z,1542667812.543 [ElevatorOffsetCalculator] Loaded 2018-11-19T22:50:12.543Z,1542667812.543 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2018-11-19T22:50:12.543Z,1542667812.543 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2018-11-19T22:50:12.544Z,1542667812.544 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2018-11-19T22:50:12.821Z,1542667812.821 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2018-11-19T22:50:12.822Z,1542667812.822 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2018-11-19T22:50:13.398Z,1542667813.398 [DataOverHttps] Loaded 2018-11-19T22:50:13.398Z,1542667813.398 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread. 2018-11-19T22:50:13.436Z,1542667813.436 [Depth_Keller] Loaded 2018-11-19T22:50:13.436Z,1542667813.436 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2018-11-19T22:50:13.441Z,1542667813.441 [DropWeight] Loaded 2018-11-19T22:50:13.441Z,1542667813.441 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2018-11-19T22:50:13.537Z,1542667813.537 [NAL9602] Loaded 2018-11-19T22:50:13.538Z,1542667813.538 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2018-11-19T22:50:13.554Z,1542667813.554 [Onboard] Loaded 2018-11-19T22:50:13.554Z,1542667813.554 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread. 2018-11-19T22:50:13.564Z,1542667813.564 [Radio_Surface] Loaded 2018-11-19T22:50:13.564Z,1542667813.564 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2018-11-19T22:50:13.565Z,1542667813.565 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407C34E0 2018-11-19T22:50:13.565Z,1542667813.565 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 883 2018-11-19T22:50:15.323Z,1542667815.323 [BPC1] Loaded 2018-11-19T22:50:15.323Z,1542667815.323 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2018-11-19T22:50:15.323Z,1542667815.323 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2018-11-19T22:50:15.324Z,1542667815.324 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2018-11-19T22:50:15.810Z,1542667815.810 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2018-11-19T22:50:15.811Z,1542667815.811 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2018-11-19T22:50:15.921Z,1542667815.921 [DeadReckonUsingMultipleVelocitySources] Loaded 2018-11-19T22:50:15.922Z,1542667815.922 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2018-11-19T22:50:15.975Z,1542667815.975 [DeadReckonUsingSpeedCalculator] Loaded 2018-11-19T22:50:15.976Z,1542667815.976 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2018-11-19T22:50:15.992Z,1542667815.992 [NavChart] Loaded 2018-11-19T22:50:15.992Z,1542667815.992 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2018-11-19T22:50:15.996Z,1542667815.996 [UniversalFixResidualReporter] Loaded 2018-11-19T22:50:15.996Z,1542667815.996 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2018-11-19T22:50:15.997Z,1542667815.997 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2018-11-19T22:50:15.998Z,1542667815.998 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2018-11-19T22:50:16.269Z,1542667816.269 [CTD_NeilBrown] Loaded 2018-11-19T22:50:16.269Z,1542667816.269 [ComponentRegistry](DEBUG): Component "CTD_NeilBrown" handled in its own thread. 2018-11-19T22:50:16.270Z,1542667816.270 [CTD_NeilBrown ThreadHandler](DEBUG): Created PCaller Thread at 408CF4E0 2018-11-19T22:50:16.270Z,1542667816.270 [CTD_NeilBrown ThreadHandler](INFO): Protected caller Thread ID is 884 2018-11-19T22:50:16.326Z,1542667816.326 [CTD_Seabird] Loaded 2018-11-19T22:50:16.326Z,1542667816.326 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2018-11-19T22:50:16.327Z,1542667816.327 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 408FF4E0 2018-11-19T22:50:16.328Z,1542667816.328 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 885 2018-11-19T22:50:16.376Z,1542667816.376 [WetLabsBB2FL] Loaded 2018-11-19T22:50:16.376Z,1542667816.376 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2018-11-19T22:50:16.377Z,1542667816.377 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4092F4E0 2018-11-19T22:50:16.378Z,1542667816.378 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 886 2018-11-19T22:50:16.378Z,1542667816.378 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2018-11-19T22:50:16.379Z,1542667816.379 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2018-11-19T22:50:16.466Z,1542667816.466 [VerticalControl](DEBUG): Construct VerticalControl. 2018-11-19T22:50:16.563Z,1542667816.563 [VerticalControl] Loaded 2018-11-19T22:50:16.564Z,1542667816.564 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2018-11-19T22:50:16.564Z,1542667816.564 [HorizontalControl](DEBUG): Construct HorizontalControl. 2018-11-19T22:50:16.632Z,1542667816.632 [HorizontalControl] Loaded 2018-11-19T22:50:16.632Z,1542667816.632 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2018-11-19T22:50:16.632Z,1542667816.632 [SpeedControl](DEBUG): Construct SpeedControl. 2018-11-19T22:50:16.638Z,1542667816.638 [SpeedControl] Loaded 2018-11-19T22:50:16.638Z,1542667816.638 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2018-11-19T22:50:16.639Z,1542667816.639 [LoopControl](DEBUG): Construct LoopControl. 2018-11-19T22:50:16.639Z,1542667816.639 [LoopControl] Loaded 2018-11-19T22:50:16.639Z,1542667816.639 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2018-11-19T22:50:16.640Z,1542667816.640 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2018-11-19T22:50:16.640Z,1542667816.640 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2018-11-19T22:50:16.664Z,1542667816.664 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2018-11-19T22:50:16.666Z,1542667816.666 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2018-11-19T22:50:16.826Z,1542667816.826 [SBIT](DEBUG): Construct Startup Built In Test. 2018-11-19T22:50:16.837Z,1542667816.837 [SBIT] Loaded 2018-11-19T22:50:16.838Z,1542667816.838 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2018-11-19T22:50:16.838Z,1542667816.838 [IBIT](DEBUG): Construct Initiated Built In Test. 2018-11-19T22:50:16.850Z,1542667816.850 [IBIT] Loaded 2018-11-19T22:50:16.850Z,1542667816.850 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2018-11-19T22:50:16.853Z,1542667816.853 [CBIT](DEBUG): Construct Continuous Built In Test. 2018-11-19T22:50:16.991Z,1542667816.991 [CBIT] Loaded 2018-11-19T22:50:16.991Z,1542667816.991 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2018-11-19T22:50:16.992Z,1542667816.992 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2018-11-19T22:50:16.992Z,1542667816.992 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2018-11-19T22:50:17.119Z,1542667817.119 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2018-11-19T22:50:17.120Z,1542667817.120 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2018-11-19T22:50:17.157Z,1542667817.157 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2018-11-19T22:50:17.158Z,1542667817.158 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2018-11-19T22:50:17.275Z,1542667817.275 [BuoyancyServo] Loaded 2018-11-19T22:50:17.276Z,1542667817.276 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2018-11-19T22:50:17.287Z,1542667817.287 [ElevatorServo] Loaded 2018-11-19T22:50:17.288Z,1542667817.288 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2018-11-19T22:50:17.298Z,1542667817.298 [MassServo] Loaded 2018-11-19T22:50:17.299Z,1542667817.299 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2018-11-19T22:50:17.310Z,1542667817.310 [RudderServo] Loaded 2018-11-19T22:50:17.310Z,1542667817.310 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2018-11-19T22:50:17.320Z,1542667817.320 [ThrusterServo] Loaded 2018-11-19T22:50:17.321Z,1542667817.321 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2018-11-19T22:50:17.321Z,1542667817.321 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2018-11-19T22:50:17.325Z,1542667817.325 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2018-11-19T22:50:17.326Z,1542667817.326 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2018-11-19T22:50:17.332Z,1542667817.332 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2018-11-19T22:50:17.333Z,1542667817.333 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A504E0 2018-11-19T22:50:17.334Z,1542667817.334 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 887 2018-11-19T22:50:17.338Z,1542667817.338 [Supervisor](INFO): Main Thread ID is 796 2018-11-19T22:50:17.338Z,1542667817.338 [Supervisor](DEBUG): Running supervisor. 2018-11-19T22:50:17.339Z,1542667817.339 [CommandLine ThreadHandler](INFO): Handler Thread ID is 888 2018-11-19T22:50:17.341Z,1542667817.341 [controlThread ThreadHandler](INFO): Handler Thread ID is 889 2018-11-19T22:50:17.342Z,1542667817.342 [controlThread](DEBUG): Initializing ControlThread 2018-11-19T22:50:17.342Z,1542667817.342 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2018-11-19T22:50:17.343Z,1542667817.343 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2018-11-19T22:50:17.343Z,1542667817.343 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2018-11-19T22:50:17.343Z,1542667817.343 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2018-11-19T22:50:17.344Z,1542667817.344 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2018-11-19T22:50:17.344Z,1542667817.344 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2018-11-19T22:50:17.351Z,1542667817.351 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T22:50:17.352Z,1542667817.352 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T22:50:17.352Z,1542667817.352 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T22:50:17.353Z,1542667817.353 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T22:50:17.354Z,1542667817.354 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T22:50:17.354Z,1542667817.354 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T22:50:17.354Z,1542667817.354 [NavChart](DEBUG): Initialize NavChart Navigation. 2018-11-19T22:50:17.355Z,1542667817.355 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2018-11-19T22:50:17.355Z,1542667817.355 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2018-11-19T22:50:17.357Z,1542667817.357 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2018-11-19T22:50:17.358Z,1542667817.358 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2018-11-19T22:50:17.358Z,1542667817.358 [LoopControl](DEBUG): Initialize LoopControlComponent. 2018-11-19T22:50:17.358Z,1542667817.358 [SBIT](INFO): Initialize SBIT Component. 2018-11-19T22:50:17.359Z,1542667817.359 [SBIT](IMPORTANT): git: 2018-11-05-13-g48bc2da 2018-11-19T22:50:17.359Z,1542667817.359 [SBIT](INFO): git hash: 48bc2da44dc0d2c556ca6b44896fde16a8a550cc 2018-11-19T22:50:17.359Z,1542667817.359 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2018-11-19T22:50:17.360Z,1542667817.360 [SBIT](IMPORTANT): Kernel Version:#2 PREEMPT Thu Jan 11 20:13:48 PST 2018 2018-11-19T22:50:17.361Z,1542667817.361 [SBIT](INFO): Beginning SBIT in 28.000000 seconds. 2018-11-19T22:50:17.361Z,1542667817.361 [IBIT](INFO): Initialize IBIT Component. 2018-11-19T22:50:17.362Z,1542667817.362 [CBIT](DEBUG): Initialize CBIT Component. 2018-11-19T22:50:17.363Z,1542667817.363 [logger ThreadHandler](INFO): Handler Thread ID is 890 2018-11-19T22:50:17.373Z,1542667817.373 [CBIT](DEBUG): Initialized mux pins. 2018-11-19T22:50:17.373Z,1542667817.373 [CBIT](DEBUG): Initializing the watchdog timer. 2018-11-19T22:50:17.381Z,1542667817.381 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 891 2018-11-19T22:50:17.387Z,1542667817.387 [Radio_Surface](INFO): Powering up 2018-11-19T22:50:17.393Z,1542667817.393 [CTD_NeilBrown ThreadHandler](INFO): Handler Thread ID is 892 2018-11-19T22:50:17.401Z,1542667817.401 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2018-11-19T22:50:17.401Z,1542667817.401 [CBIT](DEBUG): Initializing heartbeat. 2018-11-19T22:50:17.402Z,1542667817.402 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 893 2018-11-19T22:50:17.402Z,1542667817.402 [CTD_Seabird](INFO): Initializing 2018-11-19T22:50:17.403Z,1542667817.403 [CTD_Seabird](INFO): Checking LCM 2018-11-19T22:50:17.473Z,1542667817.473 [CBIT](DEBUG): Deactivating GF circuits. 2018-11-19T22:50:17.473Z,1542667817.473 [CBIT](DEBUG): Deactivating emergency mode. 2018-11-19T22:50:17.511Z,1542667817.511 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2018-11-19T22:50:17.518Z,1542667817.518 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 894 2018-11-19T22:50:17.519Z,1542667817.519 [WetLabsBB2FL](INFO): Powering down 2018-11-19T22:50:17.545Z,1542667817.545 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 895 2018-11-19T22:50:17.627Z,1542667817.627 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2018-11-19T22:50:17.661Z,1542667817.661 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2018-11-19T22:50:17.661Z,1542667817.661 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2018-11-19T22:50:17.661Z,1542667817.661 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2018-11-19T22:50:17.661Z,1542667817.661 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2018-11-19T22:50:17.662Z,1542667817.662 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2018-11-19T22:50:17.662Z,1542667817.662 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2018-11-19T22:50:17.662Z,1542667817.662 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2018-11-19T22:50:17.662Z,1542667817.662 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2018-11-19T22:50:17.662Z,1542667817.662 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2018-11-19T22:50:17.662Z,1542667817.662 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2018-11-19T22:50:17.663Z,1542667817.663 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2018-11-19T22:50:17.663Z,1542667817.663 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2018-11-19T22:50:17.663Z,1542667817.663 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2018-11-19T22:50:17.663Z,1542667817.663 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2018-11-19T22:50:17.663Z,1542667817.663 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2018-11-19T22:50:17.664Z,1542667817.664 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2018-11-19T22:50:17.752Z,1542667817.752 [MissionManager](DEBUG): 2018-11-19T22:50:17.755Z,1542667817.755 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2018-11-19T22:50:17.908Z,1542667817.908 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2018-11-19T22:50:17.909Z,1542667817.909 [Default:A.Wait](DEBUG): Construct Wait. 2018-11-19T22:50:17.911Z,1542667817.911 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2018-11-19T22:50:17.924Z,1542667817.924 [CTD_Seabird](INFO): LCM OK 2018-11-19T22:50:17.925Z,1542667817.925 [CTD_Seabird](INFO): Powering up 2018-11-19T22:50:17.957Z,1542667817.957 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2018-11-19T22:50:17.960Z,1542667817.960 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2018-11-19T22:50:17.994Z,1542667817.994 [Default:E.Execute](DEBUG): Construct Execute. 2018-11-19T22:50:18.014Z,1542667818.014 [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-19T22:50:18.018Z,1542667818.018 [controlThread](DEBUG): Component order: CycleStarter,DataOverHttps,Depth_Keller,DropWeight,NAL9602,Onboard,BPC1,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-19T22:50:18.040Z,1542667818.040 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2018-11-19T22:50:18.749Z,1542667818.749 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-19T22:50:18.757Z,1542667818.757 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-19T22:50:18.771Z,1542667818.771 [ElevatorServo](DEBUG): Initializing EZServoServo. 2018-11-19T22:50:18.777Z,1542667818.777 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2018-11-19T22:50:18.799Z,1542667818.799 [MassServo](DEBUG): Initializing EZServoServo. 2018-11-19T22:50:18.805Z,1542667818.805 [MassServo](DEBUG): Initializing MassServo. 2018-11-19T22:50:18.811Z,1542667818.811 [RudderServo](DEBUG): Initializing EZServoServo. 2018-11-19T22:50:18.817Z,1542667818.817 [RudderServo](DEBUG): Initializing RudderServo. 2018-11-19T22:50:18.823Z,1542667818.823 [ThrusterServo](DEBUG): Initializing EZServoServo. 2018-11-19T22:50:18.829Z,1542667818.829 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2018-11-19T22:50:18.981Z,1542667818.981 [Depth_Keller](ERROR): Pressure reading out of range: 1628.471313 decibar 2018-11-19T22:50:18.982Z,1542667818.982 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2018-11-19T22:50:18.982Z,1542667818.982 [DropWeight] Hardware Fault, FailCount= 1 2018-11-19T22:50:18.983Z,1542667818.983 [DropWeight](ERROR): Hardware Fault 2018-11-19T22:50:19.038Z,1542667819.038 [CommandLine](FAULT): Scheduling is paused 2018-11-19T22:50:19.039Z,1542667819.039 [CBIT](INFO): Critical error at 20181119T225018 2018-11-19T22:50:19.039Z,1542667819.039 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2018-11-19T22:50:19.041Z,1542667819.041 [CBIT](ERROR): Hardware Fault in component: DropWeight 2018-11-19T22:50:19.042Z,1542667819.042 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2018-11-19T22:50:19.665Z,1542667819.665 [BuoyancyServo](ERROR): Buoyancy initialization uart error serial timeout 2018-11-19T22:50:19.665Z,1542667819.665 [BuoyancyServo](FAULT): Buoyancy failed to initialize 2018-11-19T22:50:19.665Z,1542667819.665 [BuoyancyServo] Communications Fault, FailCount= 1 2018-11-19T22:50:19.665Z,1542667819.665 [BuoyancyServo](ERROR): Communications Fault 2018-11-19T22:50:19.887Z,1542667819.887 [CBIT](INFO): Critical error at 20181119T225019 2018-11-19T22:50:19.890Z,1542667819.890 [CBIT](ERROR): Communications Fault in component: BuoyancyServo 2018-11-19T22:50:21.963Z,1542667821.963 [CBIT](INFO): Clearing failed state for component BuoyancyServo 2018-11-19T22:50:21.963Z,1542667821.963 [BuoyancyServo] No Fault, FailCount= 1 2018-11-19T22:50:22.347Z,1542667822.347 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2018-11-19T22:50:22.466Z,1542667822.466 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2018-11-19T22:50:23.261Z,1542667823.261 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-11-19T22:50:23.344Z,1542667823.344 [CTD_Seabird](INFO): Started Seabird LCM interface with command:nohup ./lrauv-framework/onboard/bin/gpctd -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyC6 -b 9600 >& /dev/null & 2018-11-19T22:50:23.475Z,1542667823.475 [CTD_Seabird](INFO): LCM subscribed to channel:seabird_gpctd_t.seabird-gpctd 2018-11-19T22:50:23.827Z,1542667823.827 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-11-19T22:50:23.827Z,1542667823.827 [CTD_Seabird](INFO): Powering down 2018-11-19T22:50:40.997Z,1542667840.997 [CommandLine](IMPORTANT): got command 2018-11-19T22:50:40.998Z,1542667840.998 [CommandLine](FAULT): Incomplete syntax. Try: help 2018-11-19T22:50:41.934Z,1542667841.934 [CommandLine](IMPORTANT): got command failComponent 2018-11-19T22:50:41.934Z,1542667841.934 [CommandLine](IMPORTANT): Failed components: 2018-11-19T22:50:41.934Z,1542667841.934 [CommandLine](IMPORTANT): DropWeight: Hardware Fault 2018-11-19T22:50:43.902Z,1542667843.902 [NAL9602](INFO): Powering up NAL9602 2018-11-19T22:50:45.946Z,1542667845.946 [SBIT](IMPORTANT): Beginning Startup BIT 2018-11-19T22:50:45.950Z,1542667845.950 [CBIT](IMPORTANT): Beginning ground fault scan 2018-11-19T22:50:54.802Z,1542667854.802 [NAL9602](INFO): NAL9602 initialized 2018-11-19T22:50:56.910Z,1542667856.910 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.007415 CHAN A1 (24V): 0.001129 CHAN A2 (12V): -0.005928 CHAN A3 (5V): -0.002252 CHAN B0 (3.3V): -0.001491 CHAN B1 (3.15aV): -0.000946 CHAN B2 (3.15bV): -0.001661 CHAN B3 (GND): -0.000013 OPEN: -0.001362 Full Scale Calc: 4.765 mA, -1.589 mA 2018-11-19T22:51:39.936Z,1542667899.936 [SBIT](IMPORTANT): SBIT PASSED 2018-11-19T22:51:40.037Z,1542667900.037 [CommandLine](IMPORTANT): got command configSet list 2018-11-19T22:51:40.038Z,1542667900.038 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2018-11-19T22:51:40.038Z,1542667900.038 [CommandLine](IMPORTANT): AHRS_M2.loadAtStartup=0 bool; 2018-11-19T22:51:40.330Z,1542667900.330 [MissionManager](IMPORTANT): Started mission Startup 2018-11-19T22:51:40.331Z,1542667900.331 [Startup] Running Loop=1 2018-11-19T22:51:40.331Z,1542667900.331 [Startup](DEBUG): Aggregate::initialize Startup 2018-11-19T22:51:40.331Z,1542667900.331 [Startup:A.GoToSurface] Running Loop=1 2018-11-19T22:51:40.331Z,1542667900.331 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2018-11-19T22:51:40.332Z,1542667900.332 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2018-11-19T22:51:40.332Z,1542667900.332 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2018-11-19T22:51:40.333Z,1542667900.333 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2018-11-19T22:51:40.333Z,1542667900.333 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2018-11-19T22:51:40.334Z,1542667900.334 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2018-11-19T22:51:40.340Z,1542667900.340 [Startup:StartupSatComms] Running Loop=1 2018-11-19T22:51:40.340Z,1542667900.340 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2018-11-19T22:51:40.340Z,1542667900.340 [Startup:StartupSatComms:A] Running Loop=1 2018-11-19T22:51:40.731Z,1542667900.731 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2018-11-19T22:52:17.509Z,1542667937.509 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T22:52:17.509Z,1542667937.509 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2018-11-19T22:52:17.510Z,1542667937.510 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T22:52:17.511Z,1542667937.511 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T22:52:17.511Z,1542667937.511 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2018-11-19T22:52:17.511Z,1542667937.511 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T22:52:17.524Z,1542667937.524 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T22:52:17.524Z,1542667937.524 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T22:52:17.925Z,1542667937.925 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T22:52:17.926Z,1542667937.926 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2018-11-19T22:52:17.926Z,1542667937.926 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T22:52:17.926Z,1542667937.926 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2018-11-19T22:52:18.315Z,1542667938.315 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T22:52:18.316Z,1542667938.316 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T22:52:18.316Z,1542667938.316 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T22:52:18.316Z,1542667938.316 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T22:52:18.317Z,1542667938.317 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T22:52:18.317Z,1542667938.317 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T22:52:40.396Z,1542667960.396 [Startup:StartupSatComms:A](INFO): Timed out from 2018-11-19T22:51:40.3Z 2018-11-19T22:52:40.396Z,1542667960.396 [Startup:StartupSatComms:A] Stopped 2018-11-19T22:52:40.396Z,1542667960.396 [Startup:StartupSatComms:B] Running Loop=1 2018-11-19T22:52:40.744Z,1542667960.744 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2018-11-19T22:52:45.504Z,1542667965.504 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004335 2018-11-19T22:52:49.467Z,1542667969.467 [DataOverHttps](INFO): Sending 230 bytes from file Logs/20181119T223636/Courier0000.lzma 2018-11-19T22:52:50.260Z,1542667970.260 [DataOverHttps](INFO): Moved sent file to Logs/20181119T223636/Courier0000.lzma.bak 2018-11-19T22:52:50.260Z,1542667970.260 [DataOverHttps](INFO): SBD MOMSN=8896836 2018-11-19T22:52:59.108Z,1542667979.108 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20181119T224038/Courier0000.lzma 2018-11-19T22:52:59.907Z,1542667979.907 [DataOverHttps](INFO): Moved sent file to Logs/20181119T224038/Courier0000.lzma.bak 2018-11-19T22:52:59.907Z,1542667979.907 [DataOverHttps](INFO): SBD MOMSN=8896848 2018-11-19T22:53:08.750Z,1542667988.750 [DataOverHttps](INFO): Sending 89 bytes from file Logs/20181119T224038/Courier0004.lzma 2018-11-19T22:53:09.523Z,1542667989.523 [DataOverHttps](INFO): Moved sent file to Logs/20181119T224038/Courier0004.lzma.bak 2018-11-19T22:53:09.523Z,1542667989.523 [DataOverHttps](INFO): SBD MOMSN=8896853 2018-11-19T22:53:18.260Z,1542667998.260 [DataOverHttps](INFO): Sending 133 bytes from file Logs/20181119T225006/Courier0000.lzma 2018-11-19T22:53:19.060Z,1542667999.060 [DataOverHttps](INFO): Moved sent file to Logs/20181119T225006/Courier0000.lzma.bak 2018-11-19T22:53:19.060Z,1542667999.060 [DataOverHttps](INFO): SBD MOMSN=8896857 2018-11-19T22:53:27.898Z,1542668007.898 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20181119T215937/Express0011.lzma 2018-11-19T22:53:28.679Z,1542668008.679 [DataOverHttps](INFO): Moved sent file to Logs/20181119T215937/Express0011.lzma.bak 2018-11-19T22:53:28.679Z,1542668008.679 [DataOverHttps](INFO): SBD MOMSN=8896862 2018-11-19T22:53:37.921Z,1542668017.921 [DataOverHttps](INFO): Sending 2542 bytes from file Logs/20181119T222037/Express0001.lzma 2018-11-19T22:53:38.711Z,1542668018.711 [DataOverHttps](INFO): Moved sent file to Logs/20181119T222037/Express0001.lzma.bak 2018-11-19T22:53:38.711Z,1542668018.711 [DataOverHttps](INFO): SBD MOMSN=8896865 2018-11-19T22:53:42.631Z,1542668022.631 [Startup:StartupSatComms:B](INFO): Timed out from 2018-11-19T22:52:40.4Z 2018-11-19T22:53:42.631Z,1542668022.631 [Startup:StartupSatComms:B] Stopped 2018-11-19T22:53:42.631Z,1542668022.631 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2018-11-19T22:53:42.631Z,1542668022.631 [Startup:StartupSatComms] Stopped 2018-11-19T22:53:42.631Z,1542668022.631 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2018-11-19T22:53:42.632Z,1542668022.632 [Startup](INFO): Completed Startup 2018-11-19T22:53:42.632Z,1542668022.632 [MissionManager](INFO): Startup is completed. 2018-11-19T22:53:42.632Z,1542668022.632 [MissionManager](INFO): Uninitializing Mission Startup 2018-11-19T22:53:42.632Z,1542668022.632 [Startup] Stopped 2018-11-19T22:53:42.632Z,1542668022.632 [Startup](DEBUG): Aggregate::uninitialize Startup 2018-11-19T22:53:42.656Z,1542668022.656 [Startup:A.GoToSurface] Stopped 2018-11-19T22:53:42.656Z,1542668022.656 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2018-11-19T22:53:42.750Z,1542668022.750 [MissionManager](IMPORTANT): Started mission Default 2018-11-19T22:53:42.750Z,1542668022.750 [Default] Running Loop=1 2018-11-19T22:53:42.751Z,1542668022.751 [Default](DEBUG): Aggregate::initialize Default 2018-11-19T22:53:42.751Z,1542668022.751 [Default:B.GoToSurface] Running Loop=1 2018-11-19T22:53:42.751Z,1542668022.751 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2018-11-19T22:53:42.751Z,1542668022.751 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2018-11-19T22:53:42.751Z,1542668022.751 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2018-11-19T22:53:42.752Z,1542668022.752 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2018-11-19T22:53:42.752Z,1542668022.752 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2018-11-19T22:53:42.752Z,1542668022.752 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2018-11-19T22:53:42.754Z,1542668022.754 [Default:A.Wait] Running Loop=1 2018-11-19T22:53:42.754Z,1542668022.754 [Default:A.Wait](DEBUG): Initialize Wait Component. 2018-11-19T22:53:47.489Z,1542668027.489 [DataOverHttps](INFO): Sending 1082 bytes from file Logs/20181119T222712/Express0001.lzma 2018-11-19T22:53:48.284Z,1542668028.284 [DataOverHttps](INFO): Moved sent file to Logs/20181119T222712/Express0001.lzma.bak 2018-11-19T22:53:48.284Z,1542668028.284 [DataOverHttps](INFO): SBD MOMSN=8897204 2018-11-19T22:53:50.382Z,1542668030.382 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2018-11-19T22:53:55.916Z,1542668035.916 [Default:A.Wait](INFO): Done Waiting. 2018-11-19T22:53:55.916Z,1542668035.916 [Default:A.Wait] Stopped 2018-11-19T22:53:55.916Z,1542668035.916 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2018-11-19T22:53:56.319Z,1542668036.319 [Default:CheckIn] Running Loop=1 2018-11-19T22:53:56.319Z,1542668036.319 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-11-19T22:53:56.320Z,1542668036.320 [Default:CheckIn:Read_GPS] Running Loop=1 2018-11-19T22:53:56.716Z,1542668036.716 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2018-11-19T22:54:16.766Z,1542668056.766 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2018-11-19T22:54:18.334Z,1542668058.334 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T22:54:18.334Z,1542668058.334 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2018-11-19T22:54:18.334Z,1542668058.334 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T22:54:18.335Z,1542668058.335 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T22:54:18.336Z,1542668058.336 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2018-11-19T22:54:18.336Z,1542668058.336 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T22:54:18.349Z,1542668058.349 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T22:54:18.349Z,1542668058.349 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T22:54:18.757Z,1542668058.757 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T22:54:18.758Z,1542668058.758 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2018-11-19T22:54:18.758Z,1542668058.758 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T22:54:18.758Z,1542668058.758 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2018-11-19T22:54:19.125Z,1542668059.125 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T22:54:19.126Z,1542668059.126 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T22:54:19.126Z,1542668059.126 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T22:54:19.126Z,1542668059.126 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T22:54:19.127Z,1542668059.127 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T22:54:19.127Z,1542668059.127 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T22:55:27.808Z,1542668127.808 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2018-11-19T22:55:58.090Z,1542668158.090 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2018-11-19T22:56:19.301Z,1542668179.301 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T22:56:19.301Z,1542668179.301 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2018-11-19T22:56:19.301Z,1542668179.301 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T22:56:19.303Z,1542668179.303 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T22:56:19.303Z,1542668179.303 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2018-11-19T22:56:19.303Z,1542668179.303 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T22:56:19.359Z,1542668179.359 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T22:56:19.359Z,1542668179.359 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T22:56:19.737Z,1542668179.737 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T22:56:19.738Z,1542668179.738 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2018-11-19T22:56:19.738Z,1542668179.738 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T22:56:19.738Z,1542668179.738 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2018-11-19T22:56:20.155Z,1542668180.155 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2018-11-19T22:56:20.160Z,1542668180.160 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T22:56:20.160Z,1542668180.160 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T22:56:20.185Z,1542668180.185 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T22:56:20.185Z,1542668180.185 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T22:56:20.186Z,1542668180.186 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T22:56:20.186Z,1542668180.186 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T22:56:46.959Z,1542668206.959 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2018-11-19T22:57:27.697Z,1542668247.697 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2018-11-19T22:58:20.525Z,1542668300.525 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T22:58:20.525Z,1542668300.525 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2018-11-19T22:58:20.525Z,1542668300.525 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T22:58:20.526Z,1542668300.526 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T22:58:20.527Z,1542668300.527 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4 2018-11-19T22:58:20.527Z,1542668300.527 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T22:58:20.540Z,1542668300.540 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T22:58:20.540Z,1542668300.540 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T22:58:20.886Z,1542668300.886 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T22:58:20.886Z,1542668300.886 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2018-11-19T22:58:20.886Z,1542668300.886 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T22:58:20.886Z,1542668300.886 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4 2018-11-19T22:58:21.292Z,1542668301.292 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T22:58:21.293Z,1542668301.293 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T22:58:21.293Z,1542668301.293 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T22:58:21.294Z,1542668301.294 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T22:58:21.294Z,1542668301.294 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T22:58:21.294Z,1542668301.294 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T22:58:35.633Z,1542668315.633 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2018-11-19T22:58:56.420Z,1542668336.420 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-11-19T22:53:56.3Z 2018-11-19T22:58:56.420Z,1542668336.420 [Default:CheckIn:Read_GPS] Stopped 2018-11-19T22:58:56.420Z,1542668336.420 [Default:CheckIn:Read_Iridium] Running Loop=1 2018-11-19T22:58:56.842Z,1542668336.842 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2018-11-19T22:59:00.765Z,1542668340.765 [DataOverHttps](INFO): Sending 190 bytes from file Logs/20181119T225006/Courier0004.lzma 2018-11-19T22:59:01.559Z,1542668341.559 [DataOverHttps](INFO): Moved sent file to Logs/20181119T225006/Courier0004.lzma.bak 2018-11-19T22:59:01.559Z,1542668341.559 [DataOverHttps](INFO): SBD MOMSN=8897306 2018-11-19T22:59:10.267Z,1542668350.267 [DataOverHttps](INFO): Sending 754 bytes from file Logs/20181119T223124/Express0001.lzma 2018-11-19T22:59:11.063Z,1542668351.063 [DataOverHttps](INFO): Moved sent file to Logs/20181119T223124/Express0001.lzma.bak 2018-11-19T22:59:11.063Z,1542668351.063 [DataOverHttps](INFO): SBD MOMSN=8897308 2018-11-19T22:59:19.768Z,1542668359.768 [DataOverHttps](INFO): Sending 1367 bytes from file Logs/20181119T223320/Express0001.lzma 2018-11-19T22:59:20.563Z,1542668360.563 [DataOverHttps](INFO): Moved sent file to Logs/20181119T223320/Express0001.lzma.bak 2018-11-19T22:59:20.563Z,1542668360.563 [DataOverHttps](INFO): SBD MOMSN=8897330 2018-11-19T22:59:29.266Z,1542668369.266 [DataOverHttps](INFO): Sending 1383 bytes from file Logs/20181119T223414/Express0001.lzma 2018-11-19T22:59:30.059Z,1542668370.059 [DataOverHttps](INFO): Moved sent file to Logs/20181119T223414/Express0001.lzma.bak 2018-11-19T22:59:30.060Z,1542668370.060 [DataOverHttps](INFO): SBD MOMSN=8897451 2018-11-19T22:59:38.768Z,1542668378.768 [DataOverHttps](INFO): Sending 1433 bytes from file Logs/20181119T223507/Express0001.lzma 2018-11-19T22:59:39.563Z,1542668379.563 [DataOverHttps](INFO): Moved sent file to Logs/20181119T223507/Express0001.lzma.bak 2018-11-19T22:59:39.564Z,1542668379.564 [DataOverHttps](INFO): SBD MOMSN=8897581 2018-11-19T22:59:48.276Z,1542668388.276 [DataOverHttps](INFO): Sending 1051 bytes from file Logs/20181119T223636/Express0001.lzma 2018-11-19T22:59:49.071Z,1542668389.071 [DataOverHttps](INFO): Moved sent file to Logs/20181119T223636/Express0001.lzma.bak 2018-11-19T22:59:49.071Z,1542668389.071 [DataOverHttps](INFO): SBD MOMSN=8897713 2018-11-19T22:59:57.777Z,1542668397.777 [DataOverHttps](INFO): Sending 932 bytes from file Logs/20181119T224038/Express0001.lzma 2018-11-19T22:59:58.571Z,1542668398.571 [DataOverHttps](INFO): Moved sent file to Logs/20181119T224038/Express0001.lzma.bak 2018-11-19T22:59:58.571Z,1542668398.571 [DataOverHttps](INFO): SBD MOMSN=8897815 2018-11-19T23:00:07.276Z,1542668407.276 [DataOverHttps](INFO): Sending 497 bytes from file Logs/20181119T224038/Express0005.lzma 2018-11-19T23:00:08.076Z,1542668408.076 [DataOverHttps](INFO): Moved sent file to Logs/20181119T224038/Express0005.lzma.bak 2018-11-19T23:00:08.078Z,1542668408.078 [DataOverHttps](INFO): SBD MOMSN=8897838 2018-11-19T23:00:16.779Z,1542668416.779 [DataOverHttps](INFO): Sending 922 bytes from file Logs/20181119T225006/Express0001.lzma 2018-11-19T23:00:17.575Z,1542668417.575 [DataOverHttps](INFO): Moved sent file to Logs/20181119T225006/Express0001.lzma.bak 2018-11-19T23:00:17.575Z,1542668417.575 [DataOverHttps](INFO): SBD MOMSN=8897862 2018-11-19T23:00:21.483Z,1542668421.483 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:00:21.483Z,1542668421.483 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2018-11-19T23:00:21.483Z,1542668421.483 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T23:00:21.516Z,1542668421.516 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:00:21.516Z,1542668421.516 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5 2018-11-19T23:00:21.516Z,1542668421.516 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T23:00:21.530Z,1542668421.530 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T23:00:21.530Z,1542668421.530 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T23:00:21.639Z,1542668421.639 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T23:00:21.639Z,1542668421.639 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2018-11-19T23:00:21.640Z,1542668421.640 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T23:00:21.640Z,1542668421.640 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5 2018-11-19T23:00:21.976Z,1542668421.976 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T23:00:21.977Z,1542668421.977 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:00:21.977Z,1542668421.977 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:00:21.978Z,1542668421.978 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T23:00:21.978Z,1542668421.978 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:00:21.978Z,1542668421.978 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:00:26.278Z,1542668426.278 [DataOverHttps](INFO): Sending 275 bytes from file Logs/20181119T225006/Express0005.lzma 2018-11-19T23:00:27.075Z,1542668427.075 [DataOverHttps](INFO): Moved sent file to Logs/20181119T225006/Express0005.lzma.bak 2018-11-19T23:00:27.076Z,1542668427.076 [DataOverHttps](INFO): SBD MOMSN=8897886 2018-11-19T23:00:27.695Z,1542668427.695 [Default:CheckIn:Read_Iridium] Stopped 2018-11-19T23:00:27.695Z,1542668427.695 [Default:CheckIn:C.Wait] Running Loop=1 2018-11-19T23:00:27.695Z,1542668427.695 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2018-11-19T23:00:56.242Z,1542668456.242 [NAL9602](FAULT): GPS failed to acquire within timeout. 2018-11-19T23:00:56.242Z,1542668456.242 [NAL9602] Data Fault, FailCount= 1 2018-11-19T23:00:56.242Z,1542668456.242 [NAL9602](ERROR): Data Fault 2018-11-19T23:00:56.305Z,1542668456.305 [CBIT](ERROR): Data Fault in component: NAL9602 2018-11-19T23:00:56.638Z,1542668456.638 [NAL9602](INFO): Powering down 2018-11-19T23:00:57.478Z,1542668457.478 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-19T23:00:57.478Z,1542668457.478 [NAL9602] No Fault, FailCount= 1 2018-11-19T23:01:26.972Z,1542668486.972 [NAL9602](INFO): Powering up NAL9602 2018-11-19T23:01:38.174Z,1542668498.174 [NAL9602](INFO): NAL9602 initialized 2018-11-19T23:02:22.117Z,1542668542.117 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:02:22.117Z,1542668542.117 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2018-11-19T23:02:22.117Z,1542668542.117 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T23:02:22.125Z,1542668542.125 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:02:22.125Z,1542668542.125 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6 2018-11-19T23:02:22.125Z,1542668542.125 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T23:02:22.139Z,1542668542.139 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T23:02:22.139Z,1542668542.139 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T23:02:22.525Z,1542668542.525 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T23:02:22.525Z,1542668542.525 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2018-11-19T23:02:22.526Z,1542668542.526 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T23:02:22.526Z,1542668542.526 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6 2018-11-19T23:02:22.908Z,1542668542.908 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T23:02:22.909Z,1542668542.909 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:02:22.909Z,1542668542.909 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:02:22.910Z,1542668542.910 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T23:02:22.910Z,1542668542.910 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:02:22.911Z,1542668542.911 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:04:23.160Z,1542668663.160 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:04:23.160Z,1542668663.160 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2018-11-19T23:04:23.160Z,1542668663.160 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T23:04:23.162Z,1542668663.162 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:04:23.163Z,1542668663.163 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7 2018-11-19T23:04:23.163Z,1542668663.163 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T23:04:23.175Z,1542668663.175 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T23:04:23.176Z,1542668663.176 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T23:04:23.590Z,1542668663.590 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T23:04:23.591Z,1542668663.591 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2018-11-19T23:04:23.591Z,1542668663.591 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T23:04:23.591Z,1542668663.591 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7 2018-11-19T23:04:23.975Z,1542668663.975 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T23:04:23.975Z,1542668663.975 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:04:23.976Z,1542668663.976 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:04:23.976Z,1542668663.976 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T23:04:23.976Z,1542668663.976 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:04:23.978Z,1542668663.978 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:05:19.066Z,1542668719.066 [CBIT](INFO): Clearing failed state for component DropWeight 2018-11-19T23:05:19.066Z,1542668719.066 [DropWeight] No Fault, FailCount= 1 2018-11-19T23:05:28.255Z,1542668728.255 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2018-11-19T23:05:28.255Z,1542668728.255 [Default:CheckIn:C.Wait] Stopped 2018-11-19T23:05:28.255Z,1542668728.255 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2018-11-19T23:05:28.256Z,1542668728.256 [Default:CheckIn:D] Running Loop=1 2018-11-19T23:05:28.651Z,1542668728.651 [Default:CheckIn:D] Stopped 2018-11-19T23:05:28.651Z,1542668728.651 [Default:CheckIn:E] Running Loop=1 2018-11-19T23:05:29.047Z,1542668729.047 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.764980 min 2018-11-19T23:05:29.050Z,1542668729.050 [Default:CheckIn:E] Stopped 2018-11-19T23:05:29.050Z,1542668729.050 [Default:CheckIn](INFO): Completed Default:CheckIn 2018-11-19T23:05:29.050Z,1542668729.050 [Default:CheckIn] Stopped 2018-11-19T23:05:29.050Z,1542668729.050 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-11-19T23:05:29.050Z,1542668729.050 [Default:CheckIn](INFO): Running loop #2 2018-11-19T23:05:29.050Z,1542668729.050 [Default:CheckIn] Running Loop=2 2018-11-19T23:05:29.050Z,1542668729.050 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-11-19T23:05:29.050Z,1542668729.050 [Default:CheckIn:Read_GPS] Running Loop=1 2018-11-19T23:06:24.102Z,1542668784.102 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:06:24.102Z,1542668784.102 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2018-11-19T23:06:24.102Z,1542668784.102 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T23:06:24.104Z,1542668784.104 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:06:24.104Z,1542668784.104 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8 2018-11-19T23:06:24.104Z,1542668784.104 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T23:06:24.118Z,1542668784.118 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T23:06:24.118Z,1542668784.118 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T23:06:24.521Z,1542668784.521 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T23:06:24.521Z,1542668784.521 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2018-11-19T23:06:24.521Z,1542668784.521 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T23:06:24.521Z,1542668784.521 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8 2018-11-19T23:06:24.908Z,1542668784.908 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T23:06:24.909Z,1542668784.909 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:06:24.909Z,1542668784.909 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:06:24.910Z,1542668784.910 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T23:06:24.910Z,1542668784.910 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:06:24.910Z,1542668784.910 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:08:25.169Z,1542668905.169 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:08:25.169Z,1542668905.169 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2018-11-19T23:08:25.169Z,1542668905.169 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T23:08:25.171Z,1542668905.171 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:08:25.171Z,1542668905.171 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9 2018-11-19T23:08:25.171Z,1542668905.171 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T23:08:25.192Z,1542668905.192 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T23:08:25.192Z,1542668905.192 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T23:08:25.601Z,1542668905.601 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T23:08:25.601Z,1542668905.601 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2018-11-19T23:08:25.601Z,1542668905.601 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T23:08:25.602Z,1542668905.602 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9 2018-11-19T23:08:25.976Z,1542668905.976 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T23:08:25.991Z,1542668905.991 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:08:25.992Z,1542668905.992 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:08:25.992Z,1542668905.992 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T23:08:25.993Z,1542668905.993 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:08:25.993Z,1542668905.993 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:10:28.864Z,1542669028.864 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:10:28.864Z,1542669028.864 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2018-11-19T23:10:28.864Z,1542669028.864 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T23:10:28.866Z,1542669028.866 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:10:28.866Z,1542669028.866 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10 2018-11-19T23:10:28.866Z,1542669028.866 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T23:10:28.880Z,1542669028.880 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T23:10:28.880Z,1542669028.880 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T23:10:29.001Z,1542669029.001 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T23:10:29.001Z,1542669029.001 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2018-11-19T23:10:29.002Z,1542669029.002 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T23:10:29.002Z,1542669029.002 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10 2018-11-19T23:10:29.332Z,1542669029.332 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T23:10:29.333Z,1542669029.333 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:10:29.333Z,1542669029.333 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:10:29.333Z,1542669029.333 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T23:10:29.334Z,1542669029.334 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:10:29.334Z,1542669029.334 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:10:29.336Z,1542669029.336 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-11-19T23:05:29.1Z 2018-11-19T23:10:29.336Z,1542669029.336 [Default:CheckIn:Read_GPS] Stopped 2018-11-19T23:10:29.336Z,1542669029.336 [Default:CheckIn:Read_Iridium] Running Loop=1 2018-11-19T23:10:33.643Z,1542669033.643 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20181119T225006/Courier0007.lzma 2018-11-19T23:10:34.443Z,1542669034.443 [DataOverHttps](INFO): Moved sent file to Logs/20181119T225006/Courier0007.lzma.bak 2018-11-19T23:10:34.444Z,1542669034.444 [DataOverHttps](INFO): SBD MOMSN=8897910 2018-11-19T23:10:43.245Z,1542669043.245 [DataOverHttps](INFO): Sending 294 bytes from file Logs/20181119T225006/Express0008.lzma 2018-11-19T23:10:44.043Z,1542669044.043 [DataOverHttps](INFO): Moved sent file to Logs/20181119T225006/Express0008.lzma.bak 2018-11-19T23:10:44.044Z,1542669044.044 [DataOverHttps](INFO): SBD MOMSN=8897915 2018-11-19T23:10:44.670Z,1542669044.670 [Default:CheckIn:Read_Iridium] Stopped 2018-11-19T23:10:44.671Z,1542669044.671 [Default:CheckIn:C.Wait] Running Loop=1 2018-11-19T23:10:44.671Z,1542669044.671 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2018-11-19T23:11:43.507Z,1542669103.507 [NAL9602](FAULT): GPS failed to acquire within timeout. 2018-11-19T23:11:43.507Z,1542669103.507 [NAL9602] Data Fault, FailCount= 2 2018-11-19T23:11:43.507Z,1542669103.507 [NAL9602](ERROR): Data Fault 2018-11-19T23:11:43.583Z,1542669103.583 [CBIT](ERROR): Data Fault in component: NAL9602 2018-11-19T23:11:43.906Z,1542669103.906 [NAL9602](INFO): Powering down 2018-11-19T23:11:44.754Z,1542669104.754 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-19T23:11:44.755Z,1542669104.755 [NAL9602] No Fault, FailCount= 2 2018-11-19T23:12:14.266Z,1542669134.266 [NAL9602](INFO): Powering up NAL9602 2018-11-19T23:12:25.467Z,1542669145.467 [NAL9602](INFO): NAL9602 initialized 2018-11-19T23:12:29.505Z,1542669149.505 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:12:29.505Z,1542669149.505 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2018-11-19T23:12:29.505Z,1542669149.505 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T23:12:29.507Z,1542669149.507 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:12:29.507Z,1542669149.507 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 11 2018-11-19T23:12:29.507Z,1542669149.507 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T23:12:29.520Z,1542669149.520 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T23:12:29.521Z,1542669149.521 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T23:12:29.913Z,1542669149.913 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T23:12:29.913Z,1542669149.913 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2018-11-19T23:12:29.913Z,1542669149.913 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T23:12:29.913Z,1542669149.913 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 11 2018-11-19T23:12:30.285Z,1542669150.285 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T23:12:30.286Z,1542669150.286 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:12:30.286Z,1542669150.286 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:12:30.287Z,1542669150.287 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T23:12:30.287Z,1542669150.287 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:12:30.287Z,1542669150.287 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:14:30.457Z,1542669270.457 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:14:30.457Z,1542669270.457 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2018-11-19T23:14:30.457Z,1542669270.457 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T23:14:30.459Z,1542669270.459 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:14:30.459Z,1542669270.459 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 12 2018-11-19T23:14:30.459Z,1542669270.459 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T23:14:30.472Z,1542669270.472 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T23:14:30.472Z,1542669270.472 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T23:14:30.905Z,1542669270.905 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T23:14:30.906Z,1542669270.906 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2018-11-19T23:14:30.906Z,1542669270.906 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T23:14:30.906Z,1542669270.906 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 12 2018-11-19T23:14:31.280Z,1542669271.280 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T23:14:31.294Z,1542669271.294 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:14:31.295Z,1542669271.295 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:14:31.295Z,1542669271.295 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T23:14:31.296Z,1542669271.296 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:14:31.296Z,1542669271.296 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:15:45.172Z,1542669345.172 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2018-11-19T23:15:45.172Z,1542669345.172 [Default:CheckIn:C.Wait] Stopped 2018-11-19T23:15:45.172Z,1542669345.172 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2018-11-19T23:15:45.172Z,1542669345.172 [Default:CheckIn:D] Running Loop=1 2018-11-19T23:15:45.567Z,1542669345.567 [Default:CheckIn:D] Stopped 2018-11-19T23:15:45.567Z,1542669345.567 [Default:CheckIn:E] Running Loop=1 2018-11-19T23:15:45.966Z,1542669345.966 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 22.046940 min 2018-11-19T23:15:45.966Z,1542669345.966 [Default:CheckIn:E] Stopped 2018-11-19T23:15:45.966Z,1542669345.966 [Default:CheckIn](INFO): Completed Default:CheckIn 2018-11-19T23:15:45.966Z,1542669345.966 [Default:CheckIn] Stopped 2018-11-19T23:15:45.966Z,1542669345.966 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-11-19T23:15:45.967Z,1542669345.967 [Default:CheckIn](INFO): Running loop #3 2018-11-19T23:15:45.967Z,1542669345.967 [Default:CheckIn] Running Loop=3 2018-11-19T23:15:45.967Z,1542669345.967 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-11-19T23:15:45.967Z,1542669345.967 [Default:CheckIn:Read_GPS] Running Loop=1 2018-11-19T23:16:31.481Z,1542669391.481 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:16:31.481Z,1542669391.481 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2018-11-19T23:16:31.481Z,1542669391.481 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T23:16:31.483Z,1542669391.483 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:16:31.483Z,1542669391.483 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 13 2018-11-19T23:16:31.483Z,1542669391.483 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T23:16:31.496Z,1542669391.496 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T23:16:31.496Z,1542669391.496 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T23:16:31.904Z,1542669391.904 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T23:16:31.905Z,1542669391.905 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2018-11-19T23:16:31.938Z,1542669391.938 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T23:16:31.938Z,1542669391.938 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 13 2018-11-19T23:16:32.289Z,1542669392.289 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T23:16:32.290Z,1542669392.290 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:16:32.290Z,1542669392.290 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:16:32.291Z,1542669392.291 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T23:16:32.291Z,1542669392.291 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:16:32.291Z,1542669392.291 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:18:32.437Z,1542669512.437 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:18:32.437Z,1542669512.437 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2018-11-19T23:18:32.437Z,1542669512.437 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T23:18:32.439Z,1542669512.439 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:18:32.439Z,1542669512.439 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 14 2018-11-19T23:18:32.439Z,1542669512.439 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T23:18:32.452Z,1542669512.452 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T23:18:32.452Z,1542669512.452 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T23:18:32.860Z,1542669512.860 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T23:18:32.860Z,1542669512.860 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2018-11-19T23:18:32.860Z,1542669512.860 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T23:18:32.861Z,1542669512.861 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 14 2018-11-19T23:18:33.232Z,1542669513.232 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T23:18:33.232Z,1542669513.232 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:18:33.232Z,1542669513.232 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:18:33.233Z,1542669513.233 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T23:18:33.233Z,1542669513.233 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:18:33.234Z,1542669513.234 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:20:33.514Z,1542669633.514 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:20:33.514Z,1542669633.514 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2018-11-19T23:20:33.514Z,1542669633.514 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T23:20:33.516Z,1542669633.516 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:20:33.516Z,1542669633.516 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 15 2018-11-19T23:20:33.516Z,1542669633.516 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T23:20:33.530Z,1542669633.530 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T23:20:33.530Z,1542669633.530 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T23:20:33.928Z,1542669633.928 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T23:20:33.928Z,1542669633.928 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2018-11-19T23:20:33.929Z,1542669633.929 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T23:20:33.929Z,1542669633.929 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 15 2018-11-19T23:20:34.311Z,1542669634.311 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T23:20:34.311Z,1542669634.311 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:20:34.311Z,1542669634.311 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:20:34.312Z,1542669634.312 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T23:20:34.312Z,1542669634.312 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:20:34.313Z,1542669634.313 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:20:46.268Z,1542669646.268 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-11-19T23:15:45.0Z 2018-11-19T23:20:46.268Z,1542669646.268 [Default:CheckIn:Read_GPS] Stopped 2018-11-19T23:20:46.268Z,1542669646.268 [Default:CheckIn:Read_Iridium] Running Loop=1 2018-11-19T23:20:50.549Z,1542669650.549 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20181119T225006/Courier0010.lzma 2018-11-19T23:20:51.352Z,1542669651.352 [DataOverHttps](INFO): Moved sent file to Logs/20181119T225006/Courier0010.lzma.bak 2018-11-19T23:20:51.352Z,1542669651.352 [DataOverHttps](INFO): SBD MOMSN=8897945 2018-11-19T23:21:00.051Z,1542669660.051 [DataOverHttps](INFO): Sending 254 bytes from file Logs/20181119T225006/Express0011.lzma 2018-11-19T23:21:00.814Z,1542669660.814 [DataOverHttps](INFO): Moved sent file to Logs/20181119T225006/Express0011.lzma.bak 2018-11-19T23:21:00.814Z,1542669660.814 [DataOverHttps](INFO): SBD MOMSN=8897947 2018-11-19T23:21:01.483Z,1542669661.483 [Default:CheckIn:Read_Iridium] Stopped 2018-11-19T23:21:01.484Z,1542669661.484 [Default:CheckIn:C.Wait] Running Loop=1 2018-11-19T23:21:01.484Z,1542669661.484 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2018-11-19T23:22:27.751Z,1542669747.751 [CommandLine](IMPORTANT): got command show variable batt_fail 2018-11-19T23:22:27.914Z,1542669747.914 [NAL9602](FAULT): GPS failed to acquire within timeout. 2018-11-19T23:22:27.914Z,1542669747.914 [NAL9602] Data Fault, FailCount= 3 2018-11-19T23:22:27.915Z,1542669747.915 [NAL9602](ERROR): Data Fault 2018-11-19T23:22:27.989Z,1542669747.989 [CBIT](ERROR): Data Fault in component: NAL9602 2018-11-19T23:22:28.314Z,1542669748.314 [NAL9602](INFO): Powering down 2018-11-19T23:22:29.151Z,1542669749.151 [CBIT](INFO): Clearing failed state for component NAL9602 2018-11-19T23:22:29.151Z,1542669749.151 [NAL9602] No Fault, FailCount= 3 2018-11-19T23:22:32.495Z,1542669752.495 [CommandLine](IMPORTANT): got command show variable fail 2018-11-19T23:22:32.511Z,1542669752.511 [CommandLine](IMPORTANT): NAL9602.gpsFailTimeout (minute) 2018-11-19T23:22:32.515Z,1542669752.515 [CommandLine](IMPORTANT): CBIT.battFailReport (count) 2018-11-19T23:22:32.551Z,1542669752.551 [CommandLine](IMPORTANT): DeadReckonUsingMultipleVelocitySources.allowableFailures (count) 2018-11-19T23:22:32.552Z,1542669752.552 [CommandLine](IMPORTANT): DeadReckonUsingSpeedCalculator.allowableFailures (count) 2018-11-19T23:22:32.553Z,1542669752.553 [CommandLine](IMPORTANT): DeadReckonWithRespectToWater.allowableFailures (count) 2018-11-19T23:22:32.554Z,1542669752.554 [CommandLine](IMPORTANT): DeadReckonWithRespectToSeafloor.allowableFailures (count) 2018-11-19T23:22:32.555Z,1542669752.555 [CommandLine](IMPORTANT): DeadReckonUsingDVLWaterTrack.allowableFailures (count) 2018-11-19T23:22:32.555Z,1542669752.555 [CommandLine](IMPORTANT): DeadReckonUsingCompactModelForecast.allowableFailures (count) 2018-11-19T23:22:34.336Z,1542669754.336 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:22:34.336Z,1542669754.336 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2018-11-19T23:22:34.336Z,1542669754.336 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T23:22:34.338Z,1542669754.338 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:22:34.338Z,1542669754.338 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 16 2018-11-19T23:22:34.338Z,1542669754.338 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T23:22:34.351Z,1542669754.351 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T23:22:34.351Z,1542669754.351 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T23:22:34.765Z,1542669754.765 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T23:22:34.765Z,1542669754.765 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2018-11-19T23:22:34.765Z,1542669754.765 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T23:22:34.766Z,1542669754.766 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 16 2018-11-19T23:22:35.139Z,1542669755.139 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T23:22:35.140Z,1542669755.140 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:22:35.140Z,1542669755.140 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:22:35.140Z,1542669755.140 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T23:22:35.142Z,1542669755.142 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:22:35.143Z,1542669755.143 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:22:39.798Z,1542669759.798 [CommandLine](IMPORTANT): got command get CBIT.battFailReport 2018-11-19T23:22:39.798Z,1542669759.798 [CommandLine](IMPORTANT): CBIT.battFailReport 10 count 2018-11-19T23:22:58.671Z,1542669778.671 [NAL9602](INFO): Powering up NAL9602 2018-11-19T23:23:09.871Z,1542669789.871 [NAL9602](INFO): NAL9602 initialized 2018-11-19T23:24:36.105Z,1542669876.105 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:24:36.105Z,1542669876.105 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2018-11-19T23:24:36.105Z,1542669876.105 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T23:24:36.107Z,1542669876.107 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:24:36.107Z,1542669876.107 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 17 2018-11-19T23:24:36.107Z,1542669876.107 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T23:24:36.120Z,1542669876.120 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T23:24:36.120Z,1542669876.120 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T23:24:36.282Z,1542669876.282 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T23:24:36.282Z,1542669876.282 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2018-11-19T23:24:36.283Z,1542669876.283 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T23:24:36.283Z,1542669876.283 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 17 2018-11-19T23:24:36.557Z,1542669876.557 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T23:24:36.557Z,1542669876.557 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:24:36.558Z,1542669876.558 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:24:36.558Z,1542669876.558 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T23:24:36.558Z,1542669876.558 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:24:36.559Z,1542669876.559 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:26:01.686Z,1542669961.686 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2018-11-19T23:26:01.686Z,1542669961.686 [Default:CheckIn:C.Wait] Stopped 2018-11-19T23:26:01.687Z,1542669961.687 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2018-11-19T23:26:01.687Z,1542669961.687 [Default:CheckIn:D] Running Loop=1 2018-11-19T23:26:02.087Z,1542669962.087 [Default:CheckIn:D] Stopped 2018-11-19T23:26:02.087Z,1542669962.087 [Default:CheckIn:E] Running Loop=1 2018-11-19T23:26:02.487Z,1542669962.487 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 32.322274 min 2018-11-19T23:26:02.487Z,1542669962.487 [Default:CheckIn:E] Stopped 2018-11-19T23:26:02.487Z,1542669962.487 [Default:CheckIn](INFO): Completed Default:CheckIn 2018-11-19T23:26:02.488Z,1542669962.488 [Default:CheckIn] Stopped 2018-11-19T23:26:02.488Z,1542669962.488 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-11-19T23:26:02.488Z,1542669962.488 [Default:CheckIn](INFO): Running loop #4 2018-11-19T23:26:02.488Z,1542669962.488 [Default:CheckIn] Running Loop=4 2018-11-19T23:26:02.488Z,1542669962.488 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2018-11-19T23:26:02.488Z,1542669962.488 [Default:CheckIn:Read_GPS] Running Loop=1 2018-11-19T23:26:36.837Z,1542669996.837 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:26:36.837Z,1542669996.837 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18 2018-11-19T23:26:36.837Z,1542669996.837 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T23:26:36.839Z,1542669996.839 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:26:36.839Z,1542669996.839 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 18 2018-11-19T23:26:36.839Z,1542669996.839 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T23:26:36.851Z,1542669996.851 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T23:26:36.852Z,1542669996.852 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T23:26:37.257Z,1542669997.257 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T23:26:37.257Z,1542669997.257 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18 2018-11-19T23:26:37.257Z,1542669997.257 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T23:26:37.258Z,1542669997.258 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 18 2018-11-19T23:26:37.640Z,1542669997.640 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T23:26:37.641Z,1542669997.641 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:26:37.641Z,1542669997.641 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:26:37.642Z,1542669997.642 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T23:26:37.642Z,1542669997.642 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:26:37.642Z,1542669997.642 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:28:37.909Z,1542670117.909 [DeadReckonUsingMultipleVelocitySources](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:28:37.909Z,1542670117.909 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19 2018-11-19T23:28:37.909Z,1542670117.909 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2018-11-19T23:28:37.910Z,1542670117.910 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds. 2018-11-19T23:28:37.911Z,1542670117.911 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 19 2018-11-19T23:28:37.911Z,1542670117.911 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2018-11-19T23:28:37.923Z,1542670117.923 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2018-11-19T23:28:37.924Z,1542670117.924 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2018-11-19T23:28:38.310Z,1542670118.310 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2018-11-19T23:28:38.310Z,1542670118.310 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19 2018-11-19T23:28:38.311Z,1542670118.311 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2018-11-19T23:28:38.311Z,1542670118.311 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 19 2018-11-19T23:28:38.692Z,1542670118.692 [DeadReckonUsingMultipleVelocitySources](DEBUG): Initializing DeadReckonUsingMultipleVelocitySources component. 2018-11-19T23:28:38.693Z,1542670118.693 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:28:38.693Z,1542670118.693 [DeadReckonUsingMultipleVelocitySources](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:28:38.694Z,1542670118.694 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2018-11-19T23:28:38.694Z,1542670118.694 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s. 2018-11-19T23:28:38.694Z,1542670118.694 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s. 2018-11-19T23:30:26.183Z,1542670226.183 [CommandLine](IMPORTANT): got command restart application 2018-11-19T23:30:27.192Z,1542670227.192 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-19T23:30:27.192Z,1542670227.192 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:27.313Z,1542670227.313 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2018-11-19T23:30:27.313Z,1542670227.313 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:27.314Z,1542670227.314 [CommandLine](INFO): Join timeout helper Thread ID is 934 2018-11-19T23:30:27.325Z,1542670227.325 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2018-11-19T23:30:27.325Z,1542670227.325 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:27.326Z,1542670227.326 [NavChartDb](INFO): Join timeout helper Thread ID is 935 2018-11-19T23:30:27.481Z,1542670227.481 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-19T23:30:27.481Z,1542670227.481 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:27.485Z,1542670227.485 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2018-11-19T23:30:27.485Z,1542670227.485 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:27.485Z,1542670227.485 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 936 2018-11-19T23:30:27.717Z,1542670227.717 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-19T23:30:27.717Z,1542670227.717 [WetLabsBB2FL](INFO): Powering down 2018-11-19T23:30:27.718Z,1542670227.718 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:27.733Z,1542670227.733 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2018-11-19T23:30:27.733Z,1542670227.733 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:27.734Z,1542670227.734 [CTD_Seabird](INFO): Join timeout helper Thread ID is 937 2018-11-19T23:30:27.734Z,1542670227.734 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-19T23:30:27.894Z,1542670227.894 [CTD_Seabird](INFO): Stopping potential previous instance(s) of CTD_Seabird LCM interface 2018-11-19T23:30:27.894Z,1542670227.894 [CTD_Seabird](INFO): Powering down 2018-11-19T23:30:27.895Z,1542670227.895 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:27.913Z,1542670227.913 [ComponentRegistry](INFO): Shutting down CTD_NeilBrown ThreadHandler 2018-11-19T23:30:27.913Z,1542670227.913 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:27.913Z,1542670227.913 [CTD_NeilBrown](INFO): Join timeout helper Thread ID is 939 2018-11-19T23:30:27.937Z,1542670227.937 [CTD_NeilBrown ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-19T23:30:27.938Z,1542670227.938 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:27.946Z,1542670227.946 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2018-11-19T23:30:27.946Z,1542670227.946 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:27.946Z,1542670227.946 [Radio_Surface](INFO): Join timeout helper Thread ID is 940 2018-11-19T23:30:28.145Z,1542670228.145 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-19T23:30:28.146Z,1542670228.146 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:28.154Z,1542670228.154 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2018-11-19T23:30:28.154Z,1542670228.154 [logger ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:28.154Z,1542670228.154 [logger](INFO): Join timeout helper Thread ID is 941 2018-11-19T23:30:28.157Z,1542670228.157 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-19T23:30:28.157Z,1542670228.157 [logger ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:28.167Z,1542670228.167 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2018-11-19T23:30:28.167Z,1542670228.167 [CommandLine ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:28.167Z,1542670228.167 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2018-11-19T23:30:28.167Z,1542670228.167 [controlThread ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:28.168Z,1542670228.168 [controlThread](INFO): Join timeout helper Thread ID is 942 2018-11-19T23:30:28.489Z,1542670228.489 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2018-11-19T23:30:28.489Z,1542670228.489 [controlThread](DEBUG): Uninitializing ControlThread 2018-11-19T23:30:28.493Z,1542670228.493 [NAL9602](INFO): Powering down 2018-11-19T23:30:28.495Z,1542670228.495 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2018-11-19T23:30:28.496Z,1542670228.496 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2018-11-19T23:30:28.497Z,1542670228.497 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2018-11-19T23:30:28.497Z,1542670228.497 [MissionManager](INFO): Uninitializing Mission Default 2018-11-19T23:30:28.498Z,1542670228.498 [Default] Stopped 2018-11-19T23:30:28.498Z,1542670228.498 [Default](DEBUG): Aggregate::uninitialize Default 2018-11-19T23:30:28.498Z,1542670228.498 [Default:B.GoToSurface] Stopped 2018-11-19T23:30:28.498Z,1542670228.498 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2018-11-19T23:30:28.498Z,1542670228.498 [Default:CheckIn] Stopped 2018-11-19T23:30:28.498Z,1542670228.498 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2018-11-19T23:30:28.498Z,1542670228.498 [Default:CheckIn:Read_GPS] Stopped 2018-11-19T23:30:28.502Z,1542670228.502 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2018-11-19T23:30:28.502Z,1542670228.502 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2018-11-19T23:30:28.502Z,1542670228.502 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2018-11-19T23:30:28.503Z,1542670228.503 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2018-11-19T23:30:28.503Z,1542670228.503 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2018-11-19T23:30:28.503Z,1542670228.503 [BuoyancyServo](INFO): Powering down 2018-11-19T23:30:28.517Z,1542670228.517 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2018-11-19T23:30:28.517Z,1542670228.517 [ElevatorServo](INFO): Powering down 2018-11-19T23:30:28.518Z,1542670228.518 [MassServo](DEBUG): Uninitialize Mass Servo. 2018-11-19T23:30:28.518Z,1542670228.518 [MassServo](INFO): Powering down 2018-11-19T23:30:28.519Z,1542670228.519 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2018-11-19T23:30:28.519Z,1542670228.519 [RudderServo](INFO): Powering down 2018-11-19T23:30:28.520Z,1542670228.520 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2018-11-19T23:30:28.520Z,1542670228.520 [ThrusterServo](INFO): Powering down 2018-11-19T23:30:28.521Z,1542670228.521 [SBIT](DEBUG): Uninitialize SBIT Component. 2018-11-19T23:30:28.521Z,1542670228.521 [IBIT](DEBUG): Uninitialize IBIT Component. 2018-11-19T23:30:28.522Z,1542670228.522 [CBIT](DEBUG): Uninitialize CBIT Component. 2018-11-19T23:30:28.522Z,1542670228.522 [CBIT](DEBUG): Powering off loads. 2018-11-19T23:30:28.533Z,1542670228.533 [CBIT](DEBUG): Disabling WDT. 2018-11-19T23:30:28.545Z,1542670228.545 [CBIT](DEBUG): Opening all GF detection circuits. 2018-11-19T23:30:28.546Z,1542670228.546 [controlThread ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:28.644Z,1542670228.644 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:28.686Z,1542670228.686 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:28.689Z,1542670228.689 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:28.692Z,1542670228.692 [CTD_NeilBrown ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:28.748Z,1542670228.748 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2018-11-19T23:30:28.804Z,1542670228.804 [logger ThreadHandler](INFO): Thread cancelled.