2024-07-19T01:04:19.733Z,1721351059.733 [Supervisor](DEBUG): Initializing supervisor. 2024-07-19T01:04:19.737Z,1721351059.737 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-07-19T01:04:19.738Z,1721351059.738 [SyncHandler](INFO): Protected caller Thread ID is 837 2024-07-19T01:04:19.738Z,1721351059.738 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-07-19T01:04:19.739Z,1721351059.739 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-07-19T01:04:19.739Z,1721351059.739 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 838 2024-07-19T01:04:19.743Z,1721351059.743 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-07-19T01:04:19.761Z,1721351059.761 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-07-19T01:04:19.762Z,1721351059.762 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-07-19T01:04:19.762Z,1721351059.762 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 839 2024-07-19T01:04:19.766Z,1721351059.766 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-07-19T01:04:19.767Z,1721351059.767 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-07-19T01:04:19.768Z,1721351059.768 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 840 2024-07-19T01:04:19.770Z,1721351059.770 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-07-19T01:04:19.771Z,1721351059.771 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-07-19T01:04:19.771Z,1721351059.771 [logger ThreadHandler](INFO): Protected caller Thread ID is 841 2024-07-19T01:04:19.775Z,1721351059.775 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-07-19T01:04:19.775Z,1721351059.775 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-07-19T01:04:19.779Z,1721351059.779 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-07-19T01:04:20.272Z,1721351060.272 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-07-19T01:04:20.274Z,1721351060.274 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-07-19T01:04:20.505Z,1721351060.505 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-07-19T01:04:20.507Z,1721351060.507 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-07-19T01:04:20.599Z,1721351060.599 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-07-19T01:04:20.852Z,1721351060.852 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-07-19T01:04:20.854Z,1721351060.854 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-07-19T01:04:20.946Z,1721351060.946 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-07-19T01:04:21.055Z,1721351061.055 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-07-19T01:04:21.057Z,1721351061.057 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-07-19T01:04:21.421Z,1721351061.421 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-07-19T01:04:21.422Z,1721351061.422 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-07-19T01:04:21.569Z,1721351061.569 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-07-19T01:04:21.570Z,1721351061.570 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-07-19T01:04:22.132Z,1721351062.132 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-07-19T01:04:22.133Z,1721351062.133 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-07-19T01:04:22.337Z,1721351062.337 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-07-19T01:04:22.339Z,1721351062.339 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-07-19T01:04:22.770Z,1721351062.770 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-07-19T01:04:22.771Z,1721351062.771 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-07-19T01:04:23.172Z,1721351063.172 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-07-19T01:04:23.172Z,1721351063.172 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-07-19T01:04:23.848Z,1721351063.848 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-07-19T01:04:23.945Z,1721351063.945 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-07-19T01:04:24.831Z,1721351064.831 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-07-19T01:04:24.833Z,1721351064.833 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-07-19T01:04:25.210Z,1721351065.210 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-07-19T01:04:25.212Z,1721351065.212 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-07-19T01:04:25.459Z,1721351065.459 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-07-19T01:04:25.461Z,1721351065.461 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/ 2024-07-19T01:04:25.463Z,1721351065.463 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg 2024-07-19T01:04:25.594Z,1721351065.594 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg 2024-07-19T01:04:25.690Z,1721351065.690 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg 2024-07-19T01:04:25.840Z,1721351065.840 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg 2024-07-19T01:04:25.938Z,1721351065.938 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg 2024-07-19T01:04:26.212Z,1721351066.212 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-07-19T01:04:26.213Z,1721351066.213 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg 2024-07-19T01:04:26.331Z,1721351066.331 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg 2024-07-19T01:04:26.452Z,1721351066.452 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg 2024-07-19T01:04:26.572Z,1721351066.572 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg 2024-07-19T01:04:26.736Z,1721351066.736 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg 2024-07-19T01:04:26.847Z,1721351066.847 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg 2024-07-19T01:04:26.944Z,1721351066.944 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-07-19T01:04:26.956Z,1721351066.956 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-07-19T01:04:26.971Z,1721351066.971 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-07-19T01:04:26.972Z,1721351066.972 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-07-19T01:04:27.122Z,1721351067.122 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-07-19T01:04:27.123Z,1721351067.123 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-07-19T01:04:27.192Z,1721351067.192 [VerticalControl](DEBUG): Construct VerticalControl. 2024-07-19T01:04:27.254Z,1721351067.254 [VerticalControl] Loaded 2024-07-19T01:04:27.255Z,1721351067.255 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-07-19T01:04:27.257Z,1721351067.257 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-07-19T01:04:27.306Z,1721351067.306 [HorizontalControl] Loaded 2024-07-19T01:04:27.306Z,1721351067.306 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-07-19T01:04:27.308Z,1721351067.308 [SpeedControl](DEBUG): Construct SpeedControl. 2024-07-19T01:04:27.311Z,1721351067.311 [SpeedControl] Loaded 2024-07-19T01:04:27.312Z,1721351067.312 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-07-19T01:04:27.314Z,1721351067.314 [LoopControl](DEBUG): Construct LoopControl. 2024-07-19T01:04:27.315Z,1721351067.315 [LoopControl] Loaded 2024-07-19T01:04:27.315Z,1721351067.315 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-07-19T01:04:27.315Z,1721351067.315 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-07-19T01:04:27.317Z,1721351067.317 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-07-19T01:04:27.506Z,1721351067.506 [BuoyancyServo] Loaded 2024-07-19T01:04:27.506Z,1721351067.506 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-07-19T01:04:27.528Z,1721351067.528 [ElevatorServo] Loaded 2024-07-19T01:04:27.528Z,1721351067.528 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-07-19T01:04:27.549Z,1721351067.549 [MassServo] Loaded 2024-07-19T01:04:27.549Z,1721351067.549 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-07-19T01:04:27.570Z,1721351067.570 [RudderServo] Loaded 2024-07-19T01:04:27.570Z,1721351067.570 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-07-19T01:04:27.586Z,1721351067.586 [ThrusterHE] Loaded 2024-07-19T01:04:27.587Z,1721351067.587 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-07-19T01:04:27.587Z,1721351067.587 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-07-19T01:04:27.588Z,1721351067.588 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-07-19T01:04:27.658Z,1721351067.658 [DepthRateCalculator] Loaded 2024-07-19T01:04:27.658Z,1721351067.658 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-07-19T01:04:27.663Z,1721351067.663 [PitchRateCalculator] Loaded 2024-07-19T01:04:27.663Z,1721351067.663 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-07-19T01:04:27.673Z,1721351067.673 [SpeedCalculator] Loaded 2024-07-19T01:04:27.673Z,1721351067.673 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-07-19T01:04:27.677Z,1721351067.677 [YawRateCalculator] Loaded 2024-07-19T01:04:27.678Z,1721351067.678 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-07-19T01:04:27.696Z,1721351067.696 [ElevatorOffsetCalculator] Loaded 2024-07-19T01:04:27.696Z,1721351067.696 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-07-19T01:04:27.697Z,1721351067.697 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-07-19T01:04:27.697Z,1721351067.697 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-07-19T01:04:27.835Z,1721351067.835 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-07-19T01:04:27.835Z,1721351067.835 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-07-19T01:04:27.848Z,1721351067.848 [NavChart] Loaded 2024-07-19T01:04:27.849Z,1721351067.849 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-07-19T01:04:27.854Z,1721351067.854 [UniversalFixResidualReporter] Loaded 2024-07-19T01:04:27.855Z,1721351067.855 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-07-19T01:04:27.855Z,1721351067.855 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-07-19T01:04:27.856Z,1721351067.856 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-07-19T01:04:28.612Z,1721351068.612 [AHRS_M2] Loaded 2024-07-19T01:04:28.612Z,1721351068.612 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-07-19T01:04:28.866Z,1721351068.866 [BackseatComponent] Loaded 2024-07-19T01:04:28.866Z,1721351068.866 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-07-19T01:04:28.867Z,1721351068.867 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4090B4E0 2024-07-19T01:04:28.868Z,1721351068.868 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 923 2024-07-19T01:04:28.871Z,1721351068.871 [LcmUniversalReporter] Loaded 2024-07-19T01:04:28.871Z,1721351068.871 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-07-19T01:04:28.877Z,1721351068.877 [BioacousticsDataBridge] Loaded 2024-07-19T01:04:28.877Z,1721351068.877 [ComponentRegistry](DEBUG): SyncComponent "BioacousticsDataBridge" handled in the control thread. 2024-07-19T01:04:29.706Z,1721351069.706 [BPC1] Loaded 2024-07-19T01:04:29.706Z,1721351069.706 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-07-19T01:04:29.846Z,1721351069.846 [DataOverHttps] Loaded 2024-07-19T01:04:29.846Z,1721351069.846 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-07-19T01:04:29.847Z,1721351069.847 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 4093B4E0 2024-07-19T01:04:29.847Z,1721351069.847 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 924 2024-07-19T01:04:29.871Z,1721351069.871 [Depth_Keller] Loaded 2024-07-19T01:04:29.871Z,1721351069.871 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-07-19T01:04:29.876Z,1721351069.876 [DropWeight] Loaded 2024-07-19T01:04:29.876Z,1721351069.876 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-07-19T01:04:29.940Z,1721351069.940 [NAL9602] Loaded 2024-07-19T01:04:29.940Z,1721351069.940 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-07-19T01:04:29.970Z,1721351069.970 [Onboard] Loaded 2024-07-19T01:04:29.970Z,1721351069.970 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-07-19T01:04:29.971Z,1721351069.971 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 4096B4E0 2024-07-19T01:04:29.972Z,1721351069.972 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 925 2024-07-19T01:04:29.986Z,1721351069.986 [Power24vConverter] Loaded 2024-07-19T01:04:29.986Z,1721351069.986 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-07-19T01:04:30.002Z,1721351070.002 [Radio_Surface] Loaded 2024-07-19T01:04:30.002Z,1721351070.002 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-07-19T01:04:30.003Z,1721351070.003 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4099B4E0 2024-07-19T01:04:30.004Z,1721351070.004 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 926 2024-07-19T01:04:30.019Z,1721351070.019 [Sonardyne_Nano] Loaded 2024-07-19T01:04:30.019Z,1721351070.019 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-07-19T01:04:30.020Z,1721351070.020 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-07-19T01:04:30.020Z,1721351070.020 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-07-19T01:04:30.621Z,1721351070.621 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-07-19T01:04:30.622Z,1721351070.622 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-07-19T01:04:31.069Z,1721351071.069 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-07-19T01:04:31.069Z,1721351071.069 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-07-19T01:04:31.114Z,1721351071.114 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-07-19T01:04:31.115Z,1721351071.115 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-07-19T01:04:31.336Z,1721351071.336 [CTD_Seabird] Loaded 2024-07-19T01:04:31.337Z,1721351071.337 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-07-19T01:04:31.338Z,1721351071.338 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40ADB4E0 2024-07-19T01:04:31.338Z,1721351071.338 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 927 2024-07-19T01:04:31.361Z,1721351071.361 [PAR_Licor] Loaded 2024-07-19T01:04:31.361Z,1721351071.361 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-07-19T01:04:31.406Z,1721351071.406 [WetLabsBB2FL] Loaded 2024-07-19T01:04:31.406Z,1721351071.406 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-07-19T01:04:31.407Z,1721351071.407 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B0B4E0 2024-07-19T01:04:31.408Z,1721351071.408 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 928 2024-07-19T01:04:31.409Z,1721351071.409 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-07-19T01:04:31.409Z,1721351071.409 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-07-19T01:04:31.804Z,1721351071.804 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-07-19T01:04:31.805Z,1721351071.805 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-07-19T01:04:31.979Z,1721351071.979 [SBIT](DEBUG): Construct Startup Built In Test. 2024-07-19T01:04:31.988Z,1721351071.988 [SBIT] Loaded 2024-07-19T01:04:31.988Z,1721351071.988 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-07-19T01:04:31.991Z,1721351071.991 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-07-19T01:04:32.004Z,1721351072.004 [IBIT] Loaded 2024-07-19T01:04:32.005Z,1721351072.005 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-07-19T01:04:32.011Z,1721351072.011 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-07-19T01:04:32.116Z,1721351072.116 [CBIT] Loaded 2024-07-19T01:04:32.116Z,1721351072.116 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-07-19T01:04:32.116Z,1721351072.116 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-07-19T01:04:32.123Z,1721351072.123 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-07-19T01:04:32.125Z,1721351072.125 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-07-19T01:04:32.137Z,1721351072.137 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-07-19T01:04:32.138Z,1721351072.138 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C074E0 2024-07-19T01:04:32.139Z,1721351072.139 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 929 2024-07-19T01:04:32.143Z,1721351072.143 [Supervisor](INFO): Main Thread ID is 830 2024-07-19T01:04:32.143Z,1721351072.143 [Supervisor](DEBUG): Running supervisor. 2024-07-19T01:04:32.144Z,1721351072.144 [CommandExec ThreadHandler](INFO): Handler Thread ID is 930 2024-07-19T01:04:32.144Z,1721351072.144 [CommandExec](INFO): Initializing the command executive. 2024-07-19T01:04:32.146Z,1721351072.146 [CommandLine ThreadHandler](INFO): Handler Thread ID is 931 2024-07-19T01:04:32.148Z,1721351072.148 [controlThread ThreadHandler](INFO): Handler Thread ID is 932 2024-07-19T01:04:32.148Z,1721351072.148 [controlThread](DEBUG): Initializing ControlThread 2024-07-19T01:04:32.149Z,1721351072.149 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-07-19T01:04:32.151Z,1721351072.151 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-07-19T01:04:32.151Z,1721351072.151 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-07-19T01:04:32.152Z,1721351072.152 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-07-19T01:04:32.153Z,1721351072.153 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-07-19T01:04:32.154Z,1721351072.154 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-07-19T01:04:32.154Z,1721351072.154 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-07-19T01:04:32.154Z,1721351072.154 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-07-19T01:04:32.154Z,1721351072.154 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-07-19T01:04:32.156Z,1721351072.156 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-07-19T01:04:32.156Z,1721351072.156 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-07-19T01:04:32.162Z,1721351072.162 [SBIT](INFO): Initialize SBIT Component. 2024-07-19T01:04:32.163Z,1721351072.163 [SBIT](IMPORTANT): git: 2024-07-18 2024-07-19T01:04:32.163Z,1721351072.163 [SBIT](INFO): git hash: e777c895b2d7d743d45b75a88845e2c8d3f60819 2024-07-19T01:04:32.163Z,1721351072.163 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-07-19T01:04:32.164Z,1721351072.164 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2024-07-19T01:04:32.165Z,1721351072.165 [SBIT](INFO): Beginning SBIT in 110.000000 seconds. 2024-07-19T01:04:32.166Z,1721351072.166 [IBIT](INFO): Initialize IBIT Component. 2024-07-19T01:04:32.167Z,1721351072.167 [CBIT](DEBUG): Initialize CBIT Component. 2024-07-19T01:04:32.168Z,1721351072.168 [logger ThreadHandler](INFO): Handler Thread ID is 933 2024-07-19T01:04:32.178Z,1721351072.178 [CBIT](DEBUG): Initialized mux pins. 2024-07-19T01:04:32.178Z,1721351072.178 [CBIT](DEBUG): Initializing the watchdog timer. 2024-07-19T01:04:32.186Z,1721351072.186 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 934 2024-07-19T01:04:32.198Z,1721351072.198 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 935 2024-07-19T01:04:32.200Z,1721351072.200 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-07-19T01:04:32.202Z,1721351072.202 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-07-19T01:04:32.207Z,1721351072.207 [Onboard ThreadHandler](INFO): Handler Thread ID is 936 2024-07-19T01:04:32.208Z,1721351072.208 [CBIT](FAULT): Found backtrace file: 1721350609.438418 [NavChartDb]: SIGSEGV: address not mapped to object 1721350609.438418 [NavChartDb]: Backtrace: ./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x1b3ca8] ./bin/LRAUV(_ZN10NavChartDb10addEncDataEPNS_7EncInfoE+0x130) [0x14b618] ./bin/LRAUV(_ZN10NavChartDb3runEv+0x110) [0x14d8e4] ./bin/LRAUV(_ZN9Component15executeRunStateEv+0x5c) [0xeeec8] ./bin/LRAUV(_ZN7PCaller10PThreadRunEPv+0xc8) [0x1b36f4] 2024-07-19T01:04:32.211Z,1721351072.211 [CBIT](FAULT): Renaming backtrace file to Data/backtrace11 2024-07-19T01:04:32.212Z,1721351072.212 [CBIT](DEBUG): Initializing heartbeat. 2024-07-19T01:04:32.232Z,1721351072.232 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 937 2024-07-19T01:04:32.242Z,1721351072.242 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 938 2024-07-19T01:04:32.244Z,1721351072.244 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-07-19T01:04:32.247Z,1721351072.247 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 940 2024-07-19T01:04:32.251Z,1721351072.251 [WetLabsBB2FL](INFO): Powering up 2024-07-19T01:04:32.258Z,1721351072.258 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 942 2024-07-19T01:04:32.264Z,1721351072.264 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2MI60M.000 2024-07-19T01:04:32.266Z,1721351072.266 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US2MI60M.000 2024-07-19T01:04:32.266Z,1721351072.266 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI1ND.000 2024-07-19T01:04:32.268Z,1721351072.268 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4MI1ND.000 2024-07-19T01:04:32.268Z,1721351072.268 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI1OD.000 2024-07-19T01:04:32.269Z,1721351072.269 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4MI1OD.000 2024-07-19T01:04:32.270Z,1721351072.270 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI51M.000 2024-07-19T01:04:32.271Z,1721351072.271 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4MI51M.000 2024-07-19T01:04:32.271Z,1721351072.271 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI1OF.000 2024-07-19T01:04:32.273Z,1721351072.273 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4MI1OF.000 2024-07-19T01:04:32.273Z,1721351072.273 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4MI1NF.000 2024-07-19T01:04:32.275Z,1721351072.275 [NavChartDb](IMPORTANT): Will load Electronic Nav Chart data from US4MI1NF.000 2024-07-19T01:04:32.277Z,1721351072.277 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4MI1NF.000 2024-07-19T01:04:32.282Z,1721351072.282 [CBIT](DEBUG): Deactivating GF circuits. 2024-07-19T01:04:32.282Z,1721351072.282 [CBIT](DEBUG): Deactivating emergency mode. 2024-07-19T01:04:32.322Z,1721351072.322 [CBIT](DEBUG): Backplane powered. 2024-07-19T01:04:32.323Z,1721351072.323 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-07-19T01:04:32.323Z,1721351072.323 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-07-19T01:04:32.324Z,1721351072.324 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-07-19T01:04:32.330Z,1721351072.330 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-07-19T01:04:32.365Z,1721351072.365 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-07-19T01:04:32.369Z,1721351072.369 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-07-19T01:04:32.406Z,1721351072.406 [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-07-19T01:04:32.407Z,1721351072.407 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-07-19T01:04:32.407Z,1721351072.407 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-07-19T01:04:32.414Z,1721351072.414 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-07-19T01:04:32.598Z,1721351072.598 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4MI1NF.000 2024-07-19T01:04:32.634Z,1721351072.634 [Radio_Surface](INFO): Powering up 2024-07-19T01:04:32.659Z,1721351072.659 [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-07-19T01:04:32.679Z,1721351072.679 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-07-19T01:04:32.680Z,1721351072.680 [Default:A.Wait](DEBUG): Construct Wait. 2024-07-19T01:04:32.682Z,1721351072.682 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-07-19T01:04:32.751Z,1721351072.751 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-07-19T01:04:32.753Z,1721351072.753 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-07-19T01:04:32.782Z,1721351072.782 [Default:E.Execute](DEBUG): Construct Execute. 2024-07-19T01:04:32.800Z,1721351072.800 [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-07-19T01:04:32.804Z,1721351072.804 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BioacousticsDataBridge,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,Sonardyne_Nano,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2024-07-19T01:04:32.823Z,1721351072.823 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-07-19T01:04:32.972Z,1721351072.972 [Power24vConverter](INFO): Powering up. 2024-07-19T01:04:32.973Z,1721351072.973 [Sonardyne_Nano](INFO): Initializing. 2024-07-19T01:04:33.036Z,1721351073.036 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-07-19T01:04:33.042Z,1721351073.042 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-07-19T01:04:33.043Z,1721351073.043 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-07-19T01:04:33.050Z,1721351073.050 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-07-19T01:04:33.051Z,1721351073.051 [MassServo](DEBUG): Initializing EZServoServo. 2024-07-19T01:04:33.058Z,1721351073.058 [MassServo](DEBUG): Initializing MassServo. 2024-07-19T01:04:33.059Z,1721351073.059 [RudderServo](DEBUG): Initializing EZServoServo. 2024-07-19T01:04:33.066Z,1721351073.066 [RudderServo](DEBUG): Initializing RudderServo. 2024-07-19T01:04:33.067Z,1721351073.067 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-07-19T01:04:33.074Z,1721351073.074 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-07-19T01:04:34.358Z,1721351074.358 [WetLabsBB2FL](INFO): Powering down 2024-07-19T01:04:35.241Z,1721351075.241 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-07-19T01:04:36.475Z,1721351076.475 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2107 2024-07-19T01:04:38.743Z,1721351078.743 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-07-19T01:04:39.210Z,1721351079.210 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4MI1NF.000 2024-07-19T01:04:44.291Z,1721351084.291 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4MI1NF.000 2024-07-19T01:04:46.683Z,1721351086.683 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4MI1NF.000 2024-07-19T01:04:46.705Z,1721351086.705 [NavChartDb](INFO): # of records loaded: 4667 2024-07-19T01:04:46.710Z,1721351086.710 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4MI1NF.000 2024-07-19T01:04:46.778Z,1721351086.778 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4MI1OF.000 2024-07-19T01:04:49.615Z,1721351089.615 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4MI1OF.000 2024-07-19T01:04:59.715Z,1721351099.715 [NavChartDb](INFO): # of records loaded: 5000 2024-07-19T01:05:00.288Z,1721351100.288 [NAL9602](INFO): Powering up NAL9602 2024-07-19T01:05:07.055Z,1721351107.055 [NavChartDb](INFO): # of records loaded: 10000 2024-07-19T01:05:11.208Z,1721351111.208 [NAL9602](INFO): NAL9602 initialized 2024-07-19T01:05:14.537Z,1721351114.537 [NavChartDb](INFO): # of records loaded: 15000 2024-07-19T01:05:24.197Z,1721351124.197 [NavChartDb](INFO): # of records loaded: 20000 2024-07-19T01:05:31.667Z,1721351131.667 [NavChartDb](INFO): # of records loaded: 25000 2024-07-19T01:05:39.337Z,1721351139.337 [NavChartDb](INFO): # of records loaded: 30000 2024-07-19T01:05:41.109Z,1721351141.109 [NAL9602](INFO): SBD MO Status=2, MOMSN=5274, MT Status=2, MTMSN=0 2024-07-19T01:05:41.109Z,1721351141.109 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2024-07-19T01:05:46.743Z,1721351146.743 [BPC1](ERROR): BPC1A got IPBS message with 5 sticks (min is 7). 2024-07-19T01:05:47.683Z,1721351147.683 [NavChartDb](INFO): # of records loaded: 35000 2024-07-19T01:05:48.059Z,1721351148.059 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4MI1OF.000 2024-07-19T01:05:53.715Z,1721351153.715 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-07-19T01:05:56.869Z,1721351156.869 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4MI1OF.000 2024-07-19T01:05:58.033Z,1721351158.033 [NavChartDb](INFO): # of records loaded: 40000 2024-07-19T01:06:05.949Z,1721351165.949 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4MI1OF.000 2024-07-19T01:06:05.973Z,1721351165.973 [NavChartDb](INFO): # of records loaded: 42018 2024-07-19T01:06:05.978Z,1721351165.978 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4MI1OF.000 2024-07-19T01:06:06.046Z,1721351166.046 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4MI51M.000 2024-07-19T01:06:08.231Z,1721351168.231 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4MI51M.000 2024-07-19T01:06:15.767Z,1721351175.767 [NavChartDb](INFO): # of records loaded: 5000 2024-07-19T01:06:22.773Z,1721351182.773 [SBIT](IMPORTANT): Beginning Startup BIT 2024-07-19T01:06:22.801Z,1721351182.801 [CBIT](IMPORTANT): Beginning ground fault scan 2024-07-19T01:06:24.769Z,1721351184.769 [NavChartDb](INFO): # of records loaded: 10000 2024-07-19T01:06:29.645Z,1721351189.645 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-07-19T01:06:32.501Z,1721351192.501 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-07-19T01:06:33.101Z,1721351193.101 [NavChartDb](INFO): # of records loaded: 15000 2024-07-19T01:06:33.689Z,1721351193.689 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.002645 CHAN A1 (24V): -0.007037 CHAN A2 (12V): -0.004696 CHAN A3 (5V): -0.002415 CHAN B0 (3.3V): -0.001046 CHAN B1 (3.15aV): -0.001376 CHAN B2 (3.15bV): -0.000410 CHAN B3 (GND): -0.000098 OPEN: 0.003657 Full Scale: +/- 1 mA 2024-07-19T01:06:40.993Z,1721351200.993 [NavChartDb](INFO): # of records loaded: 20000 2024-07-19T01:06:49.154Z,1721351209.154 [NavChartDb](INFO): # of records loaded: 25000 2024-07-19T01:06:57.217Z,1721351217.217 [NavChartDb](INFO): # of records loaded: 30000 2024-07-19T01:07:02.121Z,1721351222.121 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4MI51M.000 2024-07-19T01:07:05.999Z,1721351225.999 [NavChartDb](INFO): # of records loaded: 35000 2024-07-19T01:07:09.665Z,1721351229.665 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-07-19T01:07:13.497Z,1721351233.497 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4MI51M.000 2024-07-19T01:07:16.866Z,1721351236.866 [SBIT](IMPORTANT): SBIT PASSED 2024-07-19T01:07:16.867Z,1721351236.867 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-07-19T01:07:16.867Z,1721351236.867 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=8 count; 2024-07-19T01:07:16.868Z,1721351236.868 [SBIT](IMPORTANT): CTD_Seabird.minSalinityBound=0 practical_salinity_unit; 2024-07-19T01:07:16.868Z,1721351236.868 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool; 2024-07-19T01:07:16.868Z,1721351236.868 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=250 cubic_centimeter; 2024-07-19T01:07:16.868Z,1721351236.868 [SBIT](IMPORTANT): VerticalControl.massDefault=2.25 centimeter; 2024-07-19T01:07:17.278Z,1721351237.278 [MissionManager](IMPORTANT): Started mission Startup 2024-07-19T01:07:17.278Z,1721351237.278 [Startup] Running Loop=1 2024-07-19T01:07:17.279Z,1721351237.279 [Startup](DEBUG): Aggregate::initialize Startup 2024-07-19T01:07:17.279Z,1721351237.279 [Startup:A.GoToSurface] Running Loop=1 2024-07-19T01:07:17.279Z,1721351237.279 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-07-19T01:07:17.279Z,1721351237.279 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-07-19T01:07:17.280Z,1721351237.280 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-07-19T01:07:17.280Z,1721351237.280 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-07-19T01:07:17.280Z,1721351237.280 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-07-19T01:07:17.281Z,1721351237.281 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-07-19T01:07:17.281Z,1721351237.281 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-07-19T01:07:17.283Z,1721351237.283 [Startup:StartupSatComms] Running Loop=1 2024-07-19T01:07:17.283Z,1721351237.283 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-07-19T01:07:17.283Z,1721351237.283 [Startup:StartupSatComms:A] Running Loop=1 2024-07-19T01:07:17.673Z,1721351237.673 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-07-19T01:07:19.507Z,1721351239.507 [NavChartDb](INFO): # of records loaded: 40000 2024-07-19T01:07:21.905Z,1721351241.905 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4MI51M.000 2024-07-19T01:07:21.967Z,1721351241.967 [NavChartDb](INFO): # of records loaded: 40792 2024-07-19T01:07:21.971Z,1721351241.971 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4MI51M.000 2024-07-19T01:07:21.998Z,1721351241.998 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4MI1OD.000 2024-07-19T01:07:22.435Z,1721351242.435 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4MI1OD.000 2024-07-19T01:07:30.791Z,1721351250.791 [NavChartDb](INFO): # of records loaded: 5000 2024-07-19T01:07:32.223Z,1721351252.223 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-07-19T01:07:32.223Z,1721351252.223 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-07-19T01:07:32.273Z,1721351252.273 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-07-19T01:07:32.670Z,1721351252.670 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-07-19T01:07:32.671Z,1721351252.671 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-07-19T01:07:36.165Z,1721351256.165 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4MI1OD.000 2024-07-19T01:07:37.452Z,1721351257.452 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4MI1OD.000 2024-07-19T01:07:38.872Z,1721351258.872 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4MI1OD.000 2024-07-19T01:07:38.910Z,1721351258.910 [NavChartDb](INFO): # of records loaded: 9682 2024-07-19T01:07:38.912Z,1721351258.912 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4MI1OD.000 2024-07-19T01:07:38.966Z,1721351258.966 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US4MI1ND.000 2024-07-19T01:07:40.115Z,1721351260.115 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US4MI1ND.000 2024-07-19T01:07:50.334Z,1721351270.334 [NavChartDb](INFO): # of records loaded: 5000 2024-07-19T01:07:55.916Z,1721351275.916 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.003950 2024-07-19T01:07:59.554Z,1721351279.554 [NavChartDb](INFO): # of records loaded: 10000 2024-07-19T01:08:07.833Z,1721351287.833 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US4MI1ND.000 2024-07-19T01:08:07.848Z,1721351287.848 [NavChartDb](INFO): # of records loaded: 15000 2024-07-19T01:08:15.819Z,1721351295.819 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US4MI1ND.000 2024-07-19T01:08:17.524Z,1721351297.524 [Startup:StartupSatComms:A](INFO): Timed out from 2024-07-19T01:07:17.3Z 2024-07-19T01:08:17.524Z,1721351297.524 [Startup:StartupSatComms:A] Stopped 2024-07-19T01:08:17.524Z,1721351297.524 [Startup:StartupSatComms:B] Running Loop=1 2024-07-19T01:08:18.153Z,1721351298.153 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-07-19T01:08:23.867Z,1721351303.867 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US4MI1ND.000 2024-07-19T01:08:24.008Z,1721351304.008 [NavChartDb](INFO): # of records loaded: 19081 2024-07-19T01:08:24.032Z,1721351304.032 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US4MI1ND.000 2024-07-19T01:08:24.033Z,1721351304.033 [NavChartDb](INFO): Setup scan of Resources/ElectronicNavigationCharts/US2MI60M.000 2024-07-19T01:08:31.418Z,1721351311.418 [NavChartDb](INFO): Done scanning features of Resources/ElectronicNavigationCharts/US2MI60M.000 2024-07-19T01:08:31.766Z,1721351311.766 [DataOverHttps](INFO): Sending 148 bytes from file Logs/20240719T004235/Courier0010.lzma 2024-07-19T01:08:32.772Z,1721351312.772 [DataOverHttps](INFO): Moved sent file to Logs/20240719T004235/Courier0010.lzma.bak 2024-07-19T01:08:32.772Z,1721351312.772 [DataOverHttps](INFO): SBD MOMSN=21368189 2024-07-19T01:08:51.999Z,1721351331.999 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-19T01:08:58.187Z,1721351338.187 [NavChartDb](INFO): # of records loaded: 5000 2024-07-19T01:08:59.672Z,1721351339.672 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-19T01:09:13.398Z,1721351353.398 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240719T010419/Courier0000.lzma 2024-07-19T01:09:14.400Z,1721351354.400 [DataOverHttps](INFO): Moved sent file to Logs/20240719T010419/Courier0000.lzma.bak 2024-07-19T01:09:14.400Z,1721351354.400 [DataOverHttps](INFO): SBD MOMSN=21368193 2024-07-19T01:09:15.014Z,1721351355.014 [NavChartDb](INFO): # of records loaded: 10000 2024-07-19T01:09:16.243Z,1721351356.243 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-19T01:09:17.933Z,1721351357.933 [Startup:StartupSatComms:B](INFO): Timed out from 2024-07-19T01:08:17.5Z 2024-07-19T01:09:17.933Z,1721351357.933 [Startup:StartupSatComms:B] Stopped 2024-07-19T01:09:17.933Z,1721351357.933 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-07-19T01:09:17.933Z,1721351357.933 [Startup:StartupSatComms] Stopped 2024-07-19T01:09:17.933Z,1721351357.933 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-07-19T01:09:17.949Z,1721351357.949 [Startup](INFO): Completed Startup 2024-07-19T01:09:17.950Z,1721351357.950 [MissionManager](INFO): Startup is completed. 2024-07-19T01:09:17.950Z,1721351357.950 [MissionManager](INFO): Uninitializing Mission Startup 2024-07-19T01:09:17.950Z,1721351357.950 [Startup] Stopped 2024-07-19T01:09:17.950Z,1721351357.950 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-07-19T01:09:17.950Z,1721351357.950 [Startup:A.GoToSurface] Stopped 2024-07-19T01:09:17.950Z,1721351357.950 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-07-19T01:09:18.276Z,1721351358.276 [MissionManager](IMPORTANT): Started mission Default 2024-07-19T01:09:18.276Z,1721351358.276 [Default] Running Loop=1 2024-07-19T01:09:18.276Z,1721351358.276 [Default](DEBUG): Aggregate::initialize Default 2024-07-19T01:09:18.277Z,1721351358.277 [Default:B.GoToSurface] Running Loop=1 2024-07-19T01:09:18.277Z,1721351358.277 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-07-19T01:09:18.277Z,1721351358.277 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-07-19T01:09:18.277Z,1721351358.277 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-07-19T01:09:18.277Z,1721351358.277 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-07-19T01:09:18.278Z,1721351358.278 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-07-19T01:09:18.278Z,1721351358.278 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-07-19T01:09:18.279Z,1721351358.279 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-07-19T01:09:18.279Z,1721351358.279 [Default:A.Wait] Running Loop=1 2024-07-19T01:09:18.279Z,1721351358.279 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-07-19T01:09:29.753Z,1721351369.753 [NavChartDb](INFO): # of records loaded: 15000 2024-07-19T01:09:31.636Z,1721351371.636 [Default:A.Wait](INFO): Done Waiting. 2024-07-19T01:09:31.636Z,1721351371.636 [Default:A.Wait] Stopped 2024-07-19T01:09:31.636Z,1721351371.636 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-07-19T01:09:32.040Z,1721351372.040 [Default:CheckIn] Running Loop=1 2024-07-19T01:09:32.040Z,1721351372.040 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-07-19T01:09:32.040Z,1721351372.040 [Default:CheckIn:Read_GPS] Running Loop=1 2024-07-19T01:09:32.499Z,1721351372.499 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-07-19T01:09:33.227Z,1721351373.227 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-19T01:09:39.920Z,1721351379.920 [NavChartDb](INFO): # of records loaded: 20000 2024-07-19T01:09:47.724Z,1721351387.724 [NavChartDb](INFO): # of records loaded: 25000 2024-07-19T01:09:49.791Z,1721351389.791 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-19T01:09:55.592Z,1721351395.592 [NavChartDb](INFO): # of records loaded: 30000 2024-07-19T01:10:03.500Z,1721351403.500 [CommandExec](IMPORTANT): got command get latitude 2024-07-19T01:10:03.500Z,1721351403.500 [CommandExec](FAULT): Element has no value 2024-07-19T01:10:06.355Z,1721351406.355 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-19T01:10:06.519Z,1721351406.519 [CommandExec](IMPORTANT): got command ibit 2024-07-19T01:10:06.857Z,1721351406.857 [IBIT](IMPORTANT): Beginning Initiated BIT 2024-07-19T01:10:06.857Z,1721351406.857 [IBIT](IMPORTANT): Beginning control surface checks. 2024-07-19T01:10:06.869Z,1721351406.869 [CBIT](IMPORTANT): Beginning ground fault scan 2024-07-19T01:10:10.282Z,1721351410.282 [NavChartDb](INFO): # of records loaded: 35000 2024-07-19T01:10:12.898Z,1721351412.898 [DataOverHttps](INFO): Sending 209 bytes from file Logs/20240719T004235/Express0011.lzma 2024-07-19T01:10:13.900Z,1721351413.900 [DataOverHttps](INFO): Moved sent file to Logs/20240719T004235/Express0011.lzma.bak 2024-07-19T01:10:13.900Z,1721351413.900 [DataOverHttps](INFO): SBD MOMSN=21368196 2024-07-19T01:10:14.040Z,1721351414.040 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-07-19T01:10:17.776Z,1721351417.776 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.001960 CHAN A1 (24V): -0.007443 CHAN A2 (12V): -0.004514 CHAN A3 (5V): -0.002783 CHAN B0 (3.3V): -0.000999 CHAN B1 (3.15aV): -0.001187 CHAN B2 (3.15bV): -0.000860 CHAN B3 (GND): -0.000192 OPEN: 0.003697 Full Scale: +/- 1 mA 2024-07-19T01:10:18.122Z,1721351418.122 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011016.00,A,4538.82462,N,08428.36637,W,0.369,125.91,190724,,,A*71 2024-07-19T01:10:18.125Z,1721351418.125 [NAL9602](INFO): GPS fix at 20240719T011016: (45.647077, -84.472773) 2024-07-19T01:10:20.945Z,1721351420.945 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011019.00,A,4538.82566,N,08428.36626,W,0.292,125.91,190724,,,A*7E 2024-07-19T01:10:20.947Z,1721351420.947 [NAL9602](INFO): GPS fix at 20240719T011019: (45.647094, -84.472771) 2024-07-19T01:10:22.286Z,1721351422.286 [NavChartDb](INFO): # of records loaded: 40000 2024-07-19T01:10:22.970Z,1721351422.970 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-19T01:10:23.785Z,1721351423.785 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011022.00,A,4538.82577,N,08428.36609,W,0.214,125.91,190724,,,A*75 2024-07-19T01:10:23.787Z,1721351423.787 [NAL9602](INFO): GPS fix at 20240719T011022: (45.647096, -84.472768) 2024-07-19T01:10:27.001Z,1721351427.001 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011025.00,A,4538.82647,N,08428.36568,W,0.292,125.91,190724,,,A*78 2024-07-19T01:10:27.003Z,1721351427.003 [NAL9602](INFO): GPS fix at 20240719T011025: (45.647108, -84.472761) 2024-07-19T01:10:29.829Z,1721351429.829 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011028.00,A,4538.82734,N,08428.36510,W,0.311,125.91,190724,,,A*75 2024-07-19T01:10:29.831Z,1721351429.831 [NAL9602](INFO): GPS fix at 20240719T011028: (45.647122, -84.472752) 2024-07-19T01:10:33.061Z,1721351433.061 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011031.00,A,4538.82827,N,08428.36438,W,0.739,125.91,190724,,,A*75 2024-07-19T01:10:33.063Z,1721351433.063 [NAL9602](INFO): GPS fix at 20240719T011031: (45.647138, -84.472740) 2024-07-19T01:10:35.914Z,1721351435.914 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011034.00,A,4538.82880,N,08428.36358,W,0.564,125.91,190724,,,A*76 2024-07-19T01:10:35.920Z,1721351435.920 [NAL9602](INFO): GPS fix at 20240719T011034: (45.647147, -84.472726) 2024-07-19T01:10:36.563Z,1721351436.563 [NavChartDb](INFO): # of records loaded: 45000 2024-07-19T01:10:38.554Z,1721351438.554 [NavChartDb](INFO): Calculating coverage of Resources/ElectronicNavigationCharts/US2MI60M.000 2024-07-19T01:10:39.121Z,1721351439.121 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011037.00,A,4538.82896,N,08428.36290,W,0.194,125.91,190724,,,A*7C 2024-07-19T01:10:39.123Z,1721351439.123 [NAL9602](INFO): GPS fix at 20240719T011037: (45.647149, -84.472715) 2024-07-19T01:10:39.925Z,1721351439.925 [BPC1](ERROR): BPC1B got IPBS message with 6 sticks (min is 7). 2024-07-19T01:10:41.953Z,1721351441.953 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011040.00,A,4538.82927,N,08428.36251,W,0.136,125.91,190724,,,A*72 2024-07-19T01:10:41.956Z,1721351441.956 [NAL9602](INFO): GPS fix at 20240719T011040: (45.647154, -84.472708) 2024-07-19T01:10:45.185Z,1721351445.185 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011043.00,A,4538.82928,N,08428.36219,W,0.214,125.91,190724,,,A*71 2024-07-19T01:10:45.187Z,1721351445.187 [NAL9602](INFO): GPS fix at 20240719T011043: (45.647155, -84.472703) 2024-07-19T01:10:48.009Z,1721351448.009 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011046.00,A,4538.82912,N,08428.36217,W,0.214,125.91,190724,,,A*73 2024-07-19T01:10:48.012Z,1721351448.012 [NAL9602](INFO): GPS fix at 20240719T011046: (45.647152, -84.472703) 2024-07-19T01:10:49.217Z,1721351449.217 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-19T01:10:50.537Z,1721351450.537 [NavChartDb](INFO): # of records loaded: 50000 2024-07-19T01:10:50.857Z,1721351450.857 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011049.00,A,4538.82996,N,08428.36209,W,0.350,125.91,190724,,,A*7E 2024-07-19T01:10:50.867Z,1721351450.867 [NAL9602](INFO): GPS fix at 20240719T011049: (45.647166, -84.472701) 2024-07-19T01:10:54.073Z,1721351454.073 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011052.00,A,4538.83049,N,08428.36228,W,0.253,125.91,190724,,,A*7F 2024-07-19T01:10:54.075Z,1721351454.075 [NAL9602](INFO): GPS fix at 20240719T011052: (45.647175, -84.472705) 2024-07-19T01:10:55.759Z,1721351455.759 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-07-19T01:10:56.913Z,1721351456.913 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011055.00,A,4538.83054,N,08428.36222,W,0.175,125.91,190724,,,A*79 2024-07-19T01:10:56.915Z,1721351456.915 [NAL9602](INFO): GPS fix at 20240719T011055: (45.647176, -84.472704) 2024-07-19T01:10:59.668Z,1721351459.668 [NavChartDb](INFO): # of records loaded: 55000 2024-07-19T01:11:00.129Z,1721351460.129 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011058.00,A,4538.83097,N,08428.36216,W,0.253,125.91,190724,,,A*7B 2024-07-19T01:11:00.131Z,1721351460.131 [NAL9602](INFO): GPS fix at 20240719T011058: (45.647183, -84.472703) 2024-07-19T01:11:02.978Z,1721351462.978 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011101.00,A,4538.83125,N,08428.36214,W,0.156,125.91,190724,,,A*7A 2024-07-19T01:11:02.980Z,1721351462.980 [NAL9602](INFO): GPS fix at 20240719T011101: (45.647188, -84.472702) 2024-07-19T01:11:04.985Z,1721351464.985 [BPC1](ERROR): BPC1A got IPBS message with 6 sticks (min is 7). 2024-07-19T01:11:05.821Z,1721351465.821 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011104.00,A,4538.83158,N,08428.36188,W,0.330,125.91,190724,,,A*71 2024-07-19T01:11:05.823Z,1721351465.823 [NAL9602](INFO): GPS fix at 20240719T011104: (45.647193, -84.472698) 2024-07-19T01:11:09.029Z,1721351469.029 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011108.00,A,4538.83165,N,08428.36168,W,0.253,125.91,190724,,,A*79 2024-07-19T01:11:09.031Z,1721351469.031 [NAL9602](INFO): GPS fix at 20240719T011108: (45.647194, -84.472695) 2024-07-19T01:11:11.862Z,1721351471.862 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011111.00,A,4538.83193,N,08428.36177,W,0.233,125.91,190724,,,A*70 2024-07-19T01:11:11.864Z,1721351471.864 [NAL9602](INFO): GPS fix at 20240719T011111: (45.647199, -84.472696) 2024-07-19T01:11:12.693Z,1721351472.693 [NavChartDb](INFO): # of records loaded: 60000 2024-07-19T01:11:13.072Z,1721351473.072 [BPC1](INFO): Calculating totals. Valid battery stick count: 51. Valid reserve battery stick count: 5. 2024-07-19T01:11:13.075Z,1721351473.075 [BPC1](INFO): Received data from all battery sticks. 2024-07-19T01:11:15.089Z,1721351475.089 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011114.00,A,4538.83200,N,08428.36136,W,0.272,125.91,190724,,,A*7C 2024-07-19T01:11:15.091Z,1721351475.091 [NAL9602](INFO): GPS fix at 20240719T011114: (45.647200, -84.472689) 2024-07-19T01:11:17.662Z,1721351477.662 [NavChartDb](INFO): Done scanning edges of Resources/ElectronicNavigationCharts/US2MI60M.000 2024-07-19T01:11:17.917Z,1721351477.917 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011117.00,A,4538.83192,N,08428.36136,W,0.078,125.91,190724,,,A*7F 2024-07-19T01:11:17.919Z,1721351477.919 [NAL9602](INFO): GPS fix at 20240719T011117: (45.647199, -84.472689) 2024-07-19T01:11:21.149Z,1721351481.149 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011120.00,A,4538.83186,N,08428.36151,W,0.233,125.91,190724,,,A*72 2024-07-19T01:11:21.151Z,1721351481.151 [NAL9602](INFO): GPS fix at 20240719T011120: (45.647198, -84.472692) 2024-07-19T01:11:23.981Z,1721351483.981 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011123.00,A,4538.83159,N,08428.36149,W,0.058,125.91,190724,,,A*75 2024-07-19T01:11:23.983Z,1721351483.983 [NAL9602](INFO): GPS fix at 20240719T011123: (45.647193, -84.472691) 2024-07-19T01:11:26.805Z,1721351486.805 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011126.00,A,4538.83129,N,08428.36111,W,0.272,125.91,190724,,,A*70 2024-07-19T01:11:26.815Z,1721351486.815 [NAL9602](INFO): GPS fix at 20240719T011126: (45.647188, -84.472685) 2024-07-19T01:11:30.041Z,1721351490.041 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011129.00,A,4538.83087,N,08428.36052,W,0.408,125.91,190724,,,A*77 2024-07-19T01:11:30.043Z,1721351490.043 [NAL9602](INFO): GPS fix at 20240719T011129: (45.647181, -84.472675) 2024-07-19T01:11:30.417Z,1721351490.417 [NavChartDb](INFO): Done scanning nodes of Resources/ElectronicNavigationCharts/US2MI60M.000 2024-07-19T01:11:30.946Z,1721351490.946 [NavChartDb](INFO): # of records loaded: 64544 2024-07-19T01:11:30.951Z,1721351490.951 [NavChartDb](IMPORTANT): Loaded Electronic Nav Chart data from US2MI60M.000 2024-07-19T01:11:31.892Z,1721351491.892 [NavChartDb](INFO): Creating index for soundings 2024-07-19T01:11:32.869Z,1721351492.869 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011132.00,A,4538.83054,N,08428.36025,W,0.330,125.91,190724,,,A*7F 2024-07-19T01:11:32.871Z,1721351492.871 [NAL9602](INFO): GPS fix at 20240719T011132: (45.647176, -84.472671) 2024-07-19T01:11:36.097Z,1721351496.097 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011135.00,A,4538.83030,N,08428.36010,W,0.136,125.91,190724,,,A*78 2024-07-19T01:11:36.099Z,1721351496.099 [NAL9602](INFO): GPS fix at 20240719T011135: (45.647172, -84.472668) 2024-07-19T01:11:38.933Z,1721351498.933 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011138.00,A,4538.83023,N,08428.36021,W,0.194,125.91,190724,,,A*7D 2024-07-19T01:11:38.935Z,1721351498.935 [NAL9602](INFO): GPS fix at 20240719T011138: (45.647171, -84.472670) 2024-07-19T01:11:42.161Z,1721351502.161 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011141.00,A,4538.82980,N,08428.35977,W,0.253,125.91,190724,,,A*73 2024-07-19T01:11:42.164Z,1721351502.164 [NAL9602](INFO): GPS fix at 20240719T011141: (45.647163, -84.472663) 2024-07-19T01:11:43.838Z,1721351503.838 [NavChartDb](INFO): Creating index for 0p0 2024-07-19T01:11:44.985Z,1721351504.985 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011144.00,A,4538.82976,N,08428.35966,W,0.039,125.91,190724,,,A*71 2024-07-19T01:11:44.987Z,1721351504.987 [NAL9602](INFO): GPS fix at 20240719T011144: (45.647163, -84.472661) 2024-07-19T01:11:47.813Z,1721351507.813 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011147.00,A,4538.82970,N,08428.35941,W,0.078,125.91,190724,,,A*74 2024-07-19T01:11:47.815Z,1721351507.815 [NAL9602](INFO): GPS fix at 20240719T011147: (45.647162, -84.472657) 2024-07-19T01:11:49.400Z,1721351509.400 [NavChartDb](INFO): Creating index for 1p8 2024-07-19T01:11:51.045Z,1721351511.045 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011150.00,A,4538.82912,N,08428.35871,W,0.486,125.91,190724,,,A*71 2024-07-19T01:11:51.047Z,1721351511.047 [NAL9602](INFO): GPS fix at 20240719T011150: (45.647152, -84.472645) 2024-07-19T01:11:53.369Z,1721351513.369 [NavChartDb](INFO): Creating index for 3p6 2024-07-19T01:11:53.877Z,1721351513.877 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011153.00,A,4538.82902,N,08428.35821,W,0.194,125.91,190724,,,A*70 2024-07-19T01:11:53.879Z,1721351513.879 [NAL9602](INFO): GPS fix at 20240719T011153: (45.647150, -84.472637) 2024-07-19T01:11:57.109Z,1721351517.109 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011156.00,A,4538.82915,N,08428.35799,W,0.117,125.91,190724,,,A*74 2024-07-19T01:11:57.111Z,1721351517.111 [NAL9602](INFO): GPS fix at 20240719T011156: (45.647152, -84.472633) 2024-07-19T01:11:57.543Z,1721351517.543 [IBIT](FAULT): Error acquiring IBIT communications status. Timeout expired. 2024-07-19T01:11:57.934Z,1721351517.934 [IBIT](IMPORTANT): Battery Status: Battery Charge (AH): 0.000000 Voltage: 15.977000 2024-07-19T01:11:57.935Z,1721351517.935 [IBIT](IMPORTANT): batteryCapacityThreshold: 50.000000 Ah 2024-07-19T01:11:57.935Z,1721351517.935 [IBIT](IMPORTANT): batteryVoltageThreshold: 13.700000 V 2024-07-19T01:11:58.273Z,1721351518.273 [NavChartDb](INFO): Creating index for 5p4 2024-07-19T01:11:58.374Z,1721351518.374 [IBIT](IMPORTANT): bitHumidityThreshold: 55.000000 % 2024-07-19T01:11:58.374Z,1721351518.374 [IBIT](IMPORTANT): bitPressureThreshold: 0.750000 psi 2024-07-19T01:11:58.375Z,1721351518.375 [IBIT](IMPORTANT): Pressure:10.267482 PSI 2024-07-19T01:11:58.375Z,1721351518.375 [IBIT](IMPORTANT): Humidity:17.262850 % 2024-07-19T01:11:58.776Z,1721351518.776 [IBIT](IMPORTANT): Vehicle Pitch:-2.854956 degrees 2024-07-19T01:11:58.777Z,1721351518.777 [IBIT](IMPORTANT): Vehicle Roll:-6.153172 degrees 2024-07-19T01:11:58.819Z,1721351518.819 [IBIT](IMPORTANT): Vehicle Heading:263.617798 degrees 2024-07-19T01:11:59.171Z,1721351519.171 [IBIT](IMPORTANT): surfaceThreshold: 1.000000 m 2024-07-19T01:11:59.171Z,1721351519.171 [IBIT](IMPORTANT): buoyancyNeutral: 250.000015 cc 2024-07-19T01:11:59.171Z,1721351519.171 [IBIT](IMPORTANT): massDefault: 2.250000 cm 2024-07-19T01:11:59.172Z,1721351519.172 [IBIT](IMPORTANT): stopDepth: 275.000000 m 2024-07-19T01:11:59.172Z,1721351519.172 [IBIT](IMPORTANT): abortDepth: 300.000000 m 2024-07-19T01:11:59.172Z,1721351519.172 [IBIT](IMPORTANT): IBIT FAILED 2024-07-19T01:11:59.579Z,1721351519.579 [Default:CheckIn:Read_GPS] Stopped 2024-07-19T01:11:59.579Z,1721351519.579 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-07-19T01:11:59.933Z,1721351519.933 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011159.00,A,4538.82923,N,08428.35796,W,0.058,125.91,190724,,,A*7B 2024-07-19T01:11:59.935Z,1721351519.935 [NAL9602](INFO): GPS fix at 20240719T011159: (45.647154, -84.472633) 2024-07-19T01:11:59.989Z,1721351519.989 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-07-19T01:12:07.480Z,1721351527.480 [NavChartDb](INFO): Creating index for 7p3 2024-07-19T01:12:15.450Z,1721351535.450 [DataOverHttps](INFO): Sending 285 bytes from file Logs/20240719T010419/Courier0004.lzma 2024-07-19T01:12:16.452Z,1721351536.452 [DataOverHttps](INFO): Moved sent file to Logs/20240719T010419/Courier0004.lzma.bak 2024-07-19T01:12:16.452Z,1721351536.452 [DataOverHttps](INFO): SBD MOMSN=21368203 2024-07-19T01:12:17.171Z,1721351537.171 [NavChartDb](INFO): Creating index for 9p1 2024-07-19T01:12:32.371Z,1721351552.371 [NAL9602](INFO): Not Powering down - fast GPS 2024-07-19T01:12:44.784Z,1721351564.784 [DataOverHttps](INFO): Sending 1207 bytes from file Logs/20240719T010419/Express0001.lzma 2024-07-19T01:12:45.784Z,1721351565.784 [DataOverHttps](INFO): Moved sent file to Logs/20240719T010419/Express0001.lzma.bak 2024-07-19T01:12:45.784Z,1721351565.784 [DataOverHttps](INFO): SBD MOMSN=21368206 2024-07-19T01:13:08.559Z,1721351588.559 [DataOverHttps](INFO): Sending 1006 bytes from file Logs/20240719T010419/Express0005.lzma 2024-07-19T01:13:09.560Z,1721351589.560 [DataOverHttps](INFO): Moved sent file to Logs/20240719T010419/Express0005.lzma.bak 2024-07-19T01:13:09.560Z,1721351589.560 [DataOverHttps](INFO): SBD MOMSN=21368236 2024-07-19T01:13:16.037Z,1721351596.037 [Default:CheckIn:Read_Iridium] Stopped 2024-07-19T01:13:16.037Z,1721351596.037 [Default:CheckIn:C.Wait] Running Loop=1 2024-07-19T01:13:16.037Z,1721351596.037 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-07-19T01:14:33.988Z,1721351673.988 [Power24vConverter](INFO): Powering down. 2024-07-19T01:14:44.395Z,1721351684.395 [CommandExec](IMPORTANT): got command show variable distance 2024-07-19T01:14:44.398Z,1721351684.398 [CommandExec](IMPORTANT): distance_from_shore (meter) 2024-07-19T01:14:44.399Z,1721351684.399 [CommandExec](IMPORTANT): fix_distance_made_good (unknown) 2024-07-19T01:14:44.399Z,1721351684.399 [CommandExec](IMPORTANT): fix_residual_distance (unknown) 2024-07-19T01:14:44.400Z,1721351684.400 [CommandExec](IMPORTANT): fix_residual_percent_distance_traveled (unknown) 2024-07-19T01:14:44.401Z,1721351684.401 [CommandExec](IMPORTANT): platform_distance_wrt_ground (unknown) 2024-07-19T01:14:44.401Z,1721351684.401 [CommandExec](IMPORTANT): platform_distance_wrt_sea_water (meter) 2024-07-19T01:14:44.466Z,1721351684.466 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.loadAtStartup (bool) 2024-07-19T01:14:44.467Z,1721351684.467 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.verbosity (count) 2024-07-19T01:14:44.467Z,1721351684.467 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex1 (degree) 2024-07-19T01:14:44.468Z,1721351684.467 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex1 (degree) 2024-07-19T01:14:44.468Z,1721351684.468 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex2 (degree) 2024-07-19T01:14:44.468Z,1721351684.468 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex2 (degree) 2024-07-19T01:14:44.469Z,1721351684.469 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex3 (degree) 2024-07-19T01:14:44.469Z,1721351684.469 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex3 (degree) 2024-07-19T01:14:44.469Z,1721351684.469 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex4 (degree) 2024-07-19T01:14:44.470Z,1721351684.470 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex4 (degree) 2024-07-19T01:14:44.526Z,1721351684.526 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex5 (degree) 2024-07-19T01:14:44.527Z,1721351684.527 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex5 (degree) 2024-07-19T01:14:44.527Z,1721351684.527 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex6 (degree) 2024-07-19T01:14:44.527Z,1721351684.527 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex6 (degree) 2024-07-19T01:14:44.528Z,1721351684.528 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex7 (degree) 2024-07-19T01:14:44.528Z,1721351684.528 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex7 (degree) 2024-07-19T01:14:44.528Z,1721351684.528 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex8 (degree) 2024-07-19T01:14:44.529Z,1721351684.529 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex8 (degree) 2024-07-19T01:14:44.529Z,1721351684.529 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex9 (degree) 2024-07-19T01:14:44.529Z,1721351684.529 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex9 (degree) 2024-07-19T01:14:44.546Z,1721351684.546 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.latVertex10 (degree) 2024-07-19T01:14:44.546Z,1721351684.546 [CommandExec](IMPORTANT): ShortestDistanceToPolygonSidesCalculator.lonVertex10 (degree) 2024-07-19T01:14:44.548Z,1721351684.548 [CommandExec](IMPORTANT): LineCapture.rolloutDistance (meter) 2024-07-19T01:14:44.628Z,1721351684.628 [CommandExec](IMPORTANT): MassServo.deviationDistance (millimeter) 2024-07-19T01:14:44.716Z,1721351684.716 [CommandExec](IMPORTANT): GobyModem.maxDistance (kilometer) 2024-07-19T01:14:44.738Z,1721351684.738 [CommandExec](IMPORTANT): Rowe_600.acousticBlankingDistance (meter) 2024-07-19T01:14:44.793Z,1721351684.793 [CommandExec](IMPORTANT): SpeedCalculator.platform_distance_wrt_sea_water (meter) 2024-07-19T01:14:44.803Z,1721351684.803 [CommandExec](IMPORTANT): DeadReckonUsingMultipleVelocitySources.fix_distance_made_good (meter) 2024-07-19T01:14:44.804Z,1721351684.804 [CommandExec](IMPORTANT): DeadReckonUsingMultipleVelocitySources.fix_residual_distance (meter) 2024-07-19T01:14:44.804Z,1721351684.804 [CommandExec](IMPORTANT): DeadReckonUsingMultipleVelocitySources.fix_residual_percent_distance_traveled (percent) 2024-07-19T01:14:44.805Z,1721351684.805 [CommandExec](IMPORTANT): NavChart.distance_from_shore (meter) 2024-07-19T01:14:44.950Z,1721351684.950 [CommandExec](IMPORTANT): NavChartDb.closestDistance (meter) 2024-07-19T01:14:44.951Z,1721351684.951 [CommandExec](IMPORTANT): NavChartDb.nextDistance (meter) 2024-07-19T01:14:55.153Z,1721351695.153 [CommandExec](IMPORTANT): got command get NavChart.distance_from_shore 2024-07-19T01:14:55.154Z,1721351695.154 [CommandExec](IMPORTANT): NavChart.distance_from_shore 54.707306 m 2024-07-19T01:17:29.635Z,1721351849.635 [CommandExec](IMPORTANT): got command failComponent 2024-07-19T01:17:29.635Z,1721351849.635 [CommandExec](IMPORTANT): Failed components: 2024-07-19T01:17:29.635Z,1721351849.635 [CommandExec](IMPORTANT): No failed Components. 2024-07-19T01:18:16.613Z,1721351896.613 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-07-19T01:18:16.613Z,1721351896.613 [Default:CheckIn:C.Wait] Stopped 2024-07-19T01:18:16.613Z,1721351896.613 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-07-19T01:18:16.614Z,1721351896.614 [Default:CheckIn:D] Running Loop=1 2024-07-19T01:18:17.021Z,1721351897.021 [Default:CheckIn:D] Stopped 2024-07-19T01:18:17.021Z,1721351897.021 [Default:CheckIn:E] Running Loop=1 2024-07-19T01:18:17.427Z,1721351897.427 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 8.979071 min 2024-07-19T01:18:17.427Z,1721351897.427 [Default:CheckIn:E] Stopped 2024-07-19T01:18:17.428Z,1721351897.428 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-07-19T01:18:17.428Z,1721351897.428 [Default:CheckIn] Stopped 2024-07-19T01:18:17.428Z,1721351897.428 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-07-19T01:18:17.428Z,1721351897.428 [Default:CheckIn](INFO): Running loop #2 2024-07-19T01:18:17.428Z,1721351897.428 [Default:CheckIn] Running Loop=2 2024-07-19T01:18:17.428Z,1721351897.428 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-07-19T01:18:17.428Z,1721351897.428 [Default:CheckIn:Read_GPS] Running Loop=1 2024-07-19T01:18:19.424Z,1721351899.424 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,011818.00,A,4538.82777,N,08428.35932,W,0.486,125.91,190724,,,A*7F 2024-07-19T01:18:19.426Z,1721351899.426 [NAL9602](INFO): GPS fix at 20240719T011818: (45.647129, -84.472655) 2024-07-19T01:18:19.437Z,1721351899.437 [Default:CheckIn:Read_GPS] Stopped 2024-07-19T01:18:19.437Z,1721351899.437 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-07-19T01:18:29.134Z,1721351909.134 [DataOverHttps](INFO): Sending 73 bytes from file Logs/20240719T010419/Courier0007.lzma 2024-07-19T01:18:30.136Z,1721351910.136 [DataOverHttps](INFO): Moved sent file to Logs/20240719T010419/Courier0007.lzma.bak 2024-07-19T01:18:30.136Z,1721351910.136 [DataOverHttps](INFO): SBD MOMSN=21368266 2024-07-19T01:18:50.127Z,1721351930.127 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2024-07-19T01:18:50.203Z,1721351930.203 [NAL9602](ERROR): received: +CSQ:0 OK74, 2, 0, 0, 0 OK 2024-07-19T01:18:59.427Z,1721351939.427 [DataOverHttps](INFO): Sending 759 bytes from file Logs/20240719T010419/Express0008.lzma 2024-07-19T01:19:00.428Z,1721351940.428 [DataOverHttps](INFO): Moved sent file to Logs/20240719T010419/Express0008.lzma.bak 2024-07-19T01:19:00.428Z,1721351940.428 [DataOverHttps](INFO): SBD MOMSN=21368269 2024-07-19T01:19:09.164Z,1721351949.164 [Default:CheckIn:Read_Iridium] Stopped 2024-07-19T01:19:09.164Z,1721351949.164 [Default:CheckIn:C.Wait] Running Loop=1 2024-07-19T01:19:09.164Z,1721351949.164 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-07-19T01:20:41.023Z,1721352041.023 [DataOverHttps](IMPORTANT): SBD MTMSN=20240719T012040 2024-07-19T01:20:48.438Z,1721352048.438 [DataOverHttps](INFO): Received command: restart app 2024-07-19T01:20:48.475Z,1721352048.475 [CommandExec](IMPORTANT): got command restart application 2024-07-19T01:20:49.478Z,1721352049.478 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2024-07-19T01:20:49.478Z,1721352049.478 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-19T01:20:49.478Z,1721352049.478 [CommandExec](INFO): Uninitializing the command executive. 2024-07-19T01:20:49.479Z,1721352049.479 [CommandExec](INFO): Uninitializing the command scheduler. 2024-07-19T01:20:49.479Z,1721352049.479 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:49.606Z,1721352049.606 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-07-19T01:20:49.606Z,1721352049.606 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-07-19T01:20:49.606Z,1721352049.606 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:49.607Z,1721352049.607 [NavChartDb](INFO): Join timeout helper Thread ID is 1065 2024-07-19T01:20:49.906Z,1721352049.906 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-19T01:20:49.906Z,1721352049.906 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:49.914Z,1721352049.914 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-07-19T01:20:49.914Z,1721352049.914 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:49.914Z,1721352049.914 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1066 2024-07-19T01:20:50.146Z,1721352050.146 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-19T01:20:50.146Z,1721352050.146 [WetLabsBB2FL](INFO): Powering down 2024-07-19T01:20:50.147Z,1721352050.147 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:50.154Z,1721352050.154 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-07-19T01:20:50.154Z,1721352050.154 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:50.154Z,1721352050.154 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1067 2024-07-19T01:20:50.402Z,1721352050.402 [CTD_Seabird](INFO): Powering down 2024-07-19T01:20:50.414Z,1721352050.414 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-19T01:20:50.414Z,1721352050.414 [CTD_Seabird](INFO): Powering down 2024-07-19T01:20:50.426Z,1721352050.426 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:50.434Z,1721352050.434 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-07-19T01:20:50.434Z,1721352050.434 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:50.434Z,1721352050.434 [Radio_Surface](INFO): Join timeout helper Thread ID is 1068 2024-07-19T01:20:50.638Z,1721352050.638 [Radio_Surface](INFO): Powering down 2024-07-19T01:20:50.639Z,1721352050.639 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-19T01:20:50.639Z,1721352050.639 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:50.658Z,1721352050.658 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-07-19T01:20:50.658Z,1721352050.658 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:50.659Z,1721352050.659 [Onboard](INFO): Join timeout helper Thread ID is 1069 2024-07-19T01:20:51.446Z,1721352051.446 [DataOverHttps](INFO): Radio surface powered OFF, will not connect. 2024-07-19T01:20:53.022Z,1721352053.022 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-19T01:20:53.022Z,1721352053.022 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:53.039Z,1721352053.039 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-07-19T01:20:53.039Z,1721352053.039 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:53.039Z,1721352053.039 [DataOverHttps](INFO): Join timeout helper Thread ID is 1070 2024-07-19T01:20:53.454Z,1721352053.454 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-19T01:20:53.454Z,1721352053.454 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:53.477Z,1721352053.477 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-07-19T01:20:53.477Z,1721352053.477 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:53.478Z,1721352053.478 [BackseatComponent](INFO): Join timeout helper Thread ID is 1071 2024-07-19T01:20:53.646Z,1721352053.646 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-19T01:20:53.646Z,1721352053.646 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:53.651Z,1721352053.651 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-07-19T01:20:53.651Z,1721352053.651 [logger ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:53.651Z,1721352053.651 [logger](INFO): Join timeout helper Thread ID is 1072 2024-07-19T01:20:53.678Z,1721352053.678 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-19T01:20:53.678Z,1721352053.678 [logger ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:53.691Z,1721352053.691 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-07-19T01:20:53.691Z,1721352053.691 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:53.691Z,1721352053.691 [CommandLine](INFO): Join timeout helper Thread ID is 1073 2024-07-19T01:20:53.790Z,1721352053.790 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-19T01:20:53.791Z,1721352053.791 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:53.792Z,1721352053.792 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-07-19T01:20:53.792Z,1721352053.792 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:53.792Z,1721352053.792 [CommandExec](INFO): Join timeout helper Thread ID is 1074 2024-07-19T01:20:53.797Z,1721352053.797 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-07-19T01:20:53.797Z,1721352053.797 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:53.797Z,1721352053.797 [controlThread](INFO): Join timeout helper Thread ID is 1075 2024-07-19T01:20:54.158Z,1721352054.158 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-07-19T01:20:54.158Z,1721352054.158 [controlThread](DEBUG): Uninitializing ControlThread 2024-07-19T01:20:54.159Z,1721352054.159 [AHRS_M2](INFO): Powering down 2024-07-19T01:20:54.232Z,1721352054.232 [NAL9602](INFO): Powering down 2024-07-19T01:20:54.233Z,1721352054.233 [Sonardyne_Nano](INFO): Powering down 2024-07-19T01:20:54.355Z,1721352054.355 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-07-19T01:20:54.356Z,1721352054.356 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-07-19T01:20:54.356Z,1721352054.356 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-07-19T01:20:54.357Z,1721352054.357 [MissionManager](INFO): Uninitializing Mission Default 2024-07-19T01:20:54.357Z,1721352054.357 [Default] Stopped 2024-07-19T01:20:54.357Z,1721352054.357 [Default](DEBUG): Aggregate::uninitialize Default 2024-07-19T01:20:54.357Z,1721352054.357 [Default:B.GoToSurface] Stopped 2024-07-19T01:20:54.357Z,1721352054.357 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-07-19T01:20:54.357Z,1721352054.357 [Default:CheckIn] Stopped 2024-07-19T01:20:54.357Z,1721352054.357 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-07-19T01:20:54.357Z,1721352054.357 [Default:CheckIn:C.Wait] Stopped 2024-07-19T01:20:54.357Z,1721352054.357 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-07-19T01:20:54.360Z,1721352054.360 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-07-19T01:20:54.360Z,1721352054.360 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-07-19T01:20:54.361Z,1721352054.361 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-07-19T01:20:54.361Z,1721352054.361 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-07-19T01:20:54.361Z,1721352054.361 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-07-19T01:20:54.361Z,1721352054.361 [BuoyancyServo](INFO): Powering down 2024-07-19T01:20:54.374Z,1721352054.374 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-07-19T01:20:54.374Z,1721352054.374 [ElevatorServo](INFO): Powering down 2024-07-19T01:20:54.375Z,1721352054.375 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-07-19T01:20:54.375Z,1721352054.375 [MassServo](INFO): Powering down 2024-07-19T01:20:54.376Z,1721352054.376 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-07-19T01:20:54.376Z,1721352054.376 [RudderServo](INFO): Powering down 2024-07-19T01:20:54.377Z,1721352054.377 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-07-19T01:20:54.377Z,1721352054.377 [ThrusterHE](INFO): Powering down 2024-07-19T01:20:54.378Z,1721352054.378 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-07-19T01:20:54.378Z,1721352054.378 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-07-19T01:20:54.378Z,1721352054.378 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-07-19T01:20:54.379Z,1721352054.379 [CBIT](DEBUG): Powering off loads. 2024-07-19T01:20:54.390Z,1721352054.390 [CBIT](DEBUG): Disabling WDT. 2024-07-19T01:20:54.402Z,1721352054.402 [CBIT](DEBUG): Opening all GF detection circuits. 2024-07-19T01:20:54.403Z,1721352054.403 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:54.455Z,1721352054.455 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:54.458Z,1721352054.458 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:54.465Z,1721352054.465 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:54.508Z,1721352054.508 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:54.547Z,1721352054.547 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:54.551Z,1721352054.551 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:54.584Z,1721352054.584 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-07-19T01:20:54.648Z,1721352054.648 [logger ThreadHandler](INFO): Thread cancelled.