2020-10-08T20:14:49.671Z,1602188089.671 [Supervisor](DEBUG): Initializing supervisor. 2020-10-08T20:14:49.675Z,1602188089.675 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2020-10-08T20:14:49.676Z,1602188089.676 [SyncHandler](INFO): Protected caller Thread ID is 835 2020-10-08T20:14:49.676Z,1602188089.676 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2020-10-08T20:14:49.677Z,1602188089.677 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2020-10-08T20:14:49.678Z,1602188089.678 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 836 2020-10-08T20:14:49.681Z,1602188089.681 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2020-10-08T20:14:49.700Z,1602188089.700 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2020-10-08T20:14:49.701Z,1602188089.701 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2020-10-08T20:14:49.702Z,1602188089.702 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 837 2020-10-08T20:14:49.704Z,1602188089.704 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2020-10-08T20:14:49.705Z,1602188089.705 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2020-10-08T20:14:49.705Z,1602188089.705 [logger ThreadHandler](INFO): Protected caller Thread ID is 838 2020-10-08T20:14:49.709Z,1602188089.709 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2020-10-08T20:14:49.709Z,1602188089.709 [Supervisor](INFO): Looking for Config files in directory: Config/ 2020-10-08T20:14:49.713Z,1602188089.713 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2020-10-08T20:14:49.809Z,1602188089.809 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2020-10-08T20:14:49.811Z,1602188089.811 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2020-10-08T20:14:50.401Z,1602188090.401 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2020-10-08T20:14:50.403Z,1602188090.403 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2020-10-08T20:14:50.614Z,1602188090.614 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2020-10-08T20:14:50.616Z,1602188090.616 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2020-10-08T20:14:50.698Z,1602188090.698 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2020-10-08T20:14:50.805Z,1602188090.805 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2020-10-08T20:14:50.806Z,1602188090.806 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2020-10-08T20:14:50.888Z,1602188090.888 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2020-10-08T20:14:50.990Z,1602188090.990 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2020-10-08T20:14:50.990Z,1602188090.990 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2020-10-08T20:14:51.287Z,1602188091.287 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2020-10-08T20:14:51.288Z,1602188091.288 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2020-10-08T20:14:51.807Z,1602188091.807 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2020-10-08T20:14:51.808Z,1602188091.808 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2020-10-08T20:14:51.956Z,1602188091.956 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2020-10-08T20:14:51.958Z,1602188091.958 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2020-10-08T20:14:52.150Z,1602188092.150 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2020-10-08T20:14:52.151Z,1602188092.151 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2020-10-08T20:14:52.595Z,1602188092.595 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2020-10-08T20:14:52.595Z,1602188092.595 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2020-10-08T20:14:53.642Z,1602188093.642 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2020-10-08T20:14:53.642Z,1602188093.642 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2020-10-08T20:14:53.868Z,1602188093.868 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2020-10-08T20:14:53.869Z,1602188093.869 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2020-10-08T20:14:54.213Z,1602188094.213 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2020-10-08T20:14:54.214Z,1602188094.214 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2020-10-08T20:14:54.548Z,1602188094.548 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2020-10-08T20:14:54.550Z,1602188094.550 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-pontus/ 2020-10-08T20:14:54.552Z,1602188094.552 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/secure.cfg 2020-10-08T20:14:54.636Z,1602188094.636 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Sensor.cfg 2020-10-08T20:14:54.794Z,1602188094.794 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Servo.cfg 2020-10-08T20:14:54.903Z,1602188094.903 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Simulator.cfg 2020-10-08T20:14:54.991Z,1602188094.991 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/logger.cfg 2020-10-08T20:14:55.086Z,1602188095.086 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/vehicle.cfg 2020-10-08T20:14:55.323Z,1602188095.323 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Battery.cfg 2020-10-08T20:14:55.576Z,1602188095.576 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2020-10-08T20:14:55.577Z,1602188095.577 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Navigation.cfg 2020-10-08T20:14:55.672Z,1602188095.672 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/BIT.cfg 2020-10-08T20:14:55.771Z,1602188095.771 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Science.cfg 2020-10-08T20:14:55.899Z,1602188095.899 [Supervisor](INFO): Opening Config file at: Config/lrauv-pontus/Control.cfg 2020-10-08T20:14:55.999Z,1602188095.999 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2020-10-08T20:14:56.021Z,1602188096.021 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2020-10-08T20:14:56.120Z,1602188096.120 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2020-10-08T20:14:56.121Z,1602188096.121 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2020-10-08T20:14:56.190Z,1602188096.190 [VerticalControl](DEBUG): Construct VerticalControl. 2020-10-08T20:14:56.249Z,1602188096.249 [VerticalControl] Loaded 2020-10-08T20:14:56.249Z,1602188096.249 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2020-10-08T20:14:56.252Z,1602188096.252 [HorizontalControl](DEBUG): Construct HorizontalControl. 2020-10-08T20:14:56.290Z,1602188096.290 [HorizontalControl] Loaded 2020-10-08T20:14:56.290Z,1602188096.290 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2020-10-08T20:14:56.292Z,1602188096.292 [SpeedControl](DEBUG): Construct SpeedControl. 2020-10-08T20:14:56.295Z,1602188096.295 [SpeedControl] Loaded 2020-10-08T20:14:56.296Z,1602188096.296 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2020-10-08T20:14:56.298Z,1602188096.298 [LoopControl](DEBUG): Construct LoopControl. 2020-10-08T20:14:56.298Z,1602188096.298 [LoopControl] Loaded 2020-10-08T20:14:56.299Z,1602188096.299 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2020-10-08T20:14:56.299Z,1602188096.299 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2020-10-08T20:14:56.300Z,1602188096.300 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2020-10-08T20:14:56.355Z,1602188096.355 [DepthRateCalculator] Loaded 2020-10-08T20:14:56.356Z,1602188096.356 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2020-10-08T20:14:56.360Z,1602188096.360 [PitchRateCalculator] Loaded 2020-10-08T20:14:56.361Z,1602188096.361 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2020-10-08T20:14:56.371Z,1602188096.371 [SpeedCalculator] Loaded 2020-10-08T20:14:56.371Z,1602188096.371 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2020-10-08T20:14:56.384Z,1602188096.384 [TempGradientCalculator] Loaded 2020-10-08T20:14:56.384Z,1602188096.384 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2020-10-08T20:14:56.388Z,1602188096.388 [YawRateCalculator] Loaded 2020-10-08T20:14:56.389Z,1602188096.389 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2020-10-08T20:14:56.405Z,1602188096.405 [ElevatorOffsetCalculator] Loaded 2020-10-08T20:14:56.405Z,1602188096.405 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2020-10-08T20:14:56.406Z,1602188096.406 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2020-10-08T20:14:56.408Z,1602188096.408 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2020-10-08T20:14:56.449Z,1602188096.449 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2020-10-08T20:14:56.450Z,1602188096.450 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2020-10-08T20:14:56.528Z,1602188096.528 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2020-10-08T20:14:56.529Z,1602188096.529 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2020-10-08T20:14:56.887Z,1602188096.887 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2020-10-08T20:14:56.888Z,1602188096.888 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2020-10-08T20:14:57.014Z,1602188097.014 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2020-10-08T20:14:57.014Z,1602188097.014 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2020-10-08T20:14:57.664Z,1602188097.664 [AHRS_M2] Loaded 2020-10-08T20:14:57.664Z,1602188097.664 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2020-10-08T20:14:58.008Z,1602188098.008 [BackseatComponent] Loaded 2020-10-08T20:14:58.008Z,1602188098.008 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2020-10-08T20:14:58.009Z,1602188098.009 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408F94E0 2020-10-08T20:14:58.010Z,1602188098.010 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 921 2020-10-08T20:14:58.750Z,1602188098.750 [BPC1] Loaded 2020-10-08T20:14:58.750Z,1602188098.750 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2020-10-08T20:14:58.890Z,1602188098.890 [DataOverHttps] Loaded 2020-10-08T20:14:58.890Z,1602188098.890 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2020-10-08T20:14:58.891Z,1602188098.891 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 409294E0 2020-10-08T20:14:58.891Z,1602188098.891 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 922 2020-10-08T20:14:58.910Z,1602188098.910 [Depth_Keller] Loaded 2020-10-08T20:14:58.910Z,1602188098.910 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2020-10-08T20:14:58.967Z,1602188098.967 [NAL9602] Loaded 2020-10-08T20:14:58.967Z,1602188098.967 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2020-10-08T20:14:58.996Z,1602188098.996 [Onboard] Loaded 2020-10-08T20:14:58.996Z,1602188098.996 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2020-10-08T20:14:58.997Z,1602188098.997 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 409594E0 2020-10-08T20:14:58.998Z,1602188098.998 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 923 2020-10-08T20:14:59.010Z,1602188099.010 [Radio_Surface] Loaded 2020-10-08T20:14:59.010Z,1602188099.010 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2020-10-08T20:14:59.011Z,1602188099.011 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409894E0 2020-10-08T20:14:59.011Z,1602188099.011 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 924 2020-10-08T20:14:59.041Z,1602188099.041 [RDI_Pathfinder] Loaded 2020-10-08T20:14:59.041Z,1602188099.041 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread. 2020-10-08T20:14:59.115Z,1602188099.115 [DAT] Loaded 2020-10-08T20:14:59.115Z,1602188099.115 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread. 2020-10-08T20:14:59.116Z,1602188099.116 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2020-10-08T20:14:59.117Z,1602188099.117 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2020-10-08T20:14:59.213Z,1602188099.213 [DeadReckonUsingMultipleVelocitySources] Loaded 2020-10-08T20:14:59.213Z,1602188099.213 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2020-10-08T20:14:59.226Z,1602188099.226 [NavChart] Loaded 2020-10-08T20:14:59.226Z,1602188099.226 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2020-10-08T20:14:59.232Z,1602188099.232 [UniversalFixResidualReporter] Loaded 2020-10-08T20:14:59.232Z,1602188099.232 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2020-10-08T20:14:59.232Z,1602188099.232 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2020-10-08T20:14:59.233Z,1602188099.233 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2020-10-08T20:14:59.398Z,1602188099.398 [SBIT](DEBUG): Construct Startup Built In Test. 2020-10-08T20:14:59.407Z,1602188099.407 [SBIT] Loaded 2020-10-08T20:14:59.407Z,1602188099.407 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2020-10-08T20:14:59.410Z,1602188099.410 [IBIT](DEBUG): Construct Initiated Built In Test. 2020-10-08T20:14:59.423Z,1602188099.423 [IBIT] Loaded 2020-10-08T20:14:59.423Z,1602188099.423 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2020-10-08T20:14:59.428Z,1602188099.428 [CBIT](DEBUG): Construct Continuous Built In Test. 2020-10-08T20:14:59.525Z,1602188099.525 [CBIT] Loaded 2020-10-08T20:14:59.526Z,1602188099.526 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2020-10-08T20:14:59.526Z,1602188099.526 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2020-10-08T20:14:59.527Z,1602188099.527 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2020-10-08T20:14:59.665Z,1602188099.665 [BuoyancyServo] Loaded 2020-10-08T20:14:59.665Z,1602188099.665 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2020-10-08T20:14:59.684Z,1602188099.684 [ElevatorServo] Loaded 2020-10-08T20:14:59.684Z,1602188099.684 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2020-10-08T20:14:59.702Z,1602188099.702 [MassServo] Loaded 2020-10-08T20:14:59.702Z,1602188099.702 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2020-10-08T20:14:59.720Z,1602188099.720 [RudderServo] Loaded 2020-10-08T20:14:59.720Z,1602188099.720 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2020-10-08T20:14:59.737Z,1602188099.737 [ThrusterServo] Loaded 2020-10-08T20:14:59.738Z,1602188099.738 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread. 2020-10-08T20:14:59.738Z,1602188099.738 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2020-10-08T20:14:59.739Z,1602188099.739 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2020-10-08T20:14:59.755Z,1602188099.755 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2020-10-08T20:14:59.756Z,1602188099.756 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2020-10-08T20:14:59.968Z,1602188099.968 [CTD_Seabird] Loaded 2020-10-08T20:14:59.968Z,1602188099.968 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2020-10-08T20:14:59.970Z,1602188099.970 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40AB94E0 2020-10-08T20:14:59.970Z,1602188099.970 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 925 2020-10-08T20:15:00.002Z,1602188100.002 [ESPComponent] Loaded 2020-10-08T20:15:00.002Z,1602188100.002 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2020-10-08T20:15:00.021Z,1602188100.021 [PAR_Licor] Loaded 2020-10-08T20:15:00.021Z,1602188100.021 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2020-10-08T20:15:00.053Z,1602188100.053 [WetLabsBB2FL] Loaded 2020-10-08T20:15:00.053Z,1602188100.053 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2020-10-08T20:15:00.054Z,1602188100.054 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40AE94E0 2020-10-08T20:15:00.055Z,1602188100.055 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 926 2020-10-08T20:15:00.073Z,1602188100.073 [WetLabsUBAT] Loaded 2020-10-08T20:15:00.073Z,1602188100.073 [ComponentRegistry](DEBUG): Component "WetLabsUBAT" handled in its own thread. 2020-10-08T20:15:00.074Z,1602188100.074 [WetLabsUBAT ThreadHandler](DEBUG): Created PCaller Thread at 40B194E0 2020-10-08T20:15:00.074Z,1602188100.074 [WetLabsUBAT ThreadHandler](INFO): Protected caller Thread ID is 927 2020-10-08T20:15:00.075Z,1602188100.075 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2020-10-08T20:15:00.081Z,1602188100.081 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2020-10-08T20:15:00.084Z,1602188100.084 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2020-10-08T20:15:00.094Z,1602188100.094 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2020-10-08T20:15:00.095Z,1602188100.095 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B494E0 2020-10-08T20:15:00.095Z,1602188100.095 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 928 2020-10-08T20:15:00.100Z,1602188100.100 [Supervisor](INFO): Main Thread ID is 829 2020-10-08T20:15:00.100Z,1602188100.100 [Supervisor](DEBUG): Running supervisor. 2020-10-08T20:15:00.101Z,1602188100.101 [CommandLine ThreadHandler](INFO): Handler Thread ID is 929 2020-10-08T20:15:00.103Z,1602188100.103 [controlThread ThreadHandler](INFO): Handler Thread ID is 930 2020-10-08T20:15:00.103Z,1602188100.103 [controlThread](DEBUG): Initializing ControlThread 2020-10-08T20:15:00.104Z,1602188100.104 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2020-10-08T20:15:00.106Z,1602188100.106 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2020-10-08T20:15:00.107Z,1602188100.107 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2020-10-08T20:15:00.107Z,1602188100.107 [LoopControl](DEBUG): Initialize LoopControlComponent. 2020-10-08T20:15:00.107Z,1602188100.107 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2020-10-08T20:15:00.108Z,1602188100.108 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2020-10-08T20:15:00.108Z,1602188100.108 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2020-10-08T20:15:00.109Z,1602188100.109 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2020-10-08T20:15:00.109Z,1602188100.109 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2020-10-08T20:15:00.110Z,1602188100.110 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2020-10-08T20:15:00.113Z,1602188100.113 [NavChart](DEBUG): Initialize NavChart Navigation. 2020-10-08T20:15:00.114Z,1602188100.114 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2020-10-08T20:15:00.114Z,1602188100.114 [SBIT](INFO): Initialize SBIT Component. 2020-10-08T20:15:00.115Z,1602188100.115 [SBIT](IMPORTANT): git: 2020-10-08 2020-10-08T20:15:00.115Z,1602188100.115 [SBIT](INFO): git hash: faec77ea0ead06fb181cdda2cfff08f49c66121b 2020-10-08T20:15:00.115Z,1602188100.115 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2020-10-08T20:15:00.116Z,1602188100.116 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Thu Feb 21 11:17:40 PST 2019 Kernel Reported: #1 PREEMPT Thu Aug 6 12:04:53 PDT 2020 2020-10-08T20:15:00.117Z,1602188100.117 [SBIT](INFO): Beginning SBIT in 59.000000 seconds. 2020-10-08T20:15:00.118Z,1602188100.118 [IBIT](INFO): Initialize IBIT Component. 2020-10-08T20:15:00.119Z,1602188100.119 [CBIT](DEBUG): Initialize CBIT Component. 2020-10-08T20:15:00.120Z,1602188100.120 [logger ThreadHandler](INFO): Handler Thread ID is 931 2020-10-08T20:15:00.132Z,1602188100.132 [CBIT](DEBUG): Initialized mux pins. 2020-10-08T20:15:00.132Z,1602188100.132 [CBIT](DEBUG): Initializing the watchdog timer. 2020-10-08T20:15:00.140Z,1602188100.140 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 932 2020-10-08T20:15:00.152Z,1602188100.152 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 933 2020-10-08T20:15:00.153Z,1602188100.153 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2020-10-08T20:15:00.156Z,1602188100.156 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2020-10-08T20:15:00.156Z,1602188100.156 [CBIT](DEBUG): Initializing heartbeat. 2020-10-08T20:15:00.164Z,1602188100.164 [Onboard ThreadHandler](INFO): Handler Thread ID is 934 2020-10-08T20:15:00.181Z,1602188100.181 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 935 2020-10-08T20:15:00.212Z,1602188100.212 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 936 2020-10-08T20:15:00.213Z,1602188100.213 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2020-10-08T20:15:00.217Z,1602188100.217 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 938 2020-10-08T20:15:00.220Z,1602188100.220 [WetLabsBB2FL](INFO): Powering up 2020-10-08T20:15:00.221Z,1602188100.221 [WetLabsUBAT ThreadHandler](INFO): Handler Thread ID is 940 2020-10-08T20:15:00.224Z,1602188100.224 [WetLabsUBAT](INFO): Powering up 2020-10-08T20:15:00.225Z,1602188100.225 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 942 2020-10-08T20:15:00.228Z,1602188100.228 [CBIT](DEBUG): Deactivating GF circuits. 2020-10-08T20:15:00.228Z,1602188100.228 [CBIT](DEBUG): Deactivating emergency mode. 2020-10-08T20:15:00.234Z,1602188100.234 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2020-10-08T20:15:00.234Z,1602188100.234 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2020-10-08T20:15:00.234Z,1602188100.234 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2020-10-08T20:15:00.234Z,1602188100.234 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2020-10-08T20:15:00.234Z,1602188100.234 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2020-10-08T20:15:00.235Z,1602188100.235 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2020-10-08T20:15:00.235Z,1602188100.235 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2020-10-08T20:15:00.235Z,1602188100.235 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2020-10-08T20:15:00.235Z,1602188100.235 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2020-10-08T20:15:00.235Z,1602188100.235 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2020-10-08T20:15:00.235Z,1602188100.235 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2020-10-08T20:15:00.235Z,1602188100.235 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2020-10-08T20:15:00.236Z,1602188100.236 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2020-10-08T20:15:00.236Z,1602188100.236 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2020-10-08T20:15:00.236Z,1602188100.236 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2020-10-08T20:15:00.236Z,1602188100.236 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2020-10-08T20:15:00.264Z,1602188100.264 [CBIT](DEBUG): Backplane powered. 2020-10-08T20:15:00.269Z,1602188100.269 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2020-10-08T20:15:00.295Z,1602188100.295 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2020-10-08T20:15:00.329Z,1602188100.329 [MissionManager](DEBUG): 2020-10-08T20:15:00.330Z,1602188100.330 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2020-10-08T20:15:00.416Z,1602188100.416 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2020-10-08T20:15:00.417Z,1602188100.417 [Default:A.Wait](DEBUG): Construct Wait. 2020-10-08T20:15:00.420Z,1602188100.420 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2020-10-08T20:15:00.447Z,1602188100.447 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2020-10-08T20:15:00.462Z,1602188100.462 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2020-10-08T20:15:00.482Z,1602188100.482 [Default:E.Execute](DEBUG): Construct Execute. 2020-10-08T20:15:00.485Z,1602188100.485 [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 2020-10-08T20:15:00.504Z,1602188100.504 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,RDI_Pathfinder,DAT,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter, 2020-10-08T20:15:00.509Z,1602188100.509 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2020-10-08T20:15:00.588Z,1602188100.588 [Radio_Surface](INFO): Powering up 2020-10-08T20:15:00.783Z,1602188100.783 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2 2020-10-08T20:15:00.783Z,1602188100.783 [DAT](INFO): Powering up 2020-10-08T20:15:00.783Z,1602188100.783 [DAT](DEBUG): Initializing DAT. 2020-10-08T20:15:00.801Z,1602188100.801 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2 2020-10-08T20:15:00.866Z,1602188100.866 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2020-10-08T20:15:00.872Z,1602188100.872 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2020-10-08T20:15:00.874Z,1602188100.874 [ElevatorServo](DEBUG): Initializing EZServoServo. 2020-10-08T20:15:00.884Z,1602188100.884 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2020-10-08T20:15:00.885Z,1602188100.885 [MassServo](DEBUG): Initializing EZServoServo. 2020-10-08T20:15:00.896Z,1602188100.896 [MassServo](DEBUG): Initializing MassServo. 2020-10-08T20:15:00.897Z,1602188100.897 [RudderServo](DEBUG): Initializing EZServoServo. 2020-10-08T20:15:00.908Z,1602188100.908 [RudderServo](DEBUG): Initializing RudderServo. 2020-10-08T20:15:00.909Z,1602188100.909 [ThrusterServo](DEBUG): Initializing EZServoServo. 2020-10-08T20:15:00.923Z,1602188100.923 [ThrusterServo](DEBUG): Initializing ThrusterServo. 2020-10-08T20:15:02.832Z,1602188102.832 [WetLabsBB2FL](INFO): Powering down 2020-10-08T20:15:09.524Z,1602188109.524 [WetLabsUBAT](INFO): Powering down 2020-10-08T20:15:14.696Z,1602188114.696 [DAT](INFO): commRate: 800 2020-10-08T20:15:16.698Z,1602188116.698 [DAT](INFO): entering command mode 2020-10-08T20:15:17.114Z,1602188117.114 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:17.506Z,1602188117.506 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:17.910Z,1602188117.910 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:18.325Z,1602188118.325 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:18.729Z,1602188118.729 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:19.122Z,1602188119.122 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:19.537Z,1602188119.537 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:19.930Z,1602188119.930 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:20.333Z,1602188120.333 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:20.768Z,1602188120.768 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:21.142Z,1602188121.142 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:21.557Z,1602188121.557 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:21.950Z,1602188121.950 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:22.354Z,1602188122.354 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:22.769Z,1602188122.769 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:23.162Z,1602188123.162 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:23.577Z,1602188123.577 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:23.970Z,1602188123.970 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:24.374Z,1602188124.374 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:24.805Z,1602188124.805 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:25.182Z,1602188125.182 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:25.586Z,1602188125.586 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:26.010Z,1602188126.010 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:26.394Z,1602188126.394 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:26.806Z,1602188126.806 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:27.249Z,1602188127.249 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:27.617Z,1602188127.617 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:28.010Z,1602188128.010 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:28.414Z,1602188128.414 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:28.829Z,1602188128.829 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:29.221Z,1602188129.221 [NAL9602](INFO): Powering up NAL9602 2020-10-08T20:15:29.223Z,1602188129.223 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:29.657Z,1602188129.657 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:30.030Z,1602188130.030 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:30.434Z,1602188130.434 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:30.858Z,1602188130.858 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:31.242Z,1602188131.242 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:31.661Z,1602188131.661 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:32.050Z,1602188132.050 [DAT](DEBUG): checking for command mode acknowledgment 2020-10-08T20:15:32.050Z,1602188132.050 [DAT](FAULT): failed to enter command mode 2020-10-08T20:15:32.459Z,1602188132.459 [DAT](INFO): entering command mode 2020-10-08T20:15:32.886Z,1602188132.886 [DAT](INFO): setting verbose to 3 2020-10-08T20:15:33.263Z,1602188133.263 [DAT](INFO): set verbose to 3 2020-10-08T20:15:33.263Z,1602188133.263 [DAT](INFO): setting DatVerbose to 27440 2020-10-08T20:15:33.678Z,1602188133.678 [DAT](INFO): set DatVerbose to 27440 2020-10-08T20:15:33.678Z,1602188133.678 [DAT](INFO): setting transmit power to 8 2020-10-08T20:15:34.077Z,1602188134.077 [DAT](INFO): set transmit power to 8 2020-10-08T20:15:34.078Z,1602188134.078 [DAT](INFO): setting local address to 9 2020-10-08T20:15:34.475Z,1602188134.475 [DAT](INFO): set local address to 9 2020-10-08T20:15:40.129Z,1602188140.129 [NAL9602](INFO): NAL9602 initialized 2020-10-08T20:15:59.609Z,1602188159.609 [SBIT](IMPORTANT): Beginning Startup BIT 2020-10-08T20:15:59.615Z,1602188159.615 [CBIT](IMPORTANT): Beginning ground fault scan 2020-10-08T20:16:03.564Z,1602188163.564 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:06.797Z,1602188166.797 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:09.656Z,1602188169.656 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:10.509Z,1602188170.509 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.004576 CHAN A1 (24V): -0.000578 CHAN A2 (12V): -0.007435 CHAN A3 (5V): -0.001551 CHAN B0 (3.3V): 0.000472 CHAN B1 (3.15aV): 0.000148 CHAN B2 (3.15bV): -0.000042 CHAN B3 (GND): 0.002590 OPEN: -0.004011 Full Scale Calc: 4.765 mA, -1.589 mA 2020-10-08T20:16:11.709Z,1602188171.709 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:12.855Z,1602188172.855 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:15.691Z,1602188175.691 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:18.921Z,1602188178.921 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:21.743Z,1602188181.743 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:23.026Z,1602188183.026 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:24.571Z,1602188184.571 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:27.400Z,1602188187.400 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:30.630Z,1602188190.630 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:33.870Z,1602188193.870 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:33.945Z,1602188193.945 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:36.691Z,1602188196.691 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:39.924Z,1602188199.924 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:42.751Z,1602188202.751 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:45.246Z,1602188205.246 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:46.388Z,1602188206.388 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:49.215Z,1602188209.215 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:52.477Z,1602188212.477 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:53.291Z,1602188213.291 [SBIT](IMPORTANT): SBIT PASSED 2020-10-08T20:16:53.291Z,1602188213.291 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2020-10-08T20:16:53.292Z,1602188213.292 [SBIT](IMPORTANT): AMEcho.loadAtStartup=0 bool; 2020-10-08T20:16:53.292Z,1602188213.292 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=6 count; 2020-10-08T20:16:53.292Z,1602188213.292 [SBIT](IMPORTANT): BuoyancyServo.loadAtStartup=1 bool; 2020-10-08T20:16:53.292Z,1602188213.292 [SBIT](IMPORTANT): CBIT.gf24Offset=145 microampere; 2020-10-08T20:16:53.292Z,1602188213.292 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool; 2020-10-08T20:16:53.292Z,1602188213.292 [SBIT](IMPORTANT): DAT.sbdAddress=-1 enum; 2020-10-08T20:16:53.293Z,1602188213.293 [SBIT](IMPORTANT): DAT.surfaceThreshold=100 meter; 2020-10-08T20:16:53.293Z,1602188213.293 [SBIT](IMPORTANT): DAT.verbosity=0 count; 2020-10-08T20:16:53.293Z,1602188213.293 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2020-10-08T20:16:53.293Z,1602188213.293 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool; 2020-10-08T20:16:53.293Z,1602188213.293 [SBIT](IMPORTANT): Express linearApproximation AMEcho.altitude 1.000000 meter; 2020-10-08T20:16:53.293Z,1602188213.293 [SBIT](IMPORTANT): Express none ThrusterServo.component_avgCurrent; 2020-10-08T20:16:53.293Z,1602188213.293 [SBIT](IMPORTANT): Express linearApproximation WetLabsUBAT.flow_rate 1.000000 liter_per_second; 2020-10-08T20:16:53.293Z,1602188213.293 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 5.000000 meter; 2020-10-08T20:16:53.294Z,1602188213.294 [SBIT](IMPORTANT): IBIT.batteryVoltageThreshold=13 volt; 2020-10-08T20:16:53.294Z,1602188213.294 [SBIT](IMPORTANT): PAR_Licor.loadAtStartup=1 bool; 2020-10-08T20:16:53.294Z,1602188213.294 [SBIT](IMPORTANT): RDI_Pathfinder.loadAtStartup=1 bool; 2020-10-08T20:16:53.294Z,1602188213.294 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=170 cubic_centimeter; 2020-10-08T20:16:53.294Z,1602188213.294 [SBIT](IMPORTANT): VerticalControl.massDefault=10 millimeter; 2020-10-08T20:16:53.294Z,1602188213.294 [SBIT](IMPORTANT): WetLabsUBAT.loadAtStartup=1 bool; 2020-10-08T20:16:53.715Z,1602188213.715 [MissionManager](IMPORTANT): Started mission Startup 2020-10-08T20:16:53.715Z,1602188213.715 [Startup] Running Loop=1 2020-10-08T20:16:53.716Z,1602188213.716 [Startup](DEBUG): Aggregate::initialize Startup 2020-10-08T20:16:53.720Z,1602188213.720 [Startup:A.GoToSurface] Running Loop=1 2020-10-08T20:16:53.720Z,1602188213.720 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-10-08T20:16:53.721Z,1602188213.721 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-10-08T20:16:53.721Z,1602188213.721 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-10-08T20:16:53.721Z,1602188213.721 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-10-08T20:16:53.722Z,1602188213.722 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-10-08T20:16:53.722Z,1602188213.722 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-10-08T20:16:53.723Z,1602188213.723 [Startup:StartupSatComms] Running Loop=1 2020-10-08T20:16:53.748Z,1602188213.748 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2020-10-08T20:16:53.748Z,1602188213.748 [Startup:StartupSatComms:A] Running Loop=1 2020-10-08T20:16:54.083Z,1602188214.083 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2020-10-08T20:16:55.292Z,1602188215.292 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:56.162Z,1602188216.162 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T20:16:58.108Z,1602188218.108 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:00.931Z,1602188220.931 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:03.760Z,1602188223.760 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:06.587Z,1602188226.587 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:07.077Z,1602188227.077 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:10.223Z,1602188230.223 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:13.455Z,1602188233.455 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:16.284Z,1602188236.284 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:17.966Z,1602188237.966 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:19.111Z,1602188239.111 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:22.349Z,1602188242.349 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:25.847Z,1602188245.847 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005151 2020-10-08T20:17:26.415Z,1602188246.415 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:29.648Z,1602188249.648 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:29.732Z,1602188249.732 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:32.475Z,1602188252.475 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:35.309Z,1602188255.309 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:38.131Z,1602188258.131 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:40.628Z,1602188260.628 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:41.364Z,1602188261.364 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:44.195Z,1602188264.195 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:47.020Z,1602188267.020 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:49.847Z,1602188269.847 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:52.676Z,1602188272.676 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:53.903Z,1602188273.903 [Startup:StartupSatComms:A](INFO): Timed out from 2020-10-08T20:16:53.7Z 2020-10-08T20:17:53.903Z,1602188273.903 [Startup:StartupSatComms:A] Stopped 2020-10-08T20:17:53.903Z,1602188273.903 [Startup:StartupSatComms:B] Running Loop=1 2020-10-08T20:17:54.318Z,1602188274.318 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2020-10-08T20:17:55.347Z,1602188275.347 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:56.012Z,1602188276.012 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:17:57.713Z,1602188277.713 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20201008T201449/Courier0000.lzma 2020-10-08T20:17:58.714Z,1602188278.714 [DataOverHttps](INFO): Moved sent file to Logs/20201008T201449/Courier0000.lzma.bak 2020-10-08T20:17:58.714Z,1602188278.714 [DataOverHttps](INFO): SBD MOMSN=12826393 2020-10-08T20:17:58.840Z,1602188278.840 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:18:00.488Z,1602188280.488 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2020-10-08T20:18:00.488Z,1602188280.488 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T20:18:00.498Z,1602188280.498 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T20:18:00.924Z,1602188280.924 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T20:18:00.924Z,1602188280.924 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2020-10-08T20:18:02.071Z,1602188282.071 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:18:23.126Z,1602188303.126 [DataOverHttps](INFO): Sending 1071 bytes from file Logs/20201008T201449/Express0001.lzma 2020-10-08T20:18:24.126Z,1602188304.126 [DataOverHttps](INFO): Moved sent file to Logs/20201008T201449/Express0001.lzma.bak 2020-10-08T20:18:24.126Z,1602188304.126 [DataOverHttps](INFO): SBD MOMSN=12826401 2020-10-08T20:18:25.536Z,1602188305.536 [Startup:StartupSatComms:B] Stopped 2020-10-08T20:18:25.536Z,1602188305.536 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2020-10-08T20:18:25.536Z,1602188305.536 [Startup:StartupSatComms] Stopped 2020-10-08T20:18:25.536Z,1602188305.536 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2020-10-08T20:18:25.537Z,1602188305.537 [Startup](INFO): Completed Startup 2020-10-08T20:18:25.537Z,1602188305.537 [MissionManager](INFO): Startup is completed. 2020-10-08T20:18:25.537Z,1602188305.537 [MissionManager](INFO): Uninitializing Mission Startup 2020-10-08T20:18:25.537Z,1602188305.537 [Startup] Stopped 2020-10-08T20:18:25.537Z,1602188305.537 [Startup](DEBUG): Aggregate::uninitialize Startup 2020-10-08T20:18:25.538Z,1602188305.538 [Startup:A.GoToSurface] Stopped 2020-10-08T20:18:25.538Z,1602188305.538 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-10-08T20:18:25.922Z,1602188305.922 [MissionManager](IMPORTANT): Started mission Default 2020-10-08T20:18:25.923Z,1602188305.923 [Default] Running Loop=1 2020-10-08T20:18:25.923Z,1602188305.923 [Default](DEBUG): Aggregate::initialize Default 2020-10-08T20:18:25.923Z,1602188305.923 [Default:B.GoToSurface] Running Loop=1 2020-10-08T20:18:25.923Z,1602188305.923 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2020-10-08T20:18:25.923Z,1602188305.923 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2020-10-08T20:18:25.923Z,1602188305.923 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2020-10-08T20:18:25.924Z,1602188305.924 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2020-10-08T20:18:25.924Z,1602188305.924 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2020-10-08T20:18:25.925Z,1602188305.925 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2020-10-08T20:18:25.925Z,1602188305.925 [Default:A.Wait] Running Loop=1 2020-10-08T20:18:25.925Z,1602188305.925 [Default:A.Wait](DEBUG): Initialize Wait Component. 2020-10-08T20:18:39.265Z,1602188319.265 [Default:A.Wait](INFO): Done Waiting. 2020-10-08T20:18:39.265Z,1602188319.265 [Default:A.Wait] Stopped 2020-10-08T20:18:39.265Z,1602188319.265 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T20:18:39.661Z,1602188319.661 [Default:CheckIn] Running Loop=1 2020-10-08T20:18:39.661Z,1602188319.661 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T20:18:39.661Z,1602188319.661 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T20:18:40.071Z,1602188320.071 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2020-10-08T20:19:47.239Z,1602188387.239 [CommandLine](IMPORTANT): got command burn on 2020-10-08T20:19:47.239Z,1602188387.239 [CommandLine](IMPORTANT): Activating dropweight wire 2020-10-08T20:19:55.246Z,1602188395.246 [CommandLine](IMPORTANT): got command burn off 2020-10-08T20:19:55.246Z,1602188395.246 [CommandLine](IMPORTANT): Deactivating dropweight wire 2020-10-08T20:20:42.978Z,1602188442.978 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2020-10-08T20:20:47.801Z,1602188447.801 [CommandLine](INFO): End of History 2020-10-08T20:20:47.803Z,1602188447.803 [CommandLine](INFO): End of History 2020-10-08T20:20:47.813Z,1602188447.813 [CommandLine](INFO): End of History 2020-10-08T20:20:47.977Z,1602188447.977 [CommandLine](INFO): End of History 2020-10-08T20:20:47.979Z,1602188447.979 [CommandLine](INFO): End of History 2020-10-08T20:20:47.981Z,1602188447.981 [CommandLine](INFO): End of History 2020-10-08T20:21:01.479Z,1602188461.479 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2020-10-08T20:21:01.479Z,1602188461.479 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T20:21:01.490Z,1602188461.490 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T20:21:01.891Z,1602188461.891 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T20:21:01.891Z,1602188461.891 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2020-10-08T20:21:07.962Z,1602188467.962 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T20:21:19.679Z,1602188479.679 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T20:21:31.393Z,1602188491.393 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T20:21:35.432Z,1602188495.432 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2020-10-08T20:22:09.994Z,1602188529.994 [CommandLine](IMPORTANT): got command show variable abort 2020-10-08T20:22:10.062Z,1602188530.062 [CommandLine](IMPORTANT): CBIT.abortDepth (meter) 2020-10-08T20:22:10.063Z,1602188530.063 [CommandLine](IMPORTANT): CBIT.abortDepthTimeout (second) 2020-10-08T20:22:15.234Z,1602188535.234 [CommandLine](IMPORTANT): got command get CBIT.abortDepth 2020-10-08T20:22:15.235Z,1602188535.235 [CommandLine](IMPORTANT): CBIT.abortDepth 255.000000 m 2020-10-08T20:22:26.122Z,1602188546.122 [CommandLine](IMPORTANT): got command get CBIT.stopDepth 2020-10-08T20:22:26.122Z,1602188546.122 [CommandLine](IMPORTANT): CBIT.stopDepth 215.000000 m 2020-10-08T20:22:40.848Z,1602188560.848 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2020-10-08T20:23:39.842Z,1602188619.842 [Default:CheckIn:Read_GPS](INFO): Timed out from 2020-10-08T20:18:39.7Z 2020-10-08T20:23:39.842Z,1602188619.842 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T20:23:39.842Z,1602188619.842 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-10-08T20:23:40.272Z,1602188620.272 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2020-10-08T20:23:47.607Z,1602188627.607 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20201008T201449/Courier0004.lzma 2020-10-08T20:23:48.610Z,1602188628.610 [DataOverHttps](INFO): Moved sent file to Logs/20201008T201449/Courier0004.lzma.bak 2020-10-08T20:23:48.610Z,1602188628.610 [DataOverHttps](INFO): SBD MOMSN=12826485 2020-10-08T20:24:02.509Z,1602188642.509 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2020-10-08T20:24:02.509Z,1602188642.509 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T20:24:02.548Z,1602188642.548 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T20:24:02.906Z,1602188642.906 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T20:24:02.906Z,1602188642.906 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2020-10-08T20:24:36.048Z,1602188676.048 [DataOverHttps](INFO): Sending 463 bytes from file Logs/20201008T201449/Express0005.lzma 2020-10-08T20:24:37.050Z,1602188677.050 [DataOverHttps](INFO): Moved sent file to Logs/20201008T201449/Express0005.lzma.bak 2020-10-08T20:24:37.050Z,1602188677.050 [DataOverHttps](INFO): SBD MOMSN=12826511 2020-10-08T20:24:38.437Z,1602188678.437 [Default:CheckIn:Read_Iridium] Stopped 2020-10-08T20:24:38.437Z,1602188678.437 [Default:CheckIn:C.Wait] Running Loop=1 2020-10-08T20:24:38.437Z,1602188678.437 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-10-08T20:25:30.119Z,1602188730.119 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2020-10-08T20:25:30.122Z,1602188730.122 [BPC1](INFO): Received data from all battery sticks. 2020-10-08T20:25:43.043Z,1602188743.043 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-10-08T20:25:43.043Z,1602188743.043 [NAL9602] Data Fault, FailCount= 1 2020-10-08T20:25:43.043Z,1602188743.043 [NAL9602](ERROR): Data Fault 2020-10-08T20:25:43.101Z,1602188743.101 [CBIT](ERROR): Data Fault in component: NAL9602 2020-10-08T20:25:43.445Z,1602188743.445 [NAL9602](INFO): Powering down 2020-10-08T20:25:44.305Z,1602188744.305 [CBIT](INFO): Clearing failed state for component NAL9602 2020-10-08T20:25:44.305Z,1602188744.305 [NAL9602] No Fault, FailCount= 1 2020-10-08T20:26:08.898Z,1602188768.898 [CommandLine](IMPORTANT): got command failComponent 2020-10-08T20:26:08.898Z,1602188768.898 [CommandLine](IMPORTANT): Failed components: 2020-10-08T20:26:08.899Z,1602188768.899 [CommandLine](IMPORTANT): No failed Components. 2020-10-08T20:26:13.742Z,1602188773.742 [NAL9602](INFO): Powering up NAL9602 2020-10-08T20:26:24.661Z,1602188784.661 [NAL9602](INFO): NAL9602 initialized 2020-10-08T20:27:03.468Z,1602188823.468 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2020-10-08T20:27:03.468Z,1602188823.468 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T20:27:03.479Z,1602188823.479 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T20:27:03.902Z,1602188823.902 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T20:27:03.902Z,1602188823.902 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2020-10-08T20:29:38.991Z,1602188978.991 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2020-10-08T20:29:38.991Z,1602188978.991 [Default:CheckIn:C.Wait] Stopped 2020-10-08T20:29:38.991Z,1602188978.991 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T20:29:38.991Z,1602188978.991 [Default:CheckIn:D] Running Loop=1 2020-10-08T20:29:39.436Z,1602188979.436 [Default:CheckIn:D] Stopped 2020-10-08T20:29:39.436Z,1602188979.436 [Default:CheckIn:E] Running Loop=1 2020-10-08T20:29:39.826Z,1602188979.826 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.225217 min 2020-10-08T20:29:39.827Z,1602188979.827 [Default:CheckIn:E] Stopped 2020-10-08T20:29:39.827Z,1602188979.827 [Default:CheckIn](INFO): Completed Default:CheckIn 2020-10-08T20:29:39.827Z,1602188979.827 [Default:CheckIn] Stopped 2020-10-08T20:29:39.827Z,1602188979.827 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T20:29:39.827Z,1602188979.827 [Default:CheckIn](INFO): Running loop #2 2020-10-08T20:29:39.827Z,1602188979.827 [Default:CheckIn] Running Loop=2 2020-10-08T20:29:39.827Z,1602188979.827 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2020-10-08T20:29:39.827Z,1602188979.827 [Default:CheckIn:Read_GPS] Running Loop=1 2020-10-08T20:30:04.445Z,1602189004.445 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2020-10-08T20:30:04.445Z,1602189004.445 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T20:30:04.455Z,1602189004.455 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T20:30:04.890Z,1602189004.890 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T20:30:04.890Z,1602189004.890 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2020-10-08T20:33:05.452Z,1602189185.452 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2020-10-08T20:33:05.452Z,1602189185.452 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2020-10-08T20:33:05.463Z,1602189185.463 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2020-10-08T20:33:05.863Z,1602189185.863 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2020-10-08T20:33:05.863Z,1602189185.863 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2020-10-08T20:34:33.912Z,1602189273.912 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203432.00,A,3648.16243,N,12147.29412,W,0.175,186.00,081020,,,A*79 2020-10-08T20:34:33.916Z,1602189273.916 [NAL9602](INFO): GPS fix at 20201008T203432: (36.802707, -121.788235) 2020-10-08T20:34:33.938Z,1602189273.938 [Default:CheckIn:Read_GPS] Stopped 2020-10-08T20:34:33.938Z,1602189273.938 [Default:CheckIn:Read_Iridium] Running Loop=1 2020-10-08T20:34:44.360Z,1602189284.360 [DataOverHttps](INFO): Sending 289 bytes from file Logs/20201008T201449/Courier0007.lzma 2020-10-08T20:34:45.362Z,1602189285.362 [DataOverHttps](INFO): Moved sent file to Logs/20201008T201449/Courier0007.lzma.bak 2020-10-08T20:34:45.362Z,1602189285.362 [DataOverHttps](INFO): SBD MOMSN=12826610 2020-10-08T20:35:01.900Z,1602189301.900 [DataOverHttps](INFO): Sending 356 bytes from file Logs/20201008T201449/Express0008.lzma 2020-10-08T20:35:02.902Z,1602189302.902 [DataOverHttps](INFO): Moved sent file to Logs/20201008T201449/Express0008.lzma.bak 2020-10-08T20:35:02.902Z,1602189302.902 [DataOverHttps](INFO): SBD MOMSN=12826613 2020-10-08T20:35:04.289Z,1602189304.289 [Default:CheckIn:Read_Iridium] Stopped 2020-10-08T20:35:04.289Z,1602189304.289 [Default:CheckIn:C.Wait] Running Loop=1 2020-10-08T20:35:04.289Z,1602189304.289 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2020-10-08T20:35:06.253Z,1602189306.253 [NAL9602](INFO): Not Powering down - fast GPS 2020-10-08T20:37:56.434Z,1602189476.434 [CommandLine](IMPORTANT): got command failComponent 2020-10-08T20:37:56.435Z,1602189476.435 [CommandLine](IMPORTANT): Failed components: 2020-10-08T20:37:56.435Z,1602189476.435 [CommandLine](IMPORTANT): No failed Components. 2020-10-08T20:37:59.635Z,1602189479.635 [CommandLine](IMPORTANT): got command ibit 2020-10-08T20:37:59.987Z,1602189479.987 [IBIT](IMPORTANT): Beginning Initiated BIT 2020-10-08T20:37:59.987Z,1602189479.987 [IBIT](IMPORTANT): Beginning control surface checks. 2020-10-08T20:38:00.007Z,1602189480.007 [CBIT](IMPORTANT): Beginning ground fault scan 2020-10-08T20:38:01.583Z,1602189481.583 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203759.00,A,3648.13825,N,12147.23139,W,0.233,121.38,081020,,,A*79 2020-10-08T20:38:01.585Z,1602189481.585 [NAL9602](INFO): GPS fix at 20201008T203759: (36.802304, -121.787190) 2020-10-08T20:38:10.930Z,1602189490.930 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.009036 CHAN A1 (24V): 0.001621 CHAN A2 (12V): -0.005379 CHAN A3 (5V): -0.001004 CHAN B0 (3.3V): 0.000546 CHAN B1 (3.15aV): 0.000071 CHAN B2 (3.15bV): 0.000001 CHAN B3 (GND): 0.001851 OPEN: 0.005548 Full Scale Calc: 4.765 mA, -1.589 mA 2020-10-08T20:38:12.134Z,1602189492.134 [NAL9602](INFO): SBD MO Status=0, MOMSN=10026, MT Status=0, MTMSN=0 2020-10-08T20:38:12.134Z,1602189492.134 [NAL9602](INFO): No messages in MT queue 2020-10-08T20:38:13.332Z,1602189493.332 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203811.00,A,3648.13982,N,12147.23185,W,0.117,121.38,081020,,,A*74 2020-10-08T20:38:13.334Z,1602189493.334 [NAL9602](INFO): GPS fix at 20201008T203811: (36.802330, -121.787198) 2020-10-08T20:38:16.152Z,1602189496.152 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203814.00,A,3648.14020,N,12147.23197,W,0.117,121.38,081020,,,A*74 2020-10-08T20:38:16.154Z,1602189496.154 [NAL9602](INFO): GPS fix at 20201008T203814: (36.802337, -121.787199) 2020-10-08T20:38:18.983Z,1602189498.983 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203817.00,A,3648.14040,N,12147.23216,W,0.078,121.38,081020,,,A*73 2020-10-08T20:38:18.985Z,1602189498.985 [NAL9602](INFO): GPS fix at 20201008T203817: (36.802340, -121.787203) 2020-10-08T20:38:22.221Z,1602189502.221 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203820.00,A,3648.14021,N,12147.23222,W,0.058,121.38,081020,,,A*75 2020-10-08T20:38:22.227Z,1602189502.227 [NAL9602](INFO): GPS fix at 20201008T203820: (36.802337, -121.787204) 2020-10-08T20:38:25.043Z,1602189505.043 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203823.00,A,3648.13998,N,12147.23220,W,0.058,121.38,081020,,,A*78 2020-10-08T20:38:25.045Z,1602189505.045 [NAL9602](INFO): GPS fix at 20201008T203823: (36.802333, -121.787203) 2020-10-08T20:38:27.871Z,1602189507.871 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203826.00,A,3648.13958,N,12147.23209,W,0.039,121.38,081020,,,A*7D 2020-10-08T20:38:27.882Z,1602189507.882 [NAL9602](INFO): GPS fix at 20201008T203826: (36.802326, -121.787201) 2020-10-08T20:38:31.103Z,1602189511.103 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203829.00,A,3648.13933,N,12147.23202,W,0.019,121.38,081020,,,A*76 2020-10-08T20:38:31.115Z,1602189511.115 [NAL9602](INFO): GPS fix at 20201008T203829: (36.802322, -121.787200) 2020-10-08T20:38:33.926Z,1602189513.926 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203832.00,A,3648.13929,N,12147.23211,W,0.019,121.38,081020,,,A*75 2020-10-08T20:38:33.928Z,1602189513.928 [NAL9602](INFO): GPS fix at 20201008T203832: (36.802321, -121.787202) 2020-10-08T20:38:37.171Z,1602189517.171 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203835.00,A,3648.13936,N,12147.23223,W,0.019,121.38,081020,,,A*7D 2020-10-08T20:38:37.173Z,1602189517.173 [NAL9602](INFO): GPS fix at 20201008T203835: (36.802323, -121.787204) 2020-10-08T20:38:39.991Z,1602189519.991 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203838.00,A,3648.13937,N,12147.23228,W,0.019,121.38,081020,,,A*7A 2020-10-08T20:38:39.993Z,1602189519.993 [NAL9602](INFO): GPS fix at 20201008T203838: (36.802323, -121.787205) 2020-10-08T20:38:43.243Z,1602189523.243 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203841.00,A,3648.13926,N,12147.23222,W,0.019,121.38,081020,,,A*7E 2020-10-08T20:38:43.245Z,1602189523.245 [NAL9602](INFO): GPS fix at 20201008T203841: (36.802321, -121.787204) 2020-10-08T20:38:46.067Z,1602189526.067 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,203844.00,A,3648.13919,N,12147.23217,W,0.019,121.38,081020,,,A*71 2020-10-08T20:38:46.073Z,1602189526.073 [NAL9602](INFO): GPS fix at 20201008T203844: (36.802320, -121.787203) 2020-10-08T20:38:46.201Z,1602189526.201 [IBIT](IMPORTANT): Communications Status: Fix Status: 1 Iridium Signal Strength: 5 Latitude: 36.802319 Longitude: -121.787201 2020-10-08T20:38:46.509Z,1602189526.509 [IBIT](IMPORTANT): Battery Status: Battery Charge (AH): 0.000000 Voltage: 16.809000 2020-10-08T20:38:46.510Z,1602189526.510 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah 2020-10-08T20:38:46.510Z,1602189526.510 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.000000 V 2020-10-08T20:38:46.928Z,1602189526.928 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 % 2020-10-08T20:38:46.928Z,1602189526.928 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi 2020-10-08T20:38:46.929Z,1602189526.929 [IBIT](IMPORTANT): Pressure:8.417918 PSI 2020-10-08T20:38:46.929Z,1602189526.929 [IBIT](IMPORTANT): Humidity:15.022586 % 2020-10-08T20:38:47.320Z,1602189527.320 [IBIT](IMPORTANT): Vehicle Pitch:-0.831468 degrees 2020-10-08T20:38:47.320Z,1602189527.320 [IBIT](IMPORTANT): Vehicle Roll:5.524014 degrees 2020-10-08T20:38:47.321Z,1602189527.321 [IBIT](IMPORTANT): Vehicle Heading:105.547241 degrees 2020-10-08T20:38:47.726Z,1602189527.726 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m 2020-10-08T20:38:47.726Z,1602189527.726 [IBIT](IMPORTANT): buoyancyNeutral: 170.000000 cc 2020-10-08T20:38:47.727Z,1602189527.727 [IBIT](IMPORTANT): massDefault: 1.000000 cm 2020-10-08T20:38:47.727Z,1602189527.727 [IBIT](IMPORTANT): stopDepth: 215.000000 m 2020-10-08T20:38:47.727Z,1602189527.727 [IBIT](IMPORTANT): abortDepth: 255.000000 m 2020-10-08T20:38:47.727Z,1602189527.727 [IBIT](IMPORTANT): IBIT PASSED 2020-10-08T20:39:18.389Z,1602189558.389 [NAL9602](INFO): Not Powering down - fast GPS 2020-10-08T20:39:47.598Z,1602189587.598 [CommandLine](IMPORTANT): got command failComponent 2020-10-08T20:39:47.598Z,1602189587.598 [CommandLine](IMPORTANT): Failed components: 2020-10-08T20:39:47.598Z,1602189587.598 [CommandLine](IMPORTANT): No failed Components. 2020-10-08T20:39:53.226Z,1602189593.226 [CommandLine](IMPORTANT): got command restart application 2020-10-08T20:39:53.539Z,1602189593.539 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2020-10-08T20:39:54.228Z,1602189594.228 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2020-10-08T20:39:54.229Z,1602189594.229 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T20:39:54.230Z,1602189594.230 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:54.316Z,1602189594.316 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2020-10-08T20:39:54.316Z,1602189594.316 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:54.317Z,1602189594.317 [CommandLine](INFO): Join timeout helper Thread ID is 1052 2020-10-08T20:39:54.380Z,1602189594.380 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2020-10-08T20:39:54.380Z,1602189594.380 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:54.381Z,1602189594.381 [NavChartDb](INFO): Join timeout helper Thread ID is 1053 2020-10-08T20:39:54.480Z,1602189594.480 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T20:39:54.481Z,1602189594.481 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:54.484Z,1602189594.484 [ComponentRegistry](INFO): Shutting down WetLabsUBAT ThreadHandler 2020-10-08T20:39:54.484Z,1602189594.484 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:54.485Z,1602189594.485 [WetLabsUBAT](INFO): Join timeout helper Thread ID is 1054 2020-10-08T20:39:54.540Z,1602189594.540 [WetLabsUBAT ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T20:39:54.541Z,1602189594.541 [WetLabsUBAT](INFO): Powering down 2020-10-08T20:39:54.541Z,1602189594.541 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:54.552Z,1602189594.552 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2020-10-08T20:39:54.552Z,1602189594.552 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:54.553Z,1602189594.553 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1055 2020-10-08T20:39:54.964Z,1602189594.964 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T20:39:54.964Z,1602189594.964 [WetLabsBB2FL](INFO): Powering down 2020-10-08T20:39:54.965Z,1602189594.965 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:54.968Z,1602189594.968 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2020-10-08T20:39:54.968Z,1602189594.968 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:54.969Z,1602189594.969 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1056 2020-10-08T20:39:55.116Z,1602189595.116 [CTD_Seabird](INFO): Powering down 2020-10-08T20:39:55.128Z,1602189595.128 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T20:39:55.128Z,1602189595.128 [CTD_Seabird](INFO): Powering down 2020-10-08T20:39:55.140Z,1602189595.140 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:55.157Z,1602189595.157 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2020-10-08T20:39:55.157Z,1602189595.157 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:55.158Z,1602189595.158 [Radio_Surface](INFO): Join timeout helper Thread ID is 1057 2020-10-08T20:39:55.228Z,1602189595.228 [Radio_Surface](INFO): Powering down 2020-10-08T20:39:55.229Z,1602189595.229 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T20:39:55.229Z,1602189595.229 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:55.249Z,1602189595.249 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2020-10-08T20:39:55.249Z,1602189595.249 [Onboard ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:55.250Z,1602189595.250 [Onboard](INFO): Join timeout helper Thread ID is 1058 2020-10-08T20:39:57.184Z,1602189597.184 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T20:39:57.185Z,1602189597.185 [Onboard ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:57.189Z,1602189597.189 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2020-10-08T20:39:57.189Z,1602189597.189 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:57.189Z,1602189597.189 [DataOverHttps](INFO): Join timeout helper Thread ID is 1059 2020-10-08T20:39:58.000Z,1602189598.000 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T20:39:58.003Z,1602189598.003 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:58.021Z,1602189598.021 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2020-10-08T20:39:58.021Z,1602189598.021 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:58.021Z,1602189598.021 [BackseatComponent](INFO): Join timeout helper Thread ID is 1060 2020-10-08T20:39:58.124Z,1602189598.124 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T20:39:58.125Z,1602189598.125 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:58.129Z,1602189598.129 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2020-10-08T20:39:58.129Z,1602189598.129 [logger ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:58.129Z,1602189598.129 [logger](INFO): Join timeout helper Thread ID is 1061 2020-10-08T20:39:58.168Z,1602189598.168 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T20:39:58.169Z,1602189598.169 [logger ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:58.189Z,1602189598.189 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2020-10-08T20:39:58.189Z,1602189598.189 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:58.189Z,1602189598.189 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2020-10-08T20:39:58.189Z,1602189598.189 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:58.189Z,1602189598.189 [controlThread](INFO): Join timeout helper Thread ID is 1062 2020-10-08T20:39:58.364Z,1602189598.364 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2020-10-08T20:39:58.364Z,1602189598.364 [controlThread](DEBUG): Uninitializing ControlThread 2020-10-08T20:39:58.365Z,1602189598.365 [AHRS_M2](INFO): Powering down 2020-10-08T20:39:58.437Z,1602189598.437 [NAL9602](INFO): Powering down 2020-10-08T20:39:58.508Z,1602189598.508 [RDI_Pathfinder](INFO): Powering down 2020-10-08T20:39:58.509Z,1602189598.509 [DAT](INFO): Powering down 2020-10-08T20:39:58.630Z,1602189598.630 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2020-10-08T20:39:58.631Z,1602189598.631 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2020-10-08T20:39:58.631Z,1602189598.631 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2020-10-08T20:39:58.632Z,1602189598.632 [MissionManager](INFO): Uninitializing Mission Default 2020-10-08T20:39:58.632Z,1602189598.632 [Default] Stopped 2020-10-08T20:39:58.632Z,1602189598.632 [Default](DEBUG): Aggregate::uninitialize Default 2020-10-08T20:39:58.632Z,1602189598.632 [Default:B.GoToSurface] Stopped 2020-10-08T20:39:58.633Z,1602189598.633 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-10-08T20:39:58.633Z,1602189598.633 [Default:CheckIn] Stopped 2020-10-08T20:39:58.633Z,1602189598.633 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2020-10-08T20:39:58.633Z,1602189598.633 [Default:CheckIn:C.Wait] Stopped 2020-10-08T20:39:58.633Z,1602189598.633 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-10-08T20:39:58.636Z,1602189598.636 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2020-10-08T20:39:58.636Z,1602189598.636 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2020-10-08T20:39:58.636Z,1602189598.636 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2020-10-08T20:39:58.637Z,1602189598.637 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2020-10-08T20:39:58.637Z,1602189598.637 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2020-10-08T20:39:58.637Z,1602189598.637 [BuoyancyServo](INFO): Powering down 2020-10-08T20:39:58.648Z,1602189598.648 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2020-10-08T20:39:58.648Z,1602189598.648 [ElevatorServo](INFO): Powering down 2020-10-08T20:39:58.649Z,1602189598.649 [MassServo](DEBUG): Uninitialize Mass Servo. 2020-10-08T20:39:58.649Z,1602189598.649 [MassServo](INFO): Powering down 2020-10-08T20:39:58.650Z,1602189598.650 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-10-08T20:39:58.650Z,1602189598.650 [RudderServo](INFO): Powering down 2020-10-08T20:39:58.651Z,1602189598.651 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2020-10-08T20:39:58.651Z,1602189598.651 [ThrusterServo](INFO): Powering down 2020-10-08T20:39:58.652Z,1602189598.652 [SBIT](DEBUG): Uninitialize SBIT Component. 2020-10-08T20:39:58.652Z,1602189598.652 [IBIT](DEBUG): Uninitialize IBIT Component. 2020-10-08T20:39:58.652Z,1602189598.652 [CBIT](DEBUG): Uninitialize CBIT Component. 2020-10-08T20:39:58.652Z,1602189598.652 [CBIT](DEBUG): Powering off loads. 2020-10-08T20:39:58.664Z,1602189598.664 [CBIT](DEBUG): Disabling WDT. 2020-10-08T20:39:58.676Z,1602189598.676 [CBIT](DEBUG): Opening all GF detection circuits. 2020-10-08T20:39:58.677Z,1602189598.677 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:58.739Z,1602189598.739 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:58.742Z,1602189598.742 [Onboard ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:58.748Z,1602189598.748 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:58.792Z,1602189598.792 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:58.845Z,1602189598.845 [WetLabsUBAT ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:58.847Z,1602189598.847 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:58.852Z,1602189598.852 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:58.860Z,1602189598.860 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-10-08T20:39:58.930Z,1602189598.930 [logger ThreadHandler](INFO): Thread cancelled.