2024-06-03T15:59:03.300Z,1717430343.300 [Supervisor](DEBUG): Initializing supervisor. 2024-06-03T15:59:03.304Z,1717430343.304 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-06-03T15:59:03.305Z,1717430343.305 [SyncHandler](INFO): Protected caller Thread ID is 837 2024-06-03T15:59:03.305Z,1717430343.305 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-06-03T15:59:03.306Z,1717430343.306 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-06-03T15:59:03.306Z,1717430343.306 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 838 2024-06-03T15:59:03.310Z,1717430343.310 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-06-03T15:59:03.328Z,1717430343.328 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-06-03T15:59:03.329Z,1717430343.329 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-06-03T15:59:03.329Z,1717430343.329 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 839 2024-06-03T15:59:03.334Z,1717430343.334 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-06-03T15:59:03.335Z,1717430343.335 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-06-03T15:59:03.335Z,1717430343.335 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 840 2024-06-03T15:59:03.337Z,1717430343.337 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-06-03T15:59:03.338Z,1717430343.338 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-06-03T15:59:03.339Z,1717430343.339 [logger ThreadHandler](INFO): Protected caller Thread ID is 841 2024-06-03T15:59:03.342Z,1717430343.342 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-06-03T15:59:03.343Z,1717430343.343 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-06-03T15:59:03.347Z,1717430343.347 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-06-03T15:59:03.574Z,1717430343.574 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-06-03T15:59:03.576Z,1717430343.576 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-06-03T15:59:03.696Z,1717430343.696 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-06-03T15:59:03.697Z,1717430343.697 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-06-03T15:59:03.836Z,1717430343.836 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-06-03T15:59:03.837Z,1717430343.837 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-06-03T15:59:04.349Z,1717430344.349 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-06-03T15:59:04.351Z,1717430344.351 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-06-03T15:59:04.723Z,1717430344.723 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-06-03T15:59:04.725Z,1717430344.725 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-06-03T15:59:05.087Z,1717430345.087 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-06-03T15:59:05.089Z,1717430345.089 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-06-03T15:59:05.289Z,1717430345.289 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-06-03T15:59:05.291Z,1717430345.291 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-06-03T15:59:05.383Z,1717430345.383 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-06-03T15:59:05.477Z,1717430345.477 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-06-03T15:59:05.962Z,1717430345.962 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-06-03T15:59:05.963Z,1717430345.963 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-06-03T15:59:06.272Z,1717430346.272 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-06-03T15:59:06.274Z,1717430346.274 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-06-03T15:59:06.917Z,1717430346.917 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-06-03T15:59:06.918Z,1717430346.918 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-06-03T15:59:07.744Z,1717430347.744 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-06-03T15:59:07.745Z,1717430347.745 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-06-03T15:59:08.006Z,1717430348.006 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-06-03T15:59:08.008Z,1717430348.008 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-06-03T15:59:08.160Z,1717430348.160 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-06-03T15:59:08.161Z,1717430348.161 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-06-03T15:59:09.058Z,1717430349.058 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-06-03T15:59:09.060Z,1717430349.060 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2024-06-03T15:59:09.064Z,1717430349.064 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2024-06-03T15:59:09.160Z,1717430349.160 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2024-06-03T15:59:09.301Z,1717430349.301 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2024-06-03T15:59:09.580Z,1717430349.580 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-06-03T15:59:09.580Z,1717430349.580 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2024-06-03T15:59:09.721Z,1717430349.721 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2024-06-03T15:59:09.836Z,1717430349.836 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2024-06-03T15:59:09.943Z,1717430349.943 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2024-06-03T15:59:10.066Z,1717430350.066 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2024-06-03T15:59:10.175Z,1717430350.175 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2024-06-03T15:59:10.274Z,1717430350.274 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2024-06-03T15:59:10.378Z,1717430350.378 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2024-06-03T15:59:10.568Z,1717430350.568 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-06-03T15:59:10.586Z,1717430350.586 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-06-03T15:59:10.702Z,1717430350.702 [DepthRateCalculator] Loaded 2024-06-03T15:59:10.702Z,1717430350.702 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-06-03T15:59:10.708Z,1717430350.708 [PitchRateCalculator] Loaded 2024-06-03T15:59:10.708Z,1717430350.708 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-06-03T15:59:10.719Z,1717430350.719 [SpeedCalculator] Loaded 2024-06-03T15:59:10.719Z,1717430350.719 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-06-03T15:59:10.724Z,1717430350.724 [YawRateCalculator] Loaded 2024-06-03T15:59:10.724Z,1717430350.724 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-06-03T15:59:10.746Z,1717430350.746 [ElevatorOffsetCalculator] Loaded 2024-06-03T15:59:10.746Z,1717430350.746 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-06-03T15:59:10.747Z,1717430350.747 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-06-03T15:59:10.747Z,1717430350.747 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-06-03T15:59:10.792Z,1717430350.792 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-06-03T15:59:10.792Z,1717430350.792 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-06-03T15:59:10.808Z,1717430350.808 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-06-03T15:59:10.809Z,1717430350.809 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-06-03T15:59:11.617Z,1717430351.617 [AHRS_M2] Loaded 2024-06-03T15:59:11.617Z,1717430351.617 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-06-03T15:59:11.868Z,1717430351.868 [BackseatComponent] Loaded 2024-06-03T15:59:11.869Z,1717430351.869 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-06-03T15:59:11.870Z,1717430351.870 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408584E0 2024-06-03T15:59:11.870Z,1717430351.870 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 924 2024-06-03T15:59:11.873Z,1717430351.873 [LcmUniversalReporter] Loaded 2024-06-03T15:59:11.873Z,1717430351.873 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-06-03T15:59:13.209Z,1717430353.209 [BPC1] Loaded 2024-06-03T15:59:13.210Z,1717430353.210 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-06-03T15:59:13.355Z,1717430353.355 [DataOverHttps] Loaded 2024-06-03T15:59:13.355Z,1717430353.355 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-06-03T15:59:13.356Z,1717430353.356 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408884E0 2024-06-03T15:59:13.357Z,1717430353.357 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 925 2024-06-03T15:59:13.378Z,1717430353.378 [Depth_Keller] Loaded 2024-06-03T15:59:13.378Z,1717430353.378 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-06-03T15:59:13.441Z,1717430353.441 [NAL9602] Loaded 2024-06-03T15:59:13.441Z,1717430353.441 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-06-03T15:59:13.471Z,1717430353.471 [Onboard] Loaded 2024-06-03T15:59:13.472Z,1717430353.472 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-06-03T15:59:13.472Z,1717430353.473 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408B84E0 2024-06-03T15:59:13.473Z,1717430353.473 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 926 2024-06-03T15:59:13.485Z,1717430353.485 [Power24vConverter] Loaded 2024-06-03T15:59:13.486Z,1717430353.486 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-06-03T15:59:13.500Z,1717430353.500 [Radio_Surface] Loaded 2024-06-03T15:59:13.500Z,1717430353.500 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-06-03T15:59:13.501Z,1717430353.501 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408E84E0 2024-06-03T15:59:13.501Z,1717430353.501 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 927 2024-06-03T15:59:13.515Z,1717430353.515 [Sonardyne_Nano] Loaded 2024-06-03T15:59:13.516Z,1717430353.516 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-06-03T15:59:13.607Z,1717430353.607 [DAT] Loaded 2024-06-03T15:59:13.607Z,1717430353.607 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-06-03T15:59:13.608Z,1717430353.608 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 409184E0 2024-06-03T15:59:13.608Z,1717430353.608 [DAT ThreadHandler](INFO): Protected caller Thread ID is 928 2024-06-03T15:59:13.631Z,1717430353.631 [Waterlinked] Loaded 2024-06-03T15:59:13.632Z,1717430353.632 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread. 2024-06-03T15:59:13.632Z,1717430353.632 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-06-03T15:59:13.633Z,1717430353.633 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-06-03T15:59:13.773Z,1717430353.773 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-06-03T15:59:13.774Z,1717430353.774 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-06-03T15:59:13.816Z,1717430353.816 [DeadReckonUsingSpeedCalculator] Loaded 2024-06-03T15:59:13.817Z,1717430353.817 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2024-06-03T15:59:13.830Z,1717430353.830 [NavChart] Loaded 2024-06-03T15:59:13.831Z,1717430353.831 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-06-03T15:59:13.837Z,1717430353.837 [UniversalFixResidualReporter] Loaded 2024-06-03T15:59:13.837Z,1717430353.837 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-06-03T15:59:13.837Z,1717430353.837 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-06-03T15:59:13.838Z,1717430353.838 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-06-03T15:59:14.018Z,1717430354.018 [SBIT](DEBUG): Construct Startup Built In Test. 2024-06-03T15:59:14.032Z,1717430354.032 [SBIT] Loaded 2024-06-03T15:59:14.032Z,1717430354.032 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-06-03T15:59:14.035Z,1717430354.035 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-06-03T15:59:14.048Z,1717430354.048 [IBIT] Loaded 2024-06-03T15:59:14.049Z,1717430354.049 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-06-03T15:59:14.054Z,1717430354.054 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-06-03T15:59:14.161Z,1717430354.161 [CBIT] Loaded 2024-06-03T15:59:14.161Z,1717430354.161 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-06-03T15:59:14.162Z,1717430354.162 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-06-03T15:59:14.162Z,1717430354.162 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-06-03T15:59:14.391Z,1717430354.391 [CTD_Seabird] Loaded 2024-06-03T15:59:14.391Z,1717430354.391 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-06-03T15:59:14.392Z,1717430354.392 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A204E0 2024-06-03T15:59:14.393Z,1717430354.393 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 929 2024-06-03T15:59:14.414Z,1717430354.414 [PAR_Licor] Loaded 2024-06-03T15:59:14.415Z,1717430354.415 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-06-03T15:59:14.459Z,1717430354.459 [WetLabsBB2FL] Loaded 2024-06-03T15:59:14.460Z,1717430354.460 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-06-03T15:59:14.461Z,1717430354.461 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A504E0 2024-06-03T15:59:14.461Z,1717430354.461 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 930 2024-06-03T15:59:14.462Z,1717430354.462 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-06-03T15:59:14.462Z,1717430354.462 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-06-03T15:59:14.632Z,1717430354.632 [BuoyancyServo] Loaded 2024-06-03T15:59:14.632Z,1717430354.632 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-06-03T15:59:14.654Z,1717430354.654 [ElevatorServo] Loaded 2024-06-03T15:59:14.655Z,1717430354.655 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-06-03T15:59:14.676Z,1717430354.676 [MassServo] Loaded 2024-06-03T15:59:14.676Z,1717430354.676 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-06-03T15:59:14.697Z,1717430354.697 [RudderServo] Loaded 2024-06-03T15:59:14.697Z,1717430354.697 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-06-03T15:59:14.714Z,1717430354.714 [ThrusterHE] Loaded 2024-06-03T15:59:14.714Z,1717430354.714 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-06-03T15:59:14.715Z,1717430354.715 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-06-03T15:59:14.715Z,1717430354.715 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-06-03T15:59:14.789Z,1717430354.789 [VerticalControl](DEBUG): Construct VerticalControl. 2024-06-03T15:59:14.842Z,1717430354.842 [VerticalControl] Loaded 2024-06-03T15:59:14.842Z,1717430354.842 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-06-03T15:59:14.845Z,1717430354.845 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-06-03T15:59:14.890Z,1717430354.890 [HorizontalControl] Loaded 2024-06-03T15:59:14.890Z,1717430354.890 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-06-03T15:59:14.893Z,1717430354.893 [SpeedControl](DEBUG): Construct SpeedControl. 2024-06-03T15:59:14.895Z,1717430354.895 [SpeedControl] Loaded 2024-06-03T15:59:14.895Z,1717430354.895 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-06-03T15:59:14.898Z,1717430354.898 [LoopControl](DEBUG): Construct LoopControl. 2024-06-03T15:59:14.899Z,1717430354.899 [LoopControl] Loaded 2024-06-03T15:59:14.899Z,1717430354.899 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-06-03T15:59:14.899Z,1717430354.899 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-06-03T15:59:14.900Z,1717430354.900 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-06-03T15:59:15.054Z,1717430355.054 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-06-03T15:59:15.054Z,1717430355.054 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-06-03T15:59:15.278Z,1717430355.278 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-06-03T15:59:15.279Z,1717430355.279 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-06-03T15:59:15.700Z,1717430355.700 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-06-03T15:59:15.700Z,1717430355.700 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-06-03T15:59:15.795Z,1717430355.795 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-06-03T15:59:15.802Z,1717430355.802 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-06-03T15:59:15.805Z,1717430355.805 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-06-03T15:59:15.816Z,1717430355.816 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-06-03T15:59:15.817Z,1717430355.817 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C374E0 2024-06-03T15:59:15.817Z,1717430355.817 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 931 2024-06-03T15:59:15.821Z,1717430355.821 [Supervisor](INFO): Main Thread ID is 829 2024-06-03T15:59:15.822Z,1717430355.822 [Supervisor](DEBUG): Running supervisor. 2024-06-03T15:59:15.822Z,1717430355.822 [CommandExec ThreadHandler](INFO): Handler Thread ID is 932 2024-06-03T15:59:15.823Z,1717430355.823 [CommandExec](INFO): Initializing the command executive. 2024-06-03T15:59:15.824Z,1717430355.824 [CommandLine ThreadHandler](INFO): Handler Thread ID is 933 2024-06-03T15:59:15.826Z,1717430355.826 [controlThread ThreadHandler](INFO): Handler Thread ID is 934 2024-06-03T15:59:15.827Z,1717430355.827 [controlThread](DEBUG): Initializing ControlThread 2024-06-03T15:59:15.828Z,1717430355.828 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-06-03T15:59:15.828Z,1717430355.828 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-06-03T15:59:15.828Z,1717430355.828 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-06-03T15:59:15.829Z,1717430355.829 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-06-03T15:59:15.829Z,1717430355.829 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-06-03T15:59:15.835Z,1717430355.835 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T15:59:15.836Z,1717430355.836 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-06-03T15:59:15.836Z,1717430355.836 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-06-03T15:59:15.837Z,1717430355.837 [SBIT](INFO): Initialize SBIT Component. 2024-06-03T15:59:15.837Z,1717430355.837 [SBIT](IMPORTANT): git: 2024-05-07_B 2024-06-03T15:59:15.837Z,1717430355.837 [SBIT](INFO): git hash: bc104d259c06228d73ea553d686443c4b979f515 2024-06-03T15:59:15.837Z,1717430355.837 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-06-03T15:59:15.839Z,1717430355.839 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-06-03T15:59:15.840Z,1717430355.840 [SBIT](INFO): Beginning SBIT in 99.000000 seconds. 2024-06-03T15:59:15.840Z,1717430355.840 [IBIT](INFO): Initialize IBIT Component. 2024-06-03T15:59:15.841Z,1717430355.841 [CBIT](DEBUG): Initialize CBIT Component. 2024-06-03T15:59:15.842Z,1717430355.842 [logger ThreadHandler](INFO): Handler Thread ID is 935 2024-06-03T15:59:15.854Z,1717430355.854 [CBIT](DEBUG): Initialized mux pins. 2024-06-03T15:59:15.854Z,1717430355.854 [CBIT](DEBUG): Initializing the watchdog timer. 2024-06-03T15:59:15.863Z,1717430355.863 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 936 2024-06-03T15:59:15.875Z,1717430355.875 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 937 2024-06-03T15:59:15.876Z,1717430355.876 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-06-03T15:59:15.878Z,1717430355.878 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-06-03T15:59:15.879Z,1717430355.879 [CBIT](DEBUG): Initializing heartbeat. 2024-06-03T15:59:15.887Z,1717430355.887 [Onboard ThreadHandler](INFO): Handler Thread ID is 938 2024-06-03T15:59:15.904Z,1717430355.904 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 939 2024-06-03T15:59:15.923Z,1717430355.923 [DAT ThreadHandler](INFO): Handler Thread ID is 940 2024-06-03T15:59:15.923Z,1717430355.923 [DAT](INFO): Powering up 2024-06-03T15:59:15.923Z,1717430355.923 [DAT](DEBUG): Initializing DAT. 2024-06-03T15:59:15.928Z,1717430355.928 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 942 2024-06-03T15:59:15.929Z,1717430355.929 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-06-03T15:59:15.935Z,1717430355.935 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 944 2024-06-03T15:59:15.940Z,1717430355.940 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 946 2024-06-03T15:59:15.943Z,1717430355.943 [WetLabsBB2FL](INFO): Powering up 2024-06-03T15:59:15.947Z,1717430355.947 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-06-03T15:59:15.947Z,1717430355.947 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-06-03T15:59:15.947Z,1717430355.947 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-06-03T15:59:15.947Z,1717430355.947 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-06-03T15:59:15.948Z,1717430355.948 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-06-03T15:59:15.948Z,1717430355.948 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-06-03T15:59:15.948Z,1717430355.948 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-06-03T15:59:15.948Z,1717430355.948 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-06-03T15:59:15.950Z,1717430355.950 [CBIT](DEBUG): Deactivating GF circuits. 2024-06-03T15:59:15.950Z,1717430355.950 [CBIT](DEBUG): Deactivating emergency mode. 2024-06-03T15:59:15.990Z,1717430355.990 [CBIT](DEBUG): Backplane powered. 2024-06-03T15:59:15.996Z,1717430355.996 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-06-03T15:59:15.997Z,1717430355.997 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-06-03T15:59:15.998Z,1717430355.998 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-06-03T15:59:15.998Z,1717430355.998 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-06-03T15:59:15.999Z,1717430355.999 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-06-03T15:59:15.000Z,1717430356.000 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-06-03T15:59:15.000Z,1717430356.000 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-06-03T15:59:16.005Z,1717430356.005 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-06-03T15:59:16.059Z,1717430356.059 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-06-03T15:59:16.079Z,1717430356.079 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-06-03T15:59:16.103Z,1717430356.103 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Startup { behavior Guidance:GoToSurface { run in progression } aggregate StartupSatComms { run in sequence readDatum { timeout duration=P1M Universal:latitude_fix } readDatum { timeout duration=P1M Universal:platform_communications } } } 2024-06-03T15:59:16.104Z,1717430356.104 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-06-03T15:59:16.104Z,1717430356.104 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-06-03T15:59:16.106Z,1717430356.106 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-06-03T15:59:16.309Z,1717430356.309 [MissionManager](DEBUG): TethyslAPI: Missions/Default.tl translated into: 0 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2024-06-03T15:59:16.310Z,1717430356.310 [Radio_Surface](INFO): Powering up 2024-06-03T15:59:16.316Z,1717430356.316 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-06-03T15:59:16.317Z,1717430356.317 [Default:A.Wait](DEBUG): Construct Wait. 2024-06-03T15:59:16.325Z,1717430356.325 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-06-03T15:59:16.349Z,1717430356.349 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-06-03T15:59:16.364Z,1717430356.364 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-06-03T15:59:16.369Z,1717430356.369 [Default:E.Execute](DEBUG): Construct Execute. 2024-06-03T15:59:16.373Z,1717430356.373 [MissionManager](DEBUG): # Copyright (c) 2024 MBARI # MBARI Proprietary Information. Confidential. All Rights Reserved # Unauthorized copying or distribution of this file via any medium is strictly # prohibited. # # WARNING - This file contains information whose export is restricted by the # Export Administration Act of 1979 (Title 50, U.S.C., App. 2401 et seq.), as # amended. Violations of these export laws are subject to severe civil and/or # criminal penalties. mission Default { arguments { ElapsedSinceDefaultStarted = 0 minute } behavior Guidance:Wait { """ Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. """ run in sequence set duration = 13 second } behavior Guidance:GoToSurface { run in progression } aggregate CheckIn { run in sequence repeat=288 readDatum id="Read_GPS" { timeout duration=P5M Universal:time_fix } readDatum id="Read_Iridium" { timeout duration=P4H { behavior Guidance:Execute { run in sequence set command = "Burn on" } syslog critical "Dropped weight due to communications timeout." } Universal:platform_communications } behavior Guidance:Wait { run in sequence set duration = 5 minute } assign in sequence ElapsedSinceDefaultStarted = elapsed ( Universal:mission_started ) syslog important "Default mission has been running for " + ElapsedSinceDefaultStarted~minute } syslog important "Restarting logs and Default mission." behavior Guidance:Execute { run in sequence set command = "restart logs" } } 2024-06-03T15:59:16.377Z,1717430356.377 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,NAL9602,Power24vConverter,Sonardyne_Nano,Waterlinked,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-06-03T15:59:16.398Z,1717430356.398 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-06-03T15:59:16.520Z,1717430356.520 [Power24vConverter](INFO): Powering up. 2024-06-03T15:59:16.521Z,1717430356.521 [Sonardyne_Nano](INFO): Initializing. 2024-06-03T15:59:16.593Z,1717430356.593 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-06-03T15:59:16.598Z,1717430356.598 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-06-03T15:59:16.599Z,1717430356.599 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-06-03T15:59:16.614Z,1717430356.614 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-06-03T15:59:16.615Z,1717430356.615 [MassServo](DEBUG): Initializing EZServoServo. 2024-06-03T15:59:16.622Z,1717430356.622 [MassServo](DEBUG): Initializing MassServo. 2024-06-03T15:59:16.623Z,1717430356.623 [RudderServo](DEBUG): Initializing EZServoServo. 2024-06-03T15:59:16.630Z,1717430356.630 [RudderServo](DEBUG): Initializing RudderServo. 2024-06-03T15:59:16.631Z,1717430356.631 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-06-03T15:59:16.638Z,1717430356.638 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-06-03T15:59:18.550Z,1717430358.550 [WetLabsBB2FL](INFO): Powering down 2024-06-03T15:59:18.812Z,1717430358.812 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-06-03T15:59:20.051Z,1717430360.051 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2105 2024-06-03T15:59:22.323Z,1717430362.323 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-06-03T15:59:32.056Z,1717430372.056 [DAT](INFO): commRate: 800 2024-06-03T15:59:34.122Z,1717430374.122 [DAT](INFO): entering command mode 2024-06-03T15:59:34.323Z,1717430374.323 [DAT](INFO): setting verbose to 3 2024-06-03T15:59:34.576Z,1717430374.576 [DAT](INFO): set verbose to 3 2024-06-03T15:59:34.576Z,1717430374.576 [DAT](INFO): setting DatVerbose to 27440 2024-06-03T15:59:34.828Z,1717430374.828 [DAT](INFO): set DatVerbose to 27440 2024-06-03T15:59:34.828Z,1717430374.828 [DAT](INFO): setting transmit power to 8 2024-06-03T15:59:35.080Z,1717430375.080 [DAT](INFO): set transmit power to 8 2024-06-03T15:59:35.080Z,1717430375.080 [DAT](INFO): setting local address to 9 2024-06-03T15:59:35.332Z,1717430375.332 [DAT](INFO): set local address to 9 2024-06-03T15:59:35.333Z,1717430375.333 [DAT](INFO): Setting time to: 15:59:35 And date to:6/3/2024 2024-06-03T15:59:35.584Z,1717430375.584 [DAT](INFO): Local DAT time set to Mon Jun 3, 2024 15:59:35 2024-06-03T15:59:43.460Z,1717430383.460 [NAL9602](INFO): Powering up NAL9602 2024-06-03T15:59:54.363Z,1717430394.363 [NAL9602](INFO): NAL9602 initialized 2024-06-03T16:00:45.355Z,1717430445.355 [Waterlinked](ERROR): only read 0 of 1 data item for altitude. Device response::BD, +0.00, +0.00+0.00, 0.00, 0.00 2024-06-03T16:00:53.434Z,1717430453.434 [Waterlinked](INFO): Powering down 2024-06-03T16:00:55.456Z,1717430455.456 [SBIT](IMPORTANT): Beginning Startup BIT 2024-06-03T16:00:55.460Z,1717430455.460 [CBIT](IMPORTANT): Beginning ground fault scan 2024-06-03T16:01:06.348Z,1717430466.348 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.000403 CHAN A1 (24V): 0.000789 CHAN A2 (12V): -0.005201 CHAN A3 (5V): -0.002652 CHAN B0 (3.3V): -0.000893 CHAN B1 (3.15aV): -0.001258 CHAN B2 (3.15bV): -0.001063 CHAN B3 (GND): -0.000787 OPEN: 0.004849 Full Scale: +/- 1 mA 2024-06-03T16:01:49.521Z,1717430509.521 [SBIT](IMPORTANT): SBIT PASSED 2024-06-03T16:01:49.522Z,1717430509.522 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-06-03T16:01:49.523Z,1717430509.523 [SBIT](IMPORTANT): CBIT.runNavErrorCritical=0 bool; 2024-06-03T16:01:49.523Z,1717430509.523 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=1 bool; 2024-06-03T16:01:49.523Z,1717430509.523 [SBIT](IMPORTANT): DAT.loadAtStartup=1 bool; 2024-06-03T16:01:49.523Z,1717430509.523 [SBIT](IMPORTANT): DAT.verbosity=0 count; 2024-06-03T16:01:49.523Z,1717430509.523 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2024-06-03T16:01:49.523Z,1717430509.523 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_counts 250.000000 count; 2024-06-03T16:01:49.523Z,1717430509.523 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 10.000000 meter; 2024-06-03T16:01:49.523Z,1717430509.523 [SBIT](IMPORTANT): PAR_Licor.loadAtStartup=1 bool; 2024-06-03T16:01:49.524Z,1717430509.524 [SBIT](IMPORTANT): Sonardyne_Nano.loadAtStartup=1 bool; 2024-06-03T16:01:49.524Z,1717430509.524 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=222.541119 cubic_centimeter; 2024-06-03T16:01:49.524Z,1717430509.524 [SBIT](IMPORTANT): VerticalControl.massDefault=19.848148 millimeter; 2024-06-03T16:01:49.524Z,1717430509.524 [SBIT](IMPORTANT): Waterlinked.loadAtStartup=1 bool; 2024-06-03T16:01:49.524Z,1717430509.524 [SBIT](IMPORTANT): WetLabsBB2FL.loadAtStartup=1 bool; 2024-06-03T16:01:49.933Z,1717430509.933 [MissionManager](IMPORTANT): Started mission Startup 2024-06-03T16:01:49.934Z,1717430509.934 [Startup] Running Loop=1 2024-06-03T16:01:49.934Z,1717430509.934 [Startup](DEBUG): Aggregate::initialize Startup 2024-06-03T16:01:49.934Z,1717430509.934 [Startup:A.GoToSurface] Running Loop=1 2024-06-03T16:01:49.934Z,1717430509.934 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-06-03T16:01:49.935Z,1717430509.935 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-06-03T16:01:49.935Z,1717430509.935 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-06-03T16:01:49.936Z,1717430509.936 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-06-03T16:01:49.936Z,1717430509.936 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-06-03T16:01:49.936Z,1717430509.936 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-06-03T16:01:49.939Z,1717430509.939 [Startup:StartupSatComms] Running Loop=1 2024-06-03T16:01:49.939Z,1717430509.939 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-06-03T16:01:49.939Z,1717430509.939 [Startup:StartupSatComms:A] Running Loop=1 2024-06-03T16:01:50.325Z,1717430510.325 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-06-03T16:01:58.893Z,1717430518.893 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.005458 2024-06-03T16:02:16.062Z,1717430536.062 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-06-03T16:02:16.062Z,1717430536.062 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:02:16.064Z,1717430536.064 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2024-06-03T16:02:16.064Z,1717430536.064 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:02:16.074Z,1717430536.074 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:02:16.074Z,1717430536.074 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:02:16.488Z,1717430536.488 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:02:16.488Z,1717430536.488 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-06-03T16:02:16.488Z,1717430536.488 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:02:16.488Z,1717430536.488 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2024-06-03T16:02:16.843Z,1717430536.843 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:02:49.979Z,1717430569.979 [Startup:StartupSatComms:A](INFO): Timed out from 2024-06-03T16:01:49.9Z 2024-06-03T16:02:49.979Z,1717430569.979 [Startup:StartupSatComms:A] Stopped 2024-06-03T16:02:49.979Z,1717430569.979 [Startup:StartupSatComms:B] Running Loop=1 2024-06-03T16:02:50.391Z,1717430570.391 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-06-03T16:02:57.256Z,1717430577.256 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240602T213446/Courier0315.lzma 2024-06-03T16:02:58.257Z,1717430578.257 [DataOverHttps](INFO): Moved sent file to Logs/20240602T213446/Courier0315.lzma.bak 2024-06-03T16:02:58.258Z,1717430578.258 [DataOverHttps](INFO): SBD MOMSN=21112100 2024-06-03T16:03:14.483Z,1717430594.483 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240603T155903/Courier0000.lzma 2024-06-03T16:03:15.485Z,1717430595.485 [DataOverHttps](INFO): Moved sent file to Logs/20240603T155903/Courier0000.lzma.bak 2024-06-03T16:03:15.485Z,1717430595.485 [DataOverHttps](INFO): SBD MOMSN=21112102 2024-06-03T16:03:31.324Z,1717430611.324 [DataOverHttps](INFO): Sending 190 bytes from file Logs/20240602T213446/Express0316.lzma 2024-06-03T16:03:32.325Z,1717430612.325 [DataOverHttps](INFO): Moved sent file to Logs/20240602T213446/Express0316.lzma.bak 2024-06-03T16:03:32.325Z,1717430612.325 [DataOverHttps](INFO): SBD MOMSN=21112105 2024-06-03T16:03:48.440Z,1717430628.440 [DataOverHttps](INFO): Sending 951 bytes from file Logs/20240603T155903/Express0001.lzma 2024-06-03T16:03:49.441Z,1717430629.441 [DataOverHttps](INFO): Moved sent file to Logs/20240603T155903/Express0001.lzma.bak 2024-06-03T16:03:49.441Z,1717430629.441 [DataOverHttps](INFO): SBD MOMSN=21112109 2024-06-03T16:03:50.184Z,1717430630.184 [Startup:StartupSatComms:B](INFO): Timed out from 2024-06-03T16:02:49.0Z 2024-06-03T16:03:50.184Z,1717430630.184 [Startup:StartupSatComms:B] Stopped 2024-06-03T16:03:50.184Z,1717430630.184 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-06-03T16:03:50.184Z,1717430630.184 [Startup:StartupSatComms] Stopped 2024-06-03T16:03:50.184Z,1717430630.184 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-06-03T16:03:50.185Z,1717430630.185 [Startup](INFO): Completed Startup 2024-06-03T16:03:50.185Z,1717430630.185 [MissionManager](INFO): Startup is completed. 2024-06-03T16:03:50.186Z,1717430630.186 [MissionManager](INFO): Uninitializing Mission Startup 2024-06-03T16:03:50.186Z,1717430630.186 [Startup] Stopped 2024-06-03T16:03:50.186Z,1717430630.186 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-06-03T16:03:50.186Z,1717430630.186 [Startup:A.GoToSurface] Stopped 2024-06-03T16:03:50.186Z,1717430630.186 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-06-03T16:03:50.605Z,1717430630.605 [MissionManager](IMPORTANT): Started mission Default 2024-06-03T16:03:50.605Z,1717430630.605 [Default] Running Loop=1 2024-06-03T16:03:50.605Z,1717430630.605 [Default](DEBUG): Aggregate::initialize Default 2024-06-03T16:03:50.605Z,1717430630.605 [Default:B.GoToSurface] Running Loop=1 2024-06-03T16:03:50.605Z,1717430630.605 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-06-03T16:03:50.606Z,1717430630.606 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-06-03T16:03:50.606Z,1717430630.606 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-06-03T16:03:50.606Z,1717430630.606 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-06-03T16:03:50.607Z,1717430630.607 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-06-03T16:03:50.607Z,1717430630.607 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-06-03T16:03:50.607Z,1717430630.607 [Default:A.Wait] Running Loop=1 2024-06-03T16:03:50.607Z,1717430630.607 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-06-03T16:04:03.910Z,1717430643.910 [Default:A.Wait](INFO): Done Waiting. 2024-06-03T16:04:03.910Z,1717430643.910 [Default:A.Wait] Stopped 2024-06-03T16:04:03.910Z,1717430643.910 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-06-03T16:04:04.315Z,1717430644.315 [Default:CheckIn] Running Loop=1 2024-06-03T16:04:04.315Z,1717430644.315 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-03T16:04:04.315Z,1717430644.315 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-03T16:04:04.722Z,1717430644.722 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-06-03T16:04:56.824Z,1717430696.824 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-06-03T16:05:17.064Z,1717430717.064 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-06-03T16:05:17.064Z,1717430717.064 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:05:17.065Z,1717430717.065 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2024-06-03T16:05:17.065Z,1717430717.065 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:05:17.076Z,1717430717.076 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:05:17.076Z,1717430717.076 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:05:17.453Z,1717430717.453 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:05:17.453Z,1717430717.453 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-06-03T16:05:17.453Z,1717430717.453 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:05:17.453Z,1717430717.453 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2024-06-03T16:05:17.848Z,1717430717.848 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:08:18.020Z,1717430898.020 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-06-03T16:08:18.020Z,1717430898.020 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:08:18.021Z,1717430898.021 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2024-06-03T16:08:18.021Z,1717430898.021 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:08:18.052Z,1717430898.052 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:08:18.052Z,1717430898.052 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:08:18.442Z,1717430898.442 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:08:18.442Z,1717430898.442 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-06-03T16:08:18.467Z,1717430898.467 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:08:18.467Z,1717430898.467 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2024-06-03T16:08:18.836Z,1717430898.836 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:09:04.506Z,1717430944.506 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-06-03T16:04:04.3Z 2024-06-03T16:09:04.506Z,1717430944.506 [Default:CheckIn:Read_GPS] Stopped 2024-06-03T16:09:04.506Z,1717430944.506 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-03T16:09:04.889Z,1717430944.889 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-06-03T16:09:11.674Z,1717430951.674 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240603T155903/Courier0004.lzma 2024-06-03T16:09:12.677Z,1717430952.677 [DataOverHttps](INFO): Moved sent file to Logs/20240603T155903/Courier0004.lzma.bak 2024-06-03T16:09:12.677Z,1717430952.677 [DataOverHttps](INFO): SBD MOMSN=21112148 2024-06-03T16:09:28.363Z,1717430968.363 [DataOverHttps](INFO): Sending 188 bytes from file Logs/20240603T155903/Express0005.lzma 2024-06-03T16:09:29.365Z,1717430969.365 [DataOverHttps](INFO): Moved sent file to Logs/20240603T155903/Express0005.lzma.bak 2024-06-03T16:09:29.365Z,1717430969.365 [DataOverHttps](INFO): SBD MOMSN=21112150 2024-06-03T16:09:31.178Z,1717430971.178 [Default:CheckIn:Read_Iridium] Stopped 2024-06-03T16:09:31.178Z,1717430971.178 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-03T16:09:31.178Z,1717430971.178 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-03T16:09:55.420Z,1717430995.420 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-06-03T16:09:55.421Z,1717430995.421 [NAL9602] Data Fault, FailCount= 1 2024-06-03T16:09:55.421Z,1717430995.421 [NAL9602](ERROR): Data Fault 2024-06-03T16:09:55.634Z,1717430995.634 [CBIT](ERROR): Data Fault in component: NAL9602 2024-06-03T16:09:55.783Z,1717430995.783 [NAL9602](INFO): Powering down 2024-06-03T16:09:56.617Z,1717430996.617 [CBIT](INFO): Clearing failed state for component NAL9602 2024-06-03T16:09:56.617Z,1717430996.617 [NAL9602] No Fault, FailCount= 1 2024-06-03T16:10:26.092Z,1717431026.092 [NAL9602](INFO): Powering up NAL9602 2024-06-03T16:10:37.010Z,1717431037.010 [NAL9602](INFO): NAL9602 initialized 2024-06-03T16:11:19.067Z,1717431079.067 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2024-06-03T16:11:19.067Z,1717431079.067 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:11:19.068Z,1717431079.068 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4 2024-06-03T16:11:19.068Z,1717431079.068 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:11:19.110Z,1717431079.110 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:11:19.110Z,1717431079.110 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:11:19.494Z,1717431079.494 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:11:19.494Z,1717431079.494 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2024-06-03T16:11:19.494Z,1717431079.494 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:11:19.494Z,1717431079.494 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4 2024-06-03T16:11:19.883Z,1717431079.883 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:14:20.165Z,1717431260.165 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2024-06-03T16:14:20.165Z,1717431260.165 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:14:20.166Z,1717431260.166 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5 2024-06-03T16:14:20.166Z,1717431260.166 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:14:20.206Z,1717431260.206 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:14:20.206Z,1717431260.206 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:14:20.566Z,1717431260.566 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:14:20.566Z,1717431260.566 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2024-06-03T16:14:20.567Z,1717431260.567 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:14:20.567Z,1717431260.567 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5 2024-06-03T16:14:20.888Z,1717431260.888 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:14:31.778Z,1717431271.778 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-03T16:14:31.778Z,1717431271.778 [Default:CheckIn:C.Wait] Stopped 2024-06-03T16:14:31.778Z,1717431271.778 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-03T16:14:31.778Z,1717431271.778 [Default:CheckIn:D] Running Loop=1 2024-06-03T16:14:32.190Z,1717431272.190 [Default:CheckIn:D] Stopped 2024-06-03T16:14:32.190Z,1717431272.190 [Default:CheckIn:E] Running Loop=1 2024-06-03T16:14:32.590Z,1717431272.590 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.693083 min 2024-06-03T16:14:32.590Z,1717431272.590 [Default:CheckIn:E] Stopped 2024-06-03T16:14:32.590Z,1717431272.590 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-03T16:14:32.590Z,1717431272.590 [Default:CheckIn] Stopped 2024-06-03T16:14:32.590Z,1717431272.590 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-03T16:14:32.591Z,1717431272.591 [Default:CheckIn](INFO): Running loop #2 2024-06-03T16:14:32.591Z,1717431272.591 [Default:CheckIn] Running Loop=2 2024-06-03T16:14:32.591Z,1717431272.591 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-03T16:14:32.591Z,1717431272.591 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-03T16:17:21.112Z,1717431441.112 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2024-06-03T16:17:21.112Z,1717431441.112 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:17:21.113Z,1717431441.113 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6 2024-06-03T16:17:21.113Z,1717431441.113 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:17:21.124Z,1717431441.124 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:17:21.124Z,1717431441.124 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:17:21.501Z,1717431441.501 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:17:21.501Z,1717431441.501 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2024-06-03T16:17:21.502Z,1717431441.502 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:17:21.502Z,1717431441.502 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6 2024-06-03T16:17:21.889Z,1717431441.889 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:19:32.772Z,1717431572.772 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-06-03T16:14:32.6Z 2024-06-03T16:19:32.772Z,1717431572.772 [Default:CheckIn:Read_GPS] Stopped 2024-06-03T16:19:32.772Z,1717431572.772 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-03T16:19:40.174Z,1717431580.174 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240603T155903/Courier0007.lzma 2024-06-03T16:19:41.177Z,1717431581.177 [DataOverHttps](INFO): Moved sent file to Logs/20240603T155903/Courier0007.lzma.bak 2024-06-03T16:19:41.177Z,1717431581.177 [DataOverHttps](INFO): SBD MOMSN=21112180 2024-06-03T16:19:56.707Z,1717431596.707 [DataOverHttps](INFO): Sending 183 bytes from file Logs/20240603T155903/Express0008.lzma 2024-06-03T16:19:57.709Z,1717431597.709 [DataOverHttps](INFO): Moved sent file to Logs/20240603T155903/Express0008.lzma.bak 2024-06-03T16:19:57.709Z,1717431597.709 [DataOverHttps](INFO): SBD MOMSN=21112182 2024-06-03T16:19:59.457Z,1717431599.457 [Default:CheckIn:Read_Iridium] Stopped 2024-06-03T16:19:59.457Z,1717431599.457 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-03T16:19:59.457Z,1717431599.457 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-03T16:20:22.071Z,1717431622.071 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2024-06-03T16:20:22.071Z,1717431622.071 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:20:22.072Z,1717431622.072 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7 2024-06-03T16:20:22.073Z,1717431622.073 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:20:22.084Z,1717431622.084 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:20:22.084Z,1717431622.084 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:20:22.498Z,1717431622.498 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:20:22.498Z,1717431622.498 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2024-06-03T16:20:22.498Z,1717431622.498 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:20:22.498Z,1717431622.498 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7 2024-06-03T16:20:22.936Z,1717431622.936 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:20:39.012Z,1717431639.012 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-06-03T16:20:39.012Z,1717431639.012 [NAL9602] Data Fault, FailCount= 2 2024-06-03T16:20:39.012Z,1717431639.012 [NAL9602](ERROR): Data Fault 2024-06-03T16:20:39.084Z,1717431639.084 [CBIT](ERROR): Data Fault in component: NAL9602 2024-06-03T16:20:39.408Z,1717431639.408 [NAL9602](INFO): Powering down 2024-06-03T16:20:40.301Z,1717431640.301 [CBIT](INFO): Clearing failed state for component NAL9602 2024-06-03T16:20:40.301Z,1717431640.301 [NAL9602] No Fault, FailCount= 2 2024-06-03T16:21:09.713Z,1717431669.713 [NAL9602](INFO): Powering up NAL9602 2024-06-03T16:21:20.620Z,1717431680.620 [NAL9602](INFO): NAL9602 initialized 2024-06-03T16:23:23.035Z,1717431803.035 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2024-06-03T16:23:23.035Z,1717431803.035 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:23:23.036Z,1717431803.036 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8 2024-06-03T16:23:23.037Z,1717431803.037 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:23:23.071Z,1717431803.071 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:23:23.071Z,1717431803.071 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:23:23.449Z,1717431803.449 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:23:23.449Z,1717431803.449 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2024-06-03T16:23:23.450Z,1717431803.450 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:23:23.450Z,1717431803.450 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8 2024-06-03T16:23:23.850Z,1717431803.850 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:25:00.003Z,1717431900.003 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-03T16:25:00.003Z,1717431900.003 [Default:CheckIn:C.Wait] Stopped 2024-06-03T16:25:00.004Z,1717431900.004 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-03T16:25:00.004Z,1717431900.004 [Default:CheckIn:D] Running Loop=1 2024-06-03T16:25:00.434Z,1717431900.434 [Default:CheckIn:D] Stopped 2024-06-03T16:25:00.434Z,1717431900.434 [Default:CheckIn:E] Running Loop=1 2024-06-03T16:25:00.830Z,1717431900.830 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.163806 min 2024-06-03T16:25:00.830Z,1717431900.830 [Default:CheckIn:E] Stopped 2024-06-03T16:25:00.830Z,1717431900.830 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-03T16:25:00.830Z,1717431900.830 [Default:CheckIn] Stopped 2024-06-03T16:25:00.830Z,1717431900.830 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-03T16:25:00.831Z,1717431900.831 [Default:CheckIn](INFO): Running loop #3 2024-06-03T16:25:00.831Z,1717431900.831 [Default:CheckIn] Running Loop=3 2024-06-03T16:25:00.831Z,1717431900.831 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-03T16:25:00.831Z,1717431900.831 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-03T16:26:24.031Z,1717431984.031 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2024-06-03T16:26:24.032Z,1717431984.032 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:26:24.033Z,1717431984.033 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9 2024-06-03T16:26:24.033Z,1717431984.033 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:26:24.068Z,1717431984.068 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:26:24.068Z,1717431984.068 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:26:24.445Z,1717431984.445 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:26:24.446Z,1717431984.446 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2024-06-03T16:26:24.446Z,1717431984.446 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:26:24.446Z,1717431984.446 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9 2024-06-03T16:26:24.841Z,1717431984.841 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:29:25.023Z,1717432165.023 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2024-06-03T16:29:25.024Z,1717432165.024 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:29:25.025Z,1717432165.025 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10 2024-06-03T16:29:25.025Z,1717432165.025 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:29:25.035Z,1717432165.035 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:29:25.036Z,1717432165.036 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:29:25.454Z,1717432165.454 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:29:25.454Z,1717432165.454 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2024-06-03T16:29:25.454Z,1717432165.454 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:29:25.454Z,1717432165.454 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10 2024-06-03T16:29:25.856Z,1717432165.856 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:30:00.981Z,1717432200.981 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-06-03T16:25:00.8Z 2024-06-03T16:30:00.981Z,1717432200.981 [Default:CheckIn:Read_GPS] Stopped 2024-06-03T16:30:00.981Z,1717432200.981 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-03T16:30:07.846Z,1717432207.846 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240603T155903/Courier0010.lzma 2024-06-03T16:30:08.849Z,1717432208.849 [DataOverHttps](INFO): Moved sent file to Logs/20240603T155903/Courier0010.lzma.bak 2024-06-03T16:30:08.849Z,1717432208.849 [DataOverHttps](INFO): SBD MOMSN=21112212 2024-06-03T16:30:16.721Z,1717432216.721 [BPC1](INFO): Calculating totals. Valid battery stick count: 50. Valid reserve battery stick count: 5. 2024-06-03T16:30:16.725Z,1717432216.725 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle. 2024-06-03T16:30:24.439Z,1717432224.439 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240603T155903/Express0011.lzma 2024-06-03T16:30:25.441Z,1717432225.441 [DataOverHttps](INFO): Moved sent file to Logs/20240603T155903/Express0011.lzma.bak 2024-06-03T16:30:25.441Z,1717432225.441 [DataOverHttps](INFO): SBD MOMSN=21112214 2024-06-03T16:30:27.721Z,1717432227.721 [Default:CheckIn:Read_Iridium] Stopped 2024-06-03T16:30:27.721Z,1717432227.721 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-03T16:30:27.721Z,1717432227.721 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-03T16:31:22.657Z,1717432282.657 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-06-03T16:31:22.657Z,1717432282.657 [NAL9602] Data Fault, FailCount= 3 2024-06-03T16:31:22.657Z,1717432282.657 [NAL9602](ERROR): Data Fault 2024-06-03T16:31:22.675Z,1717432282.675 [CBIT](ERROR): Data Fault in component: NAL9602 2024-06-03T16:31:23.060Z,1717432283.060 [NAL9602](INFO): Powering down 2024-06-03T16:31:23.886Z,1717432283.886 [CBIT](INFO): Clearing failed state for component NAL9602 2024-06-03T16:31:23.887Z,1717432283.887 [NAL9602] No Fault, FailCount= 3 2024-06-03T16:31:53.360Z,1717432313.360 [NAL9602](INFO): Powering up NAL9602 2024-06-03T16:32:04.276Z,1717432324.276 [NAL9602](INFO): NAL9602 initialized 2024-06-03T16:32:26.108Z,1717432346.108 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2024-06-03T16:32:26.108Z,1717432346.108 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:32:26.109Z,1717432346.109 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 11 2024-06-03T16:32:26.109Z,1717432346.109 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:32:26.160Z,1717432346.160 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:32:26.160Z,1717432346.160 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:32:26.529Z,1717432346.529 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:32:26.529Z,1717432346.529 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2024-06-03T16:32:26.530Z,1717432346.530 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:32:26.530Z,1717432346.530 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 11 2024-06-03T16:32:26.906Z,1717432346.906 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:35:27.105Z,1717432527.105 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2024-06-03T16:35:27.105Z,1717432527.105 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:35:27.106Z,1717432527.106 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 12 2024-06-03T16:35:27.106Z,1717432527.106 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:35:27.139Z,1717432527.139 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:35:27.140Z,1717432527.140 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:35:27.522Z,1717432527.522 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:35:27.522Z,1717432527.522 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2024-06-03T16:35:27.522Z,1717432527.522 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:35:27.522Z,1717432527.522 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 12 2024-06-03T16:35:27.920Z,1717432527.920 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:35:28.301Z,1717432528.301 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-03T16:35:28.301Z,1717432528.301 [Default:CheckIn:C.Wait] Stopped 2024-06-03T16:35:28.302Z,1717432528.302 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-03T16:35:28.302Z,1717432528.302 [Default:CheckIn:D] Running Loop=1 2024-06-03T16:35:28.705Z,1717432528.705 [Default:CheckIn:D] Stopped 2024-06-03T16:35:28.705Z,1717432528.705 [Default:CheckIn:E] Running Loop=1 2024-06-03T16:35:29.109Z,1717432529.109 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.634991 min 2024-06-03T16:35:29.109Z,1717432529.109 [Default:CheckIn:E] Stopped 2024-06-03T16:35:29.110Z,1717432529.110 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-03T16:35:29.110Z,1717432529.110 [Default:CheckIn] Stopped 2024-06-03T16:35:29.110Z,1717432529.110 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-03T16:35:29.110Z,1717432529.110 [Default:CheckIn](INFO): Running loop #4 2024-06-03T16:35:29.110Z,1717432529.110 [Default:CheckIn] Running Loop=4 2024-06-03T16:35:29.110Z,1717432529.110 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-03T16:35:29.110Z,1717432529.110 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-03T16:38:28.084Z,1717432708.084 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2024-06-03T16:38:28.084Z,1717432708.084 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:38:28.085Z,1717432708.085 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 13 2024-06-03T16:38:28.085Z,1717432708.085 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:38:28.096Z,1717432708.096 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:38:28.096Z,1717432708.096 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:38:28.501Z,1717432708.501 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:38:28.502Z,1717432708.502 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2024-06-03T16:38:28.502Z,1717432708.502 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:38:28.502Z,1717432708.502 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 13 2024-06-03T16:38:28.900Z,1717432708.900 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:40:29.298Z,1717432829.298 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-06-03T16:35:29.1Z 2024-06-03T16:40:29.298Z,1717432829.298 [Default:CheckIn:Read_GPS] Stopped 2024-06-03T16:40:29.299Z,1717432829.299 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-03T16:40:38.641Z,1717432838.641 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20240603T155903/Courier0013.lzma 2024-06-03T16:40:39.641Z,1717432839.641 [DataOverHttps](INFO): Moved sent file to Logs/20240603T155903/Courier0013.lzma.bak 2024-06-03T16:40:39.641Z,1717432839.641 [DataOverHttps](INFO): SBD MOMSN=21112245 2024-06-03T16:40:55.124Z,1717432855.124 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240603T155903/Express0014.lzma 2024-06-03T16:40:56.125Z,1717432856.125 [DataOverHttps](INFO): Moved sent file to Logs/20240603T155903/Express0014.lzma.bak 2024-06-03T16:40:56.125Z,1717432856.125 [DataOverHttps](INFO): SBD MOMSN=21112247 2024-06-03T16:40:57.990Z,1717432857.990 [Default:CheckIn:Read_Iridium] Stopped 2024-06-03T16:40:57.990Z,1717432857.990 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-03T16:40:57.990Z,1717432857.990 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-03T16:41:29.095Z,1717432889.095 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2024-06-03T16:41:29.095Z,1717432889.095 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:41:29.096Z,1717432889.096 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 14 2024-06-03T16:41:29.096Z,1717432889.096 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:41:29.108Z,1717432889.108 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:41:29.108Z,1717432889.108 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:41:29.516Z,1717432889.516 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:41:29.517Z,1717432889.517 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2024-06-03T16:41:29.517Z,1717432889.517 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:41:29.517Z,1717432889.517 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 14 2024-06-03T16:41:29.896Z,1717432889.896 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:42:06.244Z,1717432926.244 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-06-03T16:42:06.245Z,1717432926.245 [NAL9602] Data Fault, FailCount= 4 2024-06-03T16:42:06.245Z,1717432926.245 [NAL9602](ERROR): Data Fault 2024-06-03T16:42:06.262Z,1717432926.262 [CBIT](ERROR): Data Fault in component: NAL9602 2024-06-03T16:42:06.649Z,1717432926.649 [NAL9602](INFO): Powering down 2024-06-03T16:42:07.482Z,1717432927.482 [CBIT](INFO): Clearing failed state for component NAL9602 2024-06-03T16:42:07.482Z,1717432927.482 [NAL9602] No Fault, FailCount= 4 2024-06-03T16:42:36.952Z,1717432956.952 [NAL9602](INFO): Powering up NAL9602 2024-06-03T16:42:47.856Z,1717432967.856 [NAL9602](INFO): NAL9602 initialized 2024-06-03T16:44:30.080Z,1717433070.080 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2024-06-03T16:44:30.080Z,1717433070.080 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:44:30.081Z,1717433070.081 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 15 2024-06-03T16:44:30.081Z,1717433070.081 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:44:30.115Z,1717433070.115 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:44:30.116Z,1717433070.116 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:44:30.492Z,1717433070.492 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:44:30.492Z,1717433070.492 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2024-06-03T16:44:30.493Z,1717433070.493 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:44:30.493Z,1717433070.493 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 15 2024-06-03T16:44:30.898Z,1717433070.898 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:45:58.565Z,1717433158.565 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-03T16:45:58.565Z,1717433158.565 [Default:CheckIn:C.Wait] Stopped 2024-06-03T16:45:58.565Z,1717433158.565 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-03T16:45:58.565Z,1717433158.565 [Default:CheckIn:D] Running Loop=1 2024-06-03T16:45:58.985Z,1717433158.985 [Default:CheckIn:D] Stopped 2024-06-03T16:45:58.985Z,1717433158.985 [Default:CheckIn:E] Running Loop=1 2024-06-03T16:45:59.398Z,1717433159.398 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 42.139665 min 2024-06-03T16:45:59.398Z,1717433159.398 [Default:CheckIn:E] Stopped 2024-06-03T16:45:59.398Z,1717433159.398 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-03T16:45:59.398Z,1717433159.398 [Default:CheckIn] Stopped 2024-06-03T16:45:59.398Z,1717433159.398 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-03T16:45:59.399Z,1717433159.399 [Default:CheckIn](INFO): Running loop #5 2024-06-03T16:45:59.399Z,1717433159.399 [Default:CheckIn] Running Loop=5 2024-06-03T16:45:59.399Z,1717433159.399 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-03T16:45:59.399Z,1717433159.399 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-03T16:47:31.091Z,1717433251.091 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2024-06-03T16:47:31.091Z,1717433251.091 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:47:31.092Z,1717433251.092 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 16 2024-06-03T16:47:31.093Z,1717433251.093 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:47:31.135Z,1717433251.135 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:47:31.136Z,1717433251.136 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:47:31.509Z,1717433251.509 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:47:31.509Z,1717433251.509 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2024-06-03T16:47:31.510Z,1717433251.510 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:47:31.510Z,1717433251.510 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 16 2024-06-03T16:47:31.884Z,1717433251.884 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:50:32.128Z,1717433432.128 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2024-06-03T16:50:32.128Z,1717433432.128 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:50:32.129Z,1717433432.129 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 17 2024-06-03T16:50:32.129Z,1717433432.129 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:50:32.183Z,1717433432.183 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:50:32.184Z,1717433432.184 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:50:32.554Z,1717433432.554 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:50:32.554Z,1717433432.554 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2024-06-03T16:50:32.555Z,1717433432.555 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:50:32.555Z,1717433432.555 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 17 2024-06-03T16:50:32.919Z,1717433432.919 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:50:59.616Z,1717433459.616 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-06-03T16:45:59.4Z 2024-06-03T16:50:59.616Z,1717433459.616 [Default:CheckIn:Read_GPS] Stopped 2024-06-03T16:50:59.616Z,1717433459.616 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-03T16:51:06.426Z,1717433466.426 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20240603T155903/Courier0016.lzma 2024-06-03T16:51:07.429Z,1717433467.429 [DataOverHttps](INFO): Moved sent file to Logs/20240603T155903/Courier0016.lzma.bak 2024-06-03T16:51:07.429Z,1717433467.429 [DataOverHttps](INFO): SBD MOMSN=21112277 2024-06-03T16:51:22.955Z,1717433482.955 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20240603T155903/Express0017.lzma 2024-06-03T16:51:23.957Z,1717433483.957 [DataOverHttps](INFO): Moved sent file to Logs/20240603T155903/Express0017.lzma.bak 2024-06-03T16:51:23.957Z,1717433483.957 [DataOverHttps](INFO): SBD MOMSN=21112279 2024-06-03T16:51:25.872Z,1717433485.872 [Default:CheckIn:Read_Iridium] Stopped 2024-06-03T16:51:25.873Z,1717433485.873 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-03T16:51:25.873Z,1717433485.873 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-03T16:52:49.064Z,1717433569.064 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-06-03T16:52:49.064Z,1717433569.064 [NAL9602] Data Fault, FailCount= 5 2024-06-03T16:52:49.064Z,1717433569.064 [NAL9602](ERROR): Data Fault 2024-06-03T16:52:49.082Z,1717433569.082 [CBIT](ERROR): Data Fault in component: NAL9602 2024-06-03T16:52:49.083Z,1717433569.083 [CBIT](CRITICAL): Data Fault in component: NAL9602 2024-06-03T16:52:49.468Z,1717433569.468 [NAL9602](INFO): Powering down 2024-06-03T16:52:49.493Z,1717433569.493 [CommandExec](FAULT): Scheduling is paused 2024-06-03T16:52:49.493Z,1717433569.493 [CBIT](INFO): Critical error at 20240603T165249 2024-06-03T16:52:49.493Z,1717433569.493 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2024-06-03T16:53:33.106Z,1717433613.106 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18 2024-06-03T16:53:33.106Z,1717433613.106 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:53:33.108Z,1717433613.108 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 18 2024-06-03T16:53:33.108Z,1717433613.108 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:53:33.142Z,1717433613.142 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:53:33.147Z,1717433613.147 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:53:33.520Z,1717433613.520 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:53:33.520Z,1717433613.520 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18 2024-06-03T16:53:33.521Z,1717433613.521 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:53:33.521Z,1717433613.521 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 18 2024-06-03T16:53:33.914Z,1717433613.914 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:54:49.093Z,1717433689.093 [CBIT](INFO): Clearing failed state for component NAL9602 2024-06-03T16:54:49.093Z,1717433689.093 [NAL9602] No Fault, FailCount= 5 2024-06-03T16:54:49.485Z,1717433689.485 [NAL9602](INFO): Powering up NAL9602 2024-06-03T16:55:00.388Z,1717433700.388 [NAL9602](INFO): NAL9602 initialized 2024-06-03T16:56:26.449Z,1717433786.449 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-06-03T16:56:26.449Z,1717433786.449 [Default:CheckIn:C.Wait] Stopped 2024-06-03T16:56:26.449Z,1717433786.449 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-03T16:56:26.449Z,1717433786.449 [Default:CheckIn:D] Running Loop=1 2024-06-03T16:56:26.853Z,1717433786.853 [Default:CheckIn:D] Stopped 2024-06-03T16:56:26.853Z,1717433786.853 [Default:CheckIn:E] Running Loop=1 2024-06-03T16:56:27.274Z,1717433787.274 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.604126 min 2024-06-03T16:56:27.274Z,1717433787.274 [Default:CheckIn:E] Stopped 2024-06-03T16:56:27.274Z,1717433787.274 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-06-03T16:56:27.274Z,1717433787.274 [Default:CheckIn] Stopped 2024-06-03T16:56:27.274Z,1717433787.274 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-03T16:56:27.275Z,1717433787.275 [Default:CheckIn](INFO): Running loop #6 2024-06-03T16:56:27.275Z,1717433787.275 [Default:CheckIn] Running Loop=6 2024-06-03T16:56:27.275Z,1717433787.275 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-06-03T16:56:27.275Z,1717433787.275 [Default:CheckIn:Read_GPS] Running Loop=1 2024-06-03T16:56:34.140Z,1717433794.140 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19 2024-06-03T16:56:34.140Z,1717433794.140 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:56:34.141Z,1717433794.141 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 19 2024-06-03T16:56:34.141Z,1717433794.141 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:56:34.180Z,1717433794.180 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:56:34.180Z,1717433794.180 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:56:34.539Z,1717433794.539 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:56:34.539Z,1717433794.539 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19 2024-06-03T16:56:34.540Z,1717433794.540 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:56:34.540Z,1717433794.540 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 19 2024-06-03T16:56:34.938Z,1717433794.938 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T16:59:35.126Z,1717433975.126 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20 2024-06-03T16:59:35.126Z,1717433975.126 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-06-03T16:59:35.127Z,1717433975.127 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 20 2024-06-03T16:59:35.127Z,1717433975.127 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-06-03T16:59:35.138Z,1717433975.138 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-06-03T16:59:35.138Z,1717433975.138 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-06-03T16:59:35.544Z,1717433975.544 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-06-03T16:59:35.544Z,1717433975.544 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20 2024-06-03T16:59:35.545Z,1717433975.545 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-06-03T16:59:35.545Z,1717433975.545 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 20 2024-06-03T16:59:35.924Z,1717433975.924 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-06-03T17:01:27.458Z,1717434087.458 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-06-03T16:56:27.3Z 2024-06-03T17:01:27.458Z,1717434087.458 [Default:CheckIn:Read_GPS] Stopped 2024-06-03T17:01:27.458Z,1717434087.458 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-06-03T17:01:34.278Z,1717434094.278 [DataOverHttps](INFO): Sending 104 bytes from file Logs/20240603T155903/Courier0019.lzma 2024-06-03T17:01:35.281Z,1717434095.281 [DataOverHttps](INFO): Moved sent file to Logs/20240603T155903/Courier0019.lzma.bak 2024-06-03T17:01:35.281Z,1717434095.281 [DataOverHttps](INFO): SBD MOMSN=21112309 2024-06-03T17:01:51.947Z,1717434111.947 [DataOverHttps](INFO): Sending 202 bytes from file Logs/20240603T155903/Express0020.lzma 2024-06-03T17:01:52.949Z,1717434112.949 [DataOverHttps](INFO): Moved sent file to Logs/20240603T155903/Express0020.lzma.bak 2024-06-03T17:01:52.949Z,1717434112.949 [DataOverHttps](INFO): SBD MOMSN=21112312 2024-06-03T17:01:54.922Z,1717434114.922 [Default:CheckIn:Read_Iridium] Stopped 2024-06-03T17:01:54.922Z,1717434114.922 [Default:CheckIn:C.Wait] Running Loop=1 2024-06-03T17:01:54.922Z,1717434114.922 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-06-03T17:02:21.016Z,1717434141.016 [CommandExec](IMPORTANT): got command quit 2024-06-03T17:02:22.019Z,1717434142.019 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T17:02:22.019Z,1717434142.019 [CommandExec](INFO): Uninitializing the command executive. 2024-06-03T17:02:22.019Z,1717434142.019 [CommandExec](INFO): Uninitializing the command scheduler. 2024-06-03T17:02:22.020Z,1717434142.020 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:22.143Z,1717434142.143 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-06-03T17:02:22.143Z,1717434142.143 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-06-03T17:02:22.143Z,1717434142.143 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:22.144Z,1717434142.144 [NavChartDb](INFO): Join timeout helper Thread ID is 1005 2024-06-03T17:02:22.479Z,1717434142.479 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T17:02:22.479Z,1717434142.479 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:22.487Z,1717434142.487 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-06-03T17:02:22.487Z,1717434142.487 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:22.487Z,1717434142.487 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1006 2024-06-03T17:02:22.495Z,1717434142.495 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T17:02:22.495Z,1717434142.495 [WetLabsBB2FL](INFO): Powering down 2024-06-03T17:02:22.496Z,1717434142.496 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:22.507Z,1717434142.507 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-06-03T17:02:22.507Z,1717434142.507 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:22.507Z,1717434142.507 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1007 2024-06-03T17:02:23.255Z,1717434143.255 [CTD_Seabird](INFO): Powering down 2024-06-03T17:02:23.267Z,1717434143.267 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T17:02:23.267Z,1717434143.267 [CTD_Seabird](INFO): Powering down 2024-06-03T17:02:23.279Z,1717434143.279 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:23.295Z,1717434143.295 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-06-03T17:02:23.295Z,1717434143.295 [DAT ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:23.296Z,1717434143.296 [DAT](INFO): Join timeout helper Thread ID is 1008 2024-06-03T17:02:23.399Z,1717434143.399 [DAT](INFO): Powering down 2024-06-03T17:02:23.472Z,1717434143.472 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T17:02:23.472Z,1717434143.472 [DAT](INFO): Powering down 2024-06-03T17:02:23.473Z,1717434143.473 [DAT ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:23.475Z,1717434143.475 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-06-03T17:02:23.475Z,1717434143.475 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:23.475Z,1717434143.475 [Radio_Surface](INFO): Join timeout helper Thread ID is 1009 2024-06-03T17:02:23.667Z,1717434143.667 [Radio_Surface](INFO): Powering down 2024-06-03T17:02:23.668Z,1717434143.668 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T17:02:23.668Z,1717434143.668 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:23.685Z,1717434143.685 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-06-03T17:02:23.685Z,1717434143.685 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:23.686Z,1717434143.686 [Onboard](INFO): Join timeout helper Thread ID is 1010 2024-06-03T17:02:24.279Z,1717434144.279 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-06-03T17:02:25.571Z,1717434145.571 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T17:02:25.571Z,1717434145.571 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:25.592Z,1717434145.592 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-06-03T17:02:25.592Z,1717434145.592 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:25.592Z,1717434145.592 [DataOverHttps](INFO): Join timeout helper Thread ID is 1011 2024-06-03T17:02:26.287Z,1717434146.287 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T17:02:26.287Z,1717434146.287 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:26.307Z,1717434146.307 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-06-03T17:02:26.307Z,1717434146.307 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:26.307Z,1717434146.307 [BackseatComponent](INFO): Join timeout helper Thread ID is 1012 2024-06-03T17:02:26.355Z,1717434146.355 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T17:02:26.356Z,1717434146.356 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:26.368Z,1717434146.368 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-06-03T17:02:26.368Z,1717434146.368 [logger ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:26.368Z,1717434146.368 [logger](INFO): Join timeout helper Thread ID is 1013 2024-06-03T17:02:26.407Z,1717434146.407 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T17:02:26.407Z,1717434146.407 [logger ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:26.409Z,1717434146.409 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-06-03T17:02:26.409Z,1717434146.409 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:26.409Z,1717434146.409 [CommandLine](INFO): Join timeout helper Thread ID is 1014 2024-06-03T17:02:26.411Z,1717434146.411 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T17:02:26.412Z,1717434146.412 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:26.420Z,1717434146.420 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-06-03T17:02:26.420Z,1717434146.420 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:26.420Z,1717434146.420 [CommandExec](INFO): Join timeout helper Thread ID is 1015 2024-06-03T17:02:26.424Z,1717434146.424 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-06-03T17:02:26.424Z,1717434146.424 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:26.424Z,1717434146.424 [controlThread](INFO): Join timeout helper Thread ID is 1016 2024-06-03T17:02:26.444Z,1717434146.444 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-06-03T17:02:26.444Z,1717434146.444 [controlThread](DEBUG): Uninitializing ControlThread 2024-06-03T17:02:26.445Z,1717434146.445 [AHRS_M2](INFO): Powering down 2024-06-03T17:02:26.516Z,1717434146.516 [NAL9602](INFO): Powering down 2024-06-03T17:02:26.517Z,1717434146.517 [Sonardyne_Nano](INFO): Powering down 2024-06-03T17:02:26.635Z,1717434146.635 [Waterlinked](INFO): Powering down 2024-06-03T17:02:26.637Z,1717434146.637 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-06-03T17:02:26.637Z,1717434146.637 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-06-03T17:02:26.638Z,1717434146.638 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-06-03T17:02:26.639Z,1717434146.639 [MissionManager](INFO): Uninitializing Mission Default 2024-06-03T17:02:26.639Z,1717434146.639 [Default] Stopped 2024-06-03T17:02:26.639Z,1717434146.639 [Default](DEBUG): Aggregate::uninitialize Default 2024-06-03T17:02:26.639Z,1717434146.639 [Default:B.GoToSurface] Stopped 2024-06-03T17:02:26.639Z,1717434146.639 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-06-03T17:02:26.639Z,1717434146.639 [Default:CheckIn] Stopped 2024-06-03T17:02:26.639Z,1717434146.639 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-06-03T17:02:26.639Z,1717434146.639 [Default:CheckIn:C.Wait] Stopped 2024-06-03T17:02:26.639Z,1717434146.639 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-06-03T17:02:26.642Z,1717434146.642 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-06-03T17:02:26.642Z,1717434146.642 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-06-03T17:02:26.643Z,1717434146.643 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-06-03T17:02:26.643Z,1717434146.643 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-06-03T17:02:26.643Z,1717434146.643 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-06-03T17:02:26.643Z,1717434146.643 [BuoyancyServo](INFO): Powering down 2024-06-03T17:02:26.655Z,1717434146.655 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-06-03T17:02:26.655Z,1717434146.655 [ElevatorServo](INFO): Powering down 2024-06-03T17:02:26.656Z,1717434146.656 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-06-03T17:02:26.656Z,1717434146.656 [MassServo](INFO): Powering down 2024-06-03T17:02:26.657Z,1717434146.657 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-06-03T17:02:26.657Z,1717434146.657 [RudderServo](INFO): Powering down 2024-06-03T17:02:26.658Z,1717434146.658 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-06-03T17:02:26.658Z,1717434146.658 [ThrusterHE](INFO): Powering down 2024-06-03T17:02:26.659Z,1717434146.659 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-06-03T17:02:26.659Z,1717434146.659 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-06-03T17:02:26.659Z,1717434146.659 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-06-03T17:02:26.660Z,1717434146.660 [CBIT](DEBUG): Powering off loads. 2024-06-03T17:02:26.671Z,1717434146.671 [CBIT](DEBUG): Disabling WDT. 2024-06-03T17:02:26.683Z,1717434146.683 [CBIT](DEBUG): Opening all GF detection circuits. 2024-06-03T17:02:26.684Z,1717434146.684 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:26.702Z,1717434146.702 [DAT ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:26.707Z,1717434146.707 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:26.709Z,1717434146.709 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:26.714Z,1717434146.714 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:26.758Z,1717434146.758 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:26.806Z,1717434146.806 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:26.810Z,1717434146.810 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:26.862Z,1717434146.862 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-06-03T17:02:26.911Z,1717434146.911 [logger ThreadHandler](INFO): Thread cancelled.