2024-09-16T17:19:15.797Z,1726507155.797 [Supervisor](DEBUG): Initializing supervisor. 2024-09-16T17:19:15.801Z,1726507155.801 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2024-09-16T17:19:15.802Z,1726507155.802 [SyncHandler](INFO): Protected caller Thread ID is 839 2024-09-16T17:19:15.802Z,1726507155.802 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2024-09-16T17:19:15.803Z,1726507155.803 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2024-09-16T17:19:15.803Z,1726507155.803 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 840 2024-09-16T17:19:15.807Z,1726507155.807 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2024-09-16T17:19:15.825Z,1726507155.825 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2024-09-16T17:19:15.826Z,1726507155.826 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2024-09-16T17:19:15.826Z,1726507155.826 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 841 2024-09-16T17:19:15.830Z,1726507155.830 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2024-09-16T17:19:15.831Z,1726507155.831 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2024-09-16T17:19:15.831Z,1726507155.831 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 842 2024-09-16T17:19:15.833Z,1726507155.833 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2024-09-16T17:19:15.834Z,1726507155.834 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2024-09-16T17:19:15.835Z,1726507155.835 [logger ThreadHandler](INFO): Protected caller Thread ID is 843 2024-09-16T17:19:15.838Z,1726507155.838 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2024-09-16T17:19:15.839Z,1726507155.839 [Supervisor](INFO): Looking for Config files in directory: Config/ 2024-09-16T17:19:15.843Z,1726507155.843 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2024-09-16T17:19:16.078Z,1726507156.078 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2024-09-16T17:19:16.080Z,1726507156.080 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2024-09-16T17:19:16.199Z,1726507156.199 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2024-09-16T17:19:16.201Z,1726507156.201 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2024-09-16T17:19:16.308Z,1726507156.308 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2024-09-16T17:19:16.308Z,1726507156.308 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2024-09-16T17:19:16.829Z,1726507156.829 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2024-09-16T17:19:16.831Z,1726507156.831 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2024-09-16T17:19:17.195Z,1726507157.195 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2024-09-16T17:19:17.197Z,1726507157.197 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2024-09-16T17:19:17.551Z,1726507157.551 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2024-09-16T17:19:17.553Z,1726507157.553 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2024-09-16T17:19:17.752Z,1726507157.752 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2024-09-16T17:19:17.754Z,1726507157.754 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2024-09-16T17:19:17.933Z,1726507157.933 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2024-09-16T17:19:18.031Z,1726507158.031 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2024-09-16T17:19:18.466Z,1726507158.466 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2024-09-16T17:19:18.467Z,1726507158.467 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2024-09-16T17:19:19.322Z,1726507159.322 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2024-09-16T17:19:19.324Z,1726507159.324 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2024-09-16T17:19:19.908Z,1726507159.908 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2024-09-16T17:19:19.909Z,1726507159.909 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2024-09-16T17:19:20.160Z,1726507160.160 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2024-09-16T17:19:20.162Z,1726507160.162 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2024-09-16T17:19:20.420Z,1726507160.420 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2024-09-16T17:19:20.422Z,1726507160.422 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2024-09-16T17:19:20.572Z,1726507160.572 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2024-09-16T17:19:20.572Z,1726507160.572 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2024-09-16T17:19:21.460Z,1726507161.460 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2024-09-16T17:19:21.462Z,1726507161.462 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/ 2024-09-16T17:19:21.465Z,1726507161.465 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/secure.cfg 2024-09-16T17:19:21.561Z,1726507161.561 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/vehicle.cfg 2024-09-16T17:19:21.702Z,1726507161.702 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Battery.cfg 2024-09-16T17:19:21.976Z,1726507161.976 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2024-09-16T17:19:21.977Z,1726507161.977 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Science.cfg 2024-09-16T17:19:22.112Z,1726507162.112 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Control.cfg 2024-09-16T17:19:22.223Z,1726507162.223 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/logger.cfg 2024-09-16T17:19:22.327Z,1726507162.327 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Servo.cfg 2024-09-16T17:19:22.446Z,1726507162.446 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Navigation.cfg 2024-09-16T17:19:22.553Z,1726507162.553 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Simulator.cfg 2024-09-16T17:19:22.650Z,1726507162.650 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/BIT.cfg 2024-09-16T17:19:22.751Z,1726507162.751 [Supervisor](INFO): Opening Config file at: Config/lrauv-galene/Sensor.cfg 2024-09-16T17:19:22.932Z,1726507162.932 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-galene/root/ 2024-09-16T17:19:22.933Z,1726507162.933 [Supervisor](IMPORTANT): Reloading configuration overrides from Data/persisted.cfg 2024-09-16T17:19:22.943Z,1726507162.943 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2024-09-16T17:19:23.015Z,1726507163.015 [DepthRateCalculator] Loaded 2024-09-16T17:19:23.015Z,1726507163.015 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2024-09-16T17:19:23.020Z,1726507163.020 [PitchRateCalculator] Loaded 2024-09-16T17:19:23.020Z,1726507163.020 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2024-09-16T17:19:23.030Z,1726507163.030 [SpeedCalculator] Loaded 2024-09-16T17:19:23.031Z,1726507163.031 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2024-09-16T17:19:23.035Z,1726507163.035 [YawRateCalculator] Loaded 2024-09-16T17:19:23.036Z,1726507163.036 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2024-09-16T17:19:23.057Z,1726507163.057 [ElevatorOffsetCalculator] Loaded 2024-09-16T17:19:23.057Z,1726507163.057 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2024-09-16T17:19:23.058Z,1726507163.058 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2024-09-16T17:19:23.058Z,1726507163.058 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2024-09-16T17:19:23.100Z,1726507163.100 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2024-09-16T17:19:23.101Z,1726507163.101 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2024-09-16T17:19:23.116Z,1726507163.116 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2024-09-16T17:19:23.117Z,1726507163.117 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2024-09-16T17:19:23.891Z,1726507163.891 [AHRS_M2] Loaded 2024-09-16T17:19:23.892Z,1726507163.892 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2024-09-16T17:19:24.144Z,1726507164.144 [BackseatComponent] Loaded 2024-09-16T17:19:24.144Z,1726507164.144 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2024-09-16T17:19:24.145Z,1726507164.145 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 408584E0 2024-09-16T17:19:24.146Z,1726507164.146 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 926 2024-09-16T17:19:24.148Z,1726507164.148 [LcmUniversalReporter] Loaded 2024-09-16T17:19:24.149Z,1726507164.149 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2024-09-16T17:19:24.948Z,1726507164.948 [BPC1] Loaded 2024-09-16T17:19:24.948Z,1726507164.948 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2024-09-16T17:19:25.038Z,1726507165.038 [DAT] Loaded 2024-09-16T17:19:25.038Z,1726507165.038 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 2024-09-16T17:19:25.039Z,1726507165.039 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408884E0 2024-09-16T17:19:25.039Z,1726507165.039 [DAT ThreadHandler](INFO): Protected caller Thread ID is 927 2024-09-16T17:19:25.188Z,1726507165.188 [DataOverHttps] Loaded 2024-09-16T17:19:25.189Z,1726507165.189 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2024-09-16T17:19:25.190Z,1726507165.190 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408B84E0 2024-09-16T17:19:25.190Z,1726507165.190 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 928 2024-09-16T17:19:25.212Z,1726507165.212 [Depth_Keller] Loaded 2024-09-16T17:19:25.213Z,1726507165.213 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2024-09-16T17:19:25.218Z,1726507165.218 [DropWeight] Loaded 2024-09-16T17:19:25.218Z,1726507165.218 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2024-09-16T17:19:25.281Z,1726507165.281 [NAL9602] Loaded 2024-09-16T17:19:25.281Z,1726507165.281 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2024-09-16T17:19:25.310Z,1726507165.310 [Onboard] Loaded 2024-09-16T17:19:25.310Z,1726507165.310 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2024-09-16T17:19:25.311Z,1726507165.311 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408E84E0 2024-09-16T17:19:25.312Z,1726507165.312 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 929 2024-09-16T17:19:25.325Z,1726507165.325 [Power24vConverter] Loaded 2024-09-16T17:19:25.326Z,1726507165.326 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2024-09-16T17:19:25.342Z,1726507165.342 [Radio_Surface] Loaded 2024-09-16T17:19:25.342Z,1726507165.342 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2024-09-16T17:19:25.343Z,1726507165.343 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 409184E0 2024-09-16T17:19:25.344Z,1726507165.344 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 930 2024-09-16T17:19:25.358Z,1726507165.358 [Sonardyne_Nano] Loaded 2024-09-16T17:19:25.359Z,1726507165.359 [ComponentRegistry](DEBUG): SyncComponent "Sonardyne_Nano" handled in the control thread. 2024-09-16T17:19:25.382Z,1726507165.382 [Waterlinked] Loaded 2024-09-16T17:19:25.382Z,1726507165.382 [ComponentRegistry](DEBUG): SyncComponent "Waterlinked" handled in the control thread. 2024-09-16T17:19:25.383Z,1726507165.383 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2024-09-16T17:19:25.383Z,1726507165.383 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2024-09-16T17:19:26.345Z,1726507166.345 [DeadReckonUsingMultipleVelocitySources] Loaded 2024-09-16T17:19:26.346Z,1726507166.346 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2024-09-16T17:19:26.398Z,1726507166.398 [DeadReckonUsingSpeedCalculator] Loaded 2024-09-16T17:19:26.399Z,1726507166.399 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 2024-09-16T17:19:26.412Z,1726507166.412 [NavChart] Loaded 2024-09-16T17:19:26.412Z,1726507166.412 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2024-09-16T17:19:26.418Z,1726507166.418 [UniversalFixResidualReporter] Loaded 2024-09-16T17:19:26.418Z,1726507166.418 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2024-09-16T17:19:26.418Z,1726507166.418 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2024-09-16T17:19:26.419Z,1726507166.419 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2024-09-16T17:19:26.584Z,1726507166.584 [SBIT](DEBUG): Construct Startup Built In Test. 2024-09-16T17:19:26.599Z,1726507166.599 [SBIT] Loaded 2024-09-16T17:19:26.599Z,1726507166.599 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2024-09-16T17:19:26.602Z,1726507166.602 [IBIT](DEBUG): Construct Initiated Built In Test. 2024-09-16T17:19:26.614Z,1726507166.614 [IBIT] Loaded 2024-09-16T17:19:26.614Z,1726507166.614 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2024-09-16T17:19:26.620Z,1726507166.620 [CBIT](DEBUG): Construct Continuous Built In Test. 2024-09-16T17:19:26.723Z,1726507166.723 [CBIT] Loaded 2024-09-16T17:19:26.724Z,1726507166.724 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2024-09-16T17:19:26.724Z,1726507166.724 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2024-09-16T17:19:26.724Z,1726507166.724 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2024-09-16T17:19:26.945Z,1726507166.945 [CTD_Seabird] Loaded 2024-09-16T17:19:26.945Z,1726507166.945 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2024-09-16T17:19:26.947Z,1726507166.947 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A204E0 2024-09-16T17:19:26.947Z,1726507166.947 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 931 2024-09-16T17:19:26.971Z,1726507166.971 [PAR_Licor] Loaded 2024-09-16T17:19:26.971Z,1726507166.971 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2024-09-16T17:19:27.015Z,1726507167.015 [WetLabsBB2FL] Loaded 2024-09-16T17:19:27.015Z,1726507167.015 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2024-09-16T17:19:27.016Z,1726507167.016 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A504E0 2024-09-16T17:19:27.017Z,1726507167.017 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 932 2024-09-16T17:19:27.018Z,1726507167.018 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2024-09-16T17:19:27.018Z,1726507167.018 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2024-09-16T17:19:27.184Z,1726507167.184 [BuoyancyServo] Loaded 2024-09-16T17:19:27.185Z,1726507167.185 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2024-09-16T17:19:27.208Z,1726507167.208 [ElevatorServo] Loaded 2024-09-16T17:19:27.209Z,1726507167.209 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2024-09-16T17:19:27.232Z,1726507167.232 [MassServo] Loaded 2024-09-16T17:19:27.232Z,1726507167.232 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2024-09-16T17:19:27.254Z,1726507167.254 [RudderServo] Loaded 2024-09-16T17:19:27.254Z,1726507167.254 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2024-09-16T17:19:27.271Z,1726507167.271 [ThrusterHE] Loaded 2024-09-16T17:19:27.272Z,1726507167.272 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2024-09-16T17:19:27.272Z,1726507167.272 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2024-09-16T17:19:27.273Z,1726507167.273 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2024-09-16T17:19:27.341Z,1726507167.341 [VerticalControl](DEBUG): Construct VerticalControl. 2024-09-16T17:19:27.392Z,1726507167.392 [VerticalControl] Loaded 2024-09-16T17:19:27.392Z,1726507167.392 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2024-09-16T17:19:27.395Z,1726507167.395 [HorizontalControl](DEBUG): Construct HorizontalControl. 2024-09-16T17:19:27.439Z,1726507167.439 [HorizontalControl] Loaded 2024-09-16T17:19:27.440Z,1726507167.440 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2024-09-16T17:19:27.442Z,1726507167.442 [SpeedControl](DEBUG): Construct SpeedControl. 2024-09-16T17:19:27.444Z,1726507167.444 [SpeedControl] Loaded 2024-09-16T17:19:27.444Z,1726507167.444 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2024-09-16T17:19:27.447Z,1726507167.447 [LoopControl](DEBUG): Construct LoopControl. 2024-09-16T17:19:27.447Z,1726507167.447 [LoopControl] Loaded 2024-09-16T17:19:27.448Z,1726507167.448 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2024-09-16T17:19:27.448Z,1726507167.448 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2024-09-16T17:19:27.449Z,1726507167.449 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2024-09-16T17:19:27.585Z,1726507167.585 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2024-09-16T17:19:27.586Z,1726507167.586 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2024-09-16T17:19:27.791Z,1726507167.791 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2024-09-16T17:19:27.791Z,1726507167.791 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2024-09-16T17:19:28.182Z,1726507168.182 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2024-09-16T17:19:28.183Z,1726507168.183 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2024-09-16T17:19:28.264Z,1726507168.264 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2024-09-16T17:19:28.271Z,1726507168.271 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2024-09-16T17:19:28.274Z,1726507168.274 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2024-09-16T17:19:28.285Z,1726507168.285 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2024-09-16T17:19:28.286Z,1726507168.286 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40C374E0 2024-09-16T17:19:28.286Z,1726507168.286 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 933 2024-09-16T17:19:28.291Z,1726507168.291 [Supervisor](INFO): Main Thread ID is 831 2024-09-16T17:19:28.291Z,1726507168.291 [Supervisor](DEBUG): Running supervisor. 2024-09-16T17:19:28.292Z,1726507168.292 [CommandExec ThreadHandler](INFO): Handler Thread ID is 934 2024-09-16T17:19:28.292Z,1726507168.292 [CommandExec](INFO): Initializing the command executive. 2024-09-16T17:19:28.293Z,1726507168.293 [CommandLine ThreadHandler](INFO): Handler Thread ID is 935 2024-09-16T17:19:28.296Z,1726507168.296 [controlThread ThreadHandler](INFO): Handler Thread ID is 936 2024-09-16T17:19:28.296Z,1726507168.296 [controlThread](DEBUG): Initializing ControlThread 2024-09-16T17:19:28.297Z,1726507168.297 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2024-09-16T17:19:28.297Z,1726507168.297 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2024-09-16T17:19:28.298Z,1726507168.298 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2024-09-16T17:19:28.298Z,1726507168.298 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2024-09-16T17:19:28.298Z,1726507168.298 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2024-09-16T17:19:28.303Z,1726507168.303 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-09-16T17:19:28.304Z,1726507168.304 [NavChart](DEBUG): Initialize NavChart Navigation. 2024-09-16T17:19:28.304Z,1726507168.304 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2024-09-16T17:19:28.305Z,1726507168.305 [SBIT](INFO): Initialize SBIT Component. 2024-09-16T17:19:28.305Z,1726507168.305 [SBIT](IMPORTANT): git: 2024-09-16-2-g9a6e6361e 2024-09-16T17:19:28.305Z,1726507168.305 [SBIT](INFO): git hash: 9a6e6361ee0225b4338ccb03ae7adeebd6db69cf 2024-09-16T17:19:28.306Z,1726507168.306 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2024-09-16T17:19:28.307Z,1726507168.307 [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-09-16T17:19:28.308Z,1726507168.308 [SBIT](INFO): Beginning SBIT in 104.000000 seconds. 2024-09-16T17:19:28.308Z,1726507168.308 [IBIT](INFO): Initialize IBIT Component. 2024-09-16T17:19:28.309Z,1726507168.309 [CBIT](DEBUG): Initialize CBIT Component. 2024-09-16T17:19:28.310Z,1726507168.310 [logger ThreadHandler](INFO): Handler Thread ID is 937 2024-09-16T17:19:28.321Z,1726507168.321 [CBIT](DEBUG): Initialized mux pins. 2024-09-16T17:19:28.321Z,1726507168.321 [CBIT](DEBUG): Initializing the watchdog timer. 2024-09-16T17:19:28.329Z,1726507168.329 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 938 2024-09-16T17:19:28.341Z,1726507168.341 [DAT ThreadHandler](INFO): Handler Thread ID is 939 2024-09-16T17:19:28.342Z,1726507168.342 [DAT](INFO): Powering up 2024-09-16T17:19:28.342Z,1726507168.342 [DAT](DEBUG): Initializing DAT. 2024-09-16T17:19:28.345Z,1726507168.345 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2024-09-16T17:19:28.345Z,1726507168.345 [CBIT](DEBUG): Initializing heartbeat. 2024-09-16T17:19:28.347Z,1726507168.347 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 941 2024-09-16T17:19:28.349Z,1726507168.349 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2024-09-16T17:19:28.358Z,1726507168.358 [Onboard ThreadHandler](INFO): Handler Thread ID is 942 2024-09-16T17:19:28.375Z,1726507168.375 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 943 2024-09-16T17:19:28.394Z,1726507168.394 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 944 2024-09-16T17:19:28.394Z,1726507168.394 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2024-09-16T17:19:28.398Z,1726507168.398 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 946 2024-09-16T17:19:28.401Z,1726507168.401 [WetLabsBB2FL](INFO): Powering up 2024-09-16T17:19:28.402Z,1726507168.402 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 948 2024-09-16T17:19:28.410Z,1726507168.410 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2024-09-16T17:19:28.410Z,1726507168.410 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2024-09-16T17:19:28.410Z,1726507168.410 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2024-09-16T17:19:28.410Z,1726507168.410 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2024-09-16T17:19:28.410Z,1726507168.410 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2024-09-16T17:19:28.410Z,1726507168.410 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2024-09-16T17:19:28.411Z,1726507168.411 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2024-09-16T17:19:28.411Z,1726507168.411 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2024-09-16T17:19:28.417Z,1726507168.417 [CBIT](DEBUG): Deactivating GF circuits. 2024-09-16T17:19:28.417Z,1726507168.417 [CBIT](DEBUG): Deactivating emergency mode. 2024-09-16T17:19:28.457Z,1726507168.457 [CBIT](DEBUG): Backplane powered. 2024-09-16T17:19:28.462Z,1726507168.462 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2024-09-16T17:19:28.464Z,1726507168.464 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2024-09-16T17:19:28.465Z,1726507168.465 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2024-09-16T17:19:28.465Z,1726507168.465 [LoopControl](DEBUG): Initialize LoopControlComponent. 2024-09-16T17:19:28.466Z,1726507168.466 [MissionManager](IMPORTANT): Using TethysL tl-to-tx parser 2024-09-16T17:19:28.466Z,1726507168.466 [MissionManager](INFO): Loading Mission from file: Missions/Startup.tl 2024-09-16T17:19:28.467Z,1726507168.467 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Startup.tl 2024-09-16T17:19:28.472Z,1726507168.472 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Startup.tl 2024-09-16T17:19:28.530Z,1726507168.530 [MissionManager](DEBUG): TethyslAPI: Missions/Startup.tl translated into: 2024-09-16T17:19:28.547Z,1726507168.547 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2024-09-16T17:19:28.570Z,1726507168.570 [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-09-16T17:19:28.571Z,1726507168.571 [MissionManager](INFO): Loading Mission from file: Missions/Default.tl 2024-09-16T17:19:28.571Z,1726507168.571 [MissionManager](DEBUG): TethyslAPI: loading: Missions/Default.tl 2024-09-16T17:19:28.574Z,1726507168.574 [MissionManager](DEBUG): TethyslAPI: mission file loaded: Missions/Default.tl 2024-09-16T17:19:28.781Z,1726507168.781 [Radio_Surface](INFO): Powering up 2024-09-16T17:19:28.782Z,1726507168.782 [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-09-16T17:19:28.792Z,1726507168.792 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2024-09-16T17:19:28.801Z,1726507168.801 [Default:A.Wait](DEBUG): Construct Wait. 2024-09-16T17:19:28.803Z,1726507168.803 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2024-09-16T17:19:28.832Z,1726507168.832 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2024-09-16T17:19:28.840Z,1726507168.840 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2024-09-16T17:19:28.862Z,1726507168.862 [Default:E.Execute](DEBUG): Construct Execute. 2024-09-16T17:19:28.865Z,1726507168.865 [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-09-16T17:19:28.881Z,1726507168.881 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,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-09-16T17:19:28.887Z,1726507168.887 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2024-09-16T17:19:29.015Z,1726507169.015 [Power24vConverter](INFO): Powering up. 2024-09-16T17:19:29.016Z,1726507169.016 [Sonardyne_Nano](INFO): Initializing. 2024-09-16T17:19:29.088Z,1726507169.088 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2024-09-16T17:19:29.093Z,1726507169.093 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2024-09-16T17:19:29.094Z,1726507169.094 [ElevatorServo](DEBUG): Initializing EZServoServo. 2024-09-16T17:19:29.101Z,1726507169.101 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2024-09-16T17:19:29.102Z,1726507169.102 [MassServo](DEBUG): Initializing EZServoServo. 2024-09-16T17:19:29.109Z,1726507169.109 [MassServo](DEBUG): Initializing MassServo. 2024-09-16T17:19:29.110Z,1726507169.110 [RudderServo](DEBUG): Initializing EZServoServo. 2024-09-16T17:19:29.122Z,1726507169.122 [RudderServo](DEBUG): Initializing RudderServo. 2024-09-16T17:19:29.122Z,1726507169.122 [ThrusterHE](DEBUG): Initializing EZServoServo. 2024-09-16T17:19:29.129Z,1726507169.129 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2024-09-16T17:19:31.013Z,1726507171.013 [WetLabsBB2FL](INFO): Powering down 2024-09-16T17:19:31.315Z,1726507171.315 [Sonardyne_Nano](ERROR): Failed to get valid response or reached max queue size, flushing UART 2024-09-16T17:19:32.554Z,1726507172.554 [Sonardyne_Nano](IMPORTANT): Found beacon with acoustic ID 2105 2024-09-16T17:19:34.751Z,1726507174.751 [CommandExec](IMPORTANT): got command strobe off 2024-09-16T17:19:34.751Z,1726507174.751 [CommandExec](IMPORTANT): Deactivating strobe 2024-09-16T17:19:34.766Z,1726507174.766 [ThrusterHE](ERROR): Zero Speed Commanded. 2024-09-16T17:19:41.211Z,1726507181.211 [DAT](INFO): DAT read: 2024-09-16T17:19:41.462Z,1726507181.462 [DAT](INFO): DAT read: Teledyne Benthos DAT-900 Series 2024-09-16T17:19:43.226Z,1726507183.226 [DAT](INFO): DAT read: MF Frequency Band 2024-09-16T17:19:43.227Z,1726507183.227 [DAT](INFO): DAT read: Directional Acoustic Transponder version 8.15.0 2024-09-16T17:19:43.227Z,1726507183.227 [DAT](INFO): DAT read: Sep 16 2024 17:19:38 2024-09-16T17:19:44.239Z,1726507184.239 [DAT](INFO): DAT read: Features enabled [Bearing] 2024-09-16T17:19:44.240Z,1726507184.240 [DAT](INFO): DAT read: CONNECT 00800 bits/sec 1 of 4, Rate 1/2 CC 12.50ms MGP 2024-09-16T17:19:44.240Z,1726507184.240 [DAT](INFO): commRate: 800 2024-09-16T17:19:46.301Z,1726507186.301 [DAT](INFO): entering command mode 2024-09-16T17:19:46.501Z,1726507186.501 [DAT](INFO): DAT read: 2024-09-16T17:19:46.502Z,1726507186.502 [DAT](INFO): DAT read: user:1> 2024-09-16T17:19:46.502Z,1726507186.502 [DAT](INFO): setting verbose to 3 2024-09-16T17:19:46.753Z,1726507186.753 [DAT](INFO): DAT read: user:1> 2024-09-16T17:19:46.754Z,1726507186.754 [DAT](INFO): DAT read: Verbose | 3 2024-09-16T17:19:46.755Z,1726507186.755 [DAT](INFO): set verbose to 3 2024-09-16T17:19:46.755Z,1726507186.755 [DAT](INFO): setting DatVerbose to 27440 2024-09-16T17:19:47.005Z,1726507187.005 [DAT](INFO): DAT read: user:2> 2024-09-16T17:19:47.006Z,1726507187.006 [DAT](INFO): DAT read: DatVerbose | 27440 2024-09-16T17:19:47.007Z,1726507187.007 [DAT](INFO): set DatVerbose to 27440 2024-09-16T17:19:47.007Z,1726507187.007 [DAT](INFO): setting transmit power to 8 2024-09-16T17:19:47.258Z,1726507187.258 [DAT](INFO): DAT read: user:3> 2024-09-16T17:19:47.258Z,1726507187.258 [DAT](INFO): DAT read: TxPower | 8 (Max) 2024-09-16T17:19:47.259Z,1726507187.259 [DAT](INFO): set transmit power to 8 2024-09-16T17:19:47.259Z,1726507187.259 [DAT](INFO): setting local address to 9 2024-09-16T17:19:47.510Z,1726507187.510 [DAT](INFO): DAT read: user:4> 2024-09-16T17:19:47.511Z,1726507187.511 [DAT](INFO): DAT read: LocalAddr | 9 2024-09-16T17:19:47.512Z,1726507187.512 [DAT](INFO): set local address to 9 2024-09-16T17:19:47.513Z,1726507187.513 [DAT](INFO): Setting time to: 17:19:47 And date to:9/16/2024 2024-09-16T17:19:47.761Z,1726507187.761 [DAT](INFO): DAT read: user:5> 2024-09-16T17:19:47.762Z,1726507187.762 [DAT](INFO): DAT read: Mon Sep 16, 2024 17:19:47 2024-09-16T17:19:47.763Z,1726507187.763 [DAT](INFO): Local DAT time set to Mon Sep 16, 2024 17:19:47 2024-09-16T17:19:55.567Z,1726507195.567 [NAL9602](INFO): Powering up NAL9602 2024-09-16T17:20:00.150Z,1726507200.150 [CommandExec](IMPORTANT): got command strobe off 2024-09-16T17:20:00.150Z,1726507200.150 [CommandExec](IMPORTANT): Deactivating strobe 2024-09-16T17:20:06.471Z,1726507206.471 [NAL9602](INFO): NAL9602 initialized 2024-09-16T17:20:06.714Z,1726507206.714 [CommandExec](IMPORTANT): got command strobe off 2024-09-16T17:20:06.714Z,1726507206.714 [CommandExec](IMPORTANT): Deactivating strobe 2024-09-16T17:21:05.941Z,1726507265.941 [Waterlinked](INFO): Powering down 2024-09-16T17:21:12.768Z,1726507272.768 [SBIT](IMPORTANT): Beginning Startup BIT 2024-09-16T17:21:12.772Z,1726507272.772 [CBIT](IMPORTANT): Beginning ground fault scan 2024-09-16T17:21:23.705Z,1726507283.705 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.010292 CHAN A1 (24V): 0.001092 CHAN A2 (12V): -0.004716 CHAN A3 (5V): -0.002186 CHAN B0 (3.3V): -0.001432 CHAN B1 (3.15aV): -0.001237 CHAN B2 (3.15bV): -0.001744 CHAN B3 (GND): 0.000037 OPEN: 0.004684 Full Scale: +/- 1 mA 2024-09-16T17:21:45.118Z,1726507305.118 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-16T17:21:45.777Z,1726507305.777 [CommandExec](IMPORTANT): got command get WetLabsBB2FL.loadAtStartup 2024-09-16T17:21:45.778Z,1726507305.778 [CommandExec](IMPORTANT): WetLabsBB2FL.loadAtStartup 1 bool 2024-09-16T17:21:59.431Z,1726507319.431 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004986 2024-09-16T17:22:06.814Z,1726507326.814 [SBIT](IMPORTANT): SBIT PASSED 2024-09-16T17:22:06.814Z,1726507326.815 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2024-09-16T17:22:06.815Z,1726507326.815 [SBIT](IMPORTANT): Express linearApproximation _.ayeris_particle_counts 250.000000 count; 2024-09-16T17:22:06.815Z,1726507326.815 [SBIT](IMPORTANT): Express linearApproximation height_above_sea_floor 10.000000 meter; 2024-09-16T17:22:06.816Z,1726507326.816 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=180.764238 cubic_centimeter; 2024-09-16T17:22:06.816Z,1726507326.816 [SBIT](IMPORTANT): VerticalControl.massDefault=21.225185 millimeter; 2024-09-16T17:22:07.224Z,1726507327.224 [MissionManager](IMPORTANT): Started mission Startup 2024-09-16T17:22:07.224Z,1726507327.224 [Startup] Running Loop=1 2024-09-16T17:22:07.224Z,1726507327.224 [Startup](DEBUG): Aggregate::initialize Startup 2024-09-16T17:22:07.224Z,1726507327.224 [Startup:A.GoToSurface] Running Loop=1 2024-09-16T17:22:07.225Z,1726507327.225 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-09-16T17:22:07.225Z,1726507327.225 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-09-16T17:22:07.225Z,1726507327.225 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-09-16T17:22:07.226Z,1726507327.226 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-09-16T17:22:07.226Z,1726507327.226 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-09-16T17:22:07.227Z,1726507327.227 [Startup:A.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-09-16T17:22:07.227Z,1726507327.227 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-09-16T17:22:07.229Z,1726507327.229 [Startup:StartupSatComms] Running Loop=1 2024-09-16T17:22:07.229Z,1726507327.229 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2024-09-16T17:22:07.229Z,1726507327.229 [Startup:StartupSatComms:A] Running Loop=1 2024-09-16T17:22:07.613Z,1726507327.613 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2024-09-16T17:22:28.624Z,1726507348.624 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2024-09-16T17:22:28.624Z,1726507348.624 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-16T17:22:28.625Z,1726507348.625 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1 2024-09-16T17:22:28.625Z,1726507348.625 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-09-16T17:22:28.636Z,1726507348.636 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-16T17:22:28.636Z,1726507348.636 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-09-16T17:22:29.065Z,1726507349.065 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:22:29.091Z,1726507349.091 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-16T17:22:29.091Z,1726507349.091 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2024-09-16T17:22:29.092Z,1726507349.092 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-09-16T17:22:29.092Z,1726507349.092 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1 2024-09-16T17:22:29.484Z,1726507349.484 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-16T17:22:29.493Z,1726507349.493 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-09-16T17:22:47.282Z,1726507367.282 [CommandExec](IMPORTANT): got command get PAR_Licor.loadAtStartup 2024-09-16T17:22:47.282Z,1726507367.282 [CommandExec](IMPORTANT): PAR_Licor.loadAtStartup 1 bool 2024-09-16T17:22:56.020Z,1726507376.020 [CommandExec](IMPORTANT): got command get Sonardyne_Nano.chargePercent 2024-09-16T17:22:56.020Z,1726507376.020 [CommandExec](IMPORTANT): Sonardyne_Nano.chargePercent 100.000000 % 2024-09-16T17:23:04.083Z,1726507384.083 [CommandExec](IMPORTANT): got command get CTD_Seabird.loadAtStartup 2024-09-16T17:23:04.083Z,1726507384.083 [CommandExec](IMPORTANT): CTD_Seabird.loadAtStartup 1 bool 2024-09-16T17:23:07.450Z,1726507387.450 [Startup:StartupSatComms:A](INFO): Timed out from 2024-09-16T17:22:07.2Z 2024-09-16T17:23:07.450Z,1726507387.450 [Startup:StartupSatComms:A] Stopped 2024-09-16T17:23:07.450Z,1726507387.450 [Startup:StartupSatComms:B] Running Loop=1 2024-09-16T17:23:07.864Z,1726507387.864 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-09-16T17:23:08.763Z,1726507388.763 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240916T171915/Courier0000.lzma 2024-09-16T17:23:09.756Z,1726507389.756 [DataOverHttps](INFO): Moved sent file to Logs/20240916T171915/Courier0000.lzma.bak 2024-09-16T17:23:09.756Z,1726507389.756 [DataOverHttps](INFO): SBD MOMSN=23190501 2024-09-16T17:23:25.444Z,1726507405.444 [DataOverHttps](INFO): Sending 1022 bytes from file Logs/20240916T171915/Express0001.lzma 2024-09-16T17:23:26.444Z,1726507406.444 [DataOverHttps](INFO): Moved sent file to Logs/20240916T171915/Express0001.lzma.bak 2024-09-16T17:23:26.444Z,1726507406.444 [DataOverHttps](INFO): SBD MOMSN=23190504 2024-09-16T17:23:27.737Z,1726507407.737 [Startup:StartupSatComms:B] Stopped 2024-09-16T17:23:27.737Z,1726507407.737 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2024-09-16T17:23:27.738Z,1726507407.738 [Startup:StartupSatComms] Stopped 2024-09-16T17:23:27.738Z,1726507407.738 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2024-09-16T17:23:27.739Z,1726507407.739 [Startup](INFO): Completed Startup 2024-09-16T17:23:27.739Z,1726507407.739 [MissionManager](INFO): Startup is completed. 2024-09-16T17:23:27.739Z,1726507407.739 [MissionManager](INFO): Uninitializing Mission Startup 2024-09-16T17:23:27.739Z,1726507407.739 [Startup] Stopped 2024-09-16T17:23:27.739Z,1726507407.739 [Startup](DEBUG): Aggregate::uninitialize Startup 2024-09-16T17:23:27.739Z,1726507407.739 [Startup:A.GoToSurface] Stopped 2024-09-16T17:23:27.739Z,1726507407.739 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-09-16T17:23:28.121Z,1726507408.121 [MissionManager](IMPORTANT): Started mission Default 2024-09-16T17:23:28.121Z,1726507408.121 [Default] Running Loop=1 2024-09-16T17:23:28.121Z,1726507408.121 [Default](DEBUG): Aggregate::initialize Default 2024-09-16T17:23:28.121Z,1726507408.121 [Default:B.GoToSurface] Running Loop=1 2024-09-16T17:23:28.121Z,1726507408.121 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2024-09-16T17:23:28.122Z,1726507408.122 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2024-09-16T17:23:28.122Z,1726507408.122 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2024-09-16T17:23:28.122Z,1726507408.122 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2024-09-16T17:23:28.123Z,1726507408.123 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2024-09-16T17:23:28.123Z,1726507408.123 [Default:B.GoToSurface](DEBUG): No altitude timeout specified. Using default value of 600.000000 seconds. 2024-09-16T17:23:28.123Z,1726507408.123 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2024-09-16T17:23:28.123Z,1726507408.123 [Default:A.Wait] Running Loop=1 2024-09-16T17:23:28.124Z,1726507408.124 [Default:A.Wait](DEBUG): Initialize Wait Component. 2024-09-16T17:23:38.242Z,1726507418.242 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:23:41.449Z,1726507421.449 [Default:A.Wait](INFO): Done Waiting. 2024-09-16T17:23:41.449Z,1726507421.449 [Default:A.Wait] Stopped 2024-09-16T17:23:41.449Z,1726507421.449 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2024-09-16T17:23:41.855Z,1726507421.855 [Default:CheckIn] Running Loop=1 2024-09-16T17:23:41.855Z,1726507421.855 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-16T17:23:41.855Z,1726507421.855 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-16T17:23:42.263Z,1726507422.263 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2024-09-16T17:23:56.783Z,1726507436.783 [BPC1](ERROR): BPC1B got IPBS message with 5 sticks (min is 7). 2024-09-16T17:23:56.787Z,1726507436.787 [BPC1](ERROR): BPC1B failed to parse battery stick message. 2024-09-16T17:25:00.275Z,1726507500.275 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:25:09.508Z,1726507509.508 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2024-09-16T17:25:26.929Z,1726507526.929 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:25:29.747Z,1726507529.747 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2024-09-16T17:25:29.747Z,1726507529.747 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-16T17:25:29.748Z,1726507529.748 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2 2024-09-16T17:25:29.748Z,1726507529.748 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-09-16T17:25:29.796Z,1726507529.796 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-16T17:25:29.796Z,1726507529.796 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-09-16T17:25:30.153Z,1726507530.153 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-16T17:25:30.153Z,1726507530.153 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2024-09-16T17:25:30.153Z,1726507530.153 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-09-16T17:25:30.153Z,1726507530.153 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2 2024-09-16T17:25:30.550Z,1726507530.550 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-09-16T17:26:31.577Z,1726507591.577 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-16T17:26:54.715Z,1726507614.715 [CommandExec](IMPORTANT): got command burn on 2024-09-16T17:26:54.715Z,1726507614.715 [CommandExec](IMPORTANT): Activating dropweight wire 2024-09-16T17:26:57.432Z,1726507617.432 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:27:28.851Z,1726507648.851 [CommandExec](IMPORTANT): got command burn off 2024-09-16T17:27:28.851Z,1726507648.851 [CommandExec](IMPORTANT): Deactivating dropweight wire 2024-09-16T17:27:46.736Z,1726507666.736 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-16T17:27:55.603Z,1726507675.603 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:28:01.613Z,1726507681.613 [BPC1](ERROR): BPC1B: No match for serial number 0000 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2024-09-16T17:28:09.344Z,1726507689.344 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:28:23.888Z,1726507703.888 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:28:30.724Z,1726507710.724 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2024-09-16T17:28:30.724Z,1726507710.724 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-16T17:28:30.725Z,1726507710.725 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3 2024-09-16T17:28:30.725Z,1726507710.725 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-09-16T17:28:30.735Z,1726507710.735 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-16T17:28:30.735Z,1726507710.735 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-09-16T17:28:31.181Z,1726507711.181 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-16T17:28:31.181Z,1726507711.181 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2024-09-16T17:28:31.182Z,1726507711.182 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-09-16T17:28:31.182Z,1726507711.182 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3 2024-09-16T17:28:31.547Z,1726507711.547 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-09-16T17:28:42.049Z,1726507722.049 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-16T17:23:41.9Z 2024-09-16T17:28:42.049Z,1726507722.049 [Default:CheckIn:Read_GPS] Stopped 2024-09-16T17:28:42.049Z,1726507722.049 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-16T17:28:42.461Z,1726507722.461 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2024-09-16T17:28:49.325Z,1726507729.325 [DataOverHttps](INFO): Sending 38 bytes from file Logs/20240916T171915/Courier0004.lzma 2024-09-16T17:28:50.328Z,1726507730.328 [DataOverHttps](INFO): Moved sent file to Logs/20240916T171915/Courier0004.lzma.bak 2024-09-16T17:28:50.328Z,1726507730.328 [DataOverHttps](INFO): SBD MOMSN=23190549 2024-09-16T17:29:05.990Z,1726507745.990 [DataOverHttps](INFO): Sending 252 bytes from file Logs/20240916T171915/Express0005.lzma 2024-09-16T17:29:06.992Z,1726507746.992 [DataOverHttps](INFO): Moved sent file to Logs/20240916T171915/Express0005.lzma.bak 2024-09-16T17:29:06.992Z,1726507746.992 [DataOverHttps](INFO): SBD MOMSN=23190551 2024-09-16T17:29:08.289Z,1726507748.289 [Default:CheckIn:Read_Iridium] Stopped 2024-09-16T17:29:08.289Z,1726507748.289 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-16T17:29:08.289Z,1726507748.289 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-16T17:29:37.820Z,1726507777.820 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:29:55.586Z,1726507795.586 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-16T17:30:08.872Z,1726507808.872 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-09-16T17:30:08.872Z,1726507808.872 [NAL9602] Data Fault, FailCount= 1 2024-09-16T17:30:08.872Z,1726507808.872 [NAL9602](ERROR): Data Fault 2024-09-16T17:30:08.929Z,1726507808.929 [CBIT](ERROR): Data Fault in component: NAL9602 2024-09-16T17:30:09.355Z,1726507809.355 [NAL9602](INFO): Powering down 2024-09-16T17:30:10.125Z,1726507810.125 [CBIT](INFO): Clearing failed state for component NAL9602 2024-09-16T17:30:10.126Z,1726507810.126 [NAL9602] No Fault, FailCount= 1 2024-09-16T17:30:39.592Z,1726507839.592 [NAL9602](INFO): Powering up NAL9602 2024-09-16T17:30:50.488Z,1726507850.488 [NAL9602](INFO): NAL9602 initialized 2024-09-16T17:30:52.150Z,1726507852.150 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:31:13.124Z,1726507873.124 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-16T17:31:13.916Z,1726507873.916 [BPC1](ERROR): BPC1A: No match for serial number 0000 in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file). 2024-09-16T17:31:31.719Z,1726507891.719 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2024-09-16T17:31:31.720Z,1726507891.720 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-16T17:31:31.721Z,1726507891.721 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4 2024-09-16T17:31:31.721Z,1726507891.721 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-09-16T17:31:31.776Z,1726507891.776 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-16T17:31:31.776Z,1726507891.776 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-09-16T17:31:32.140Z,1726507892.140 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-16T17:31:32.140Z,1726507892.140 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2024-09-16T17:31:32.141Z,1726507892.141 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-09-16T17:31:32.141Z,1726507892.141 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4 2024-09-16T17:31:32.535Z,1726507892.535 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-09-16T17:32:42.449Z,1726507962.449 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-16T17:33:32.939Z,1726508012.939 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:34:08.861Z,1726508048.861 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-16T17:34:08.861Z,1726508048.861 [Default:CheckIn:C.Wait] Stopped 2024-09-16T17:34:08.861Z,1726508048.861 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-16T17:34:08.861Z,1726508048.861 [Default:CheckIn:D] Running Loop=1 2024-09-16T17:34:09.265Z,1726508049.265 [Default:CheckIn:D] Stopped 2024-09-16T17:34:09.265Z,1726508049.265 [Default:CheckIn:E] Running Loop=1 2024-09-16T17:34:09.683Z,1726508049.683 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 10.685732 min 2024-09-16T17:34:09.683Z,1726508049.683 [Default:CheckIn:E] Stopped 2024-09-16T17:34:09.683Z,1726508049.683 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-16T17:34:09.683Z,1726508049.683 [Default:CheckIn] Stopped 2024-09-16T17:34:09.684Z,1726508049.684 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-16T17:34:09.684Z,1726508049.684 [Default:CheckIn](INFO): Running loop #2 2024-09-16T17:34:09.684Z,1726508049.684 [Default:CheckIn] Running Loop=2 2024-09-16T17:34:09.684Z,1726508049.684 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-16T17:34:09.684Z,1726508049.684 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-16T17:34:32.337Z,1726508072.337 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:34:32.707Z,1726508072.707 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2024-09-16T17:34:32.707Z,1726508072.707 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-16T17:34:32.708Z,1726508072.708 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5 2024-09-16T17:34:32.708Z,1726508072.708 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-09-16T17:34:32.751Z,1726508072.751 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-16T17:34:32.752Z,1726508072.752 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-09-16T17:34:33.107Z,1726508073.107 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-16T17:34:33.107Z,1726508073.107 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2024-09-16T17:34:33.107Z,1726508073.107 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-09-16T17:34:33.107Z,1726508073.107 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5 2024-09-16T17:34:33.516Z,1726508073.516 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-09-16T17:36:14.583Z,1726508174.583 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:36:29.037Z,1726508189.037 [BPC1](ERROR): BPC1A: No match for serial number FFFF in BPC1A's battery stick inventory (sticks 1-31 in onboard configuration file). 2024-09-16T17:36:43.641Z,1726508203.641 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:37:33.695Z,1726508253.695 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2024-09-16T17:37:33.695Z,1726508253.695 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-16T17:37:33.696Z,1726508253.696 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6 2024-09-16T17:37:33.697Z,1726508253.697 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-09-16T17:37:33.707Z,1726508253.707 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-16T17:37:33.707Z,1726508253.707 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-09-16T17:37:34.119Z,1726508254.119 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-16T17:37:34.119Z,1726508254.119 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2024-09-16T17:37:34.119Z,1726508254.119 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-09-16T17:37:34.119Z,1726508254.119 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6 2024-09-16T17:37:34.527Z,1726508254.527 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-09-16T17:37:34.950Z,1726508254.950 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-16T17:38:11.261Z,1726508291.261 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-16T17:39:05.828Z,1726508345.828 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-16T17:39:09.868Z,1726508349.868 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-16T17:34:09.7Z 2024-09-16T17:39:09.868Z,1726508349.868 [Default:CheckIn:Read_GPS] Stopped 2024-09-16T17:39:09.868Z,1726508349.868 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-16T17:39:16.182Z,1726508356.182 [DataOverHttps](INFO): Sending 38 bytes from file Logs/20240916T171915/Courier0007.lzma 2024-09-16T17:39:17.184Z,1726508357.184 [DataOverHttps](INFO): Moved sent file to Logs/20240916T171915/Courier0007.lzma.bak 2024-09-16T17:39:17.184Z,1726508357.184 [DataOverHttps](INFO): SBD MOMSN=23190631 2024-09-16T17:39:32.786Z,1726508372.786 [DataOverHttps](INFO): Sending 184 bytes from file Logs/20240916T171915/Express0008.lzma 2024-09-16T17:39:33.788Z,1726508373.788 [DataOverHttps](INFO): Moved sent file to Logs/20240916T171915/Express0008.lzma.bak 2024-09-16T17:39:33.789Z,1726508373.789 [DataOverHttps](INFO): SBD MOMSN=23190633 2024-09-16T17:39:34.907Z,1726508374.907 [Default:CheckIn:Read_Iridium] Stopped 2024-09-16T17:39:34.907Z,1726508374.907 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-16T17:39:34.907Z,1726508374.907 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-16T17:40:29.867Z,1726508429.867 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-16T17:40:34.679Z,1726508434.679 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2024-09-16T17:40:34.679Z,1726508434.679 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-16T17:40:34.680Z,1726508434.680 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7 2024-09-16T17:40:34.681Z,1726508434.681 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-09-16T17:40:34.722Z,1726508434.722 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-16T17:40:34.722Z,1726508434.722 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-09-16T17:40:35.092Z,1726508435.092 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-16T17:40:35.092Z,1726508435.092 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2024-09-16T17:40:35.093Z,1726508435.093 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-09-16T17:40:35.093Z,1726508435.093 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7 2024-09-16T17:40:35.503Z,1726508435.503 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-09-16T17:40:51.640Z,1726508451.640 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-09-16T17:40:51.640Z,1726508451.640 [NAL9602] Data Fault, FailCount= 2 2024-09-16T17:40:51.640Z,1726508451.640 [NAL9602](ERROR): Data Fault 2024-09-16T17:40:51.665Z,1726508451.665 [CBIT](ERROR): Data Fault in component: NAL9602 2024-09-16T17:40:52.040Z,1726508452.040 [NAL9602](INFO): Powering down 2024-09-16T17:40:52.870Z,1726508452.870 [CBIT](INFO): Clearing failed state for component NAL9602 2024-09-16T17:40:52.870Z,1726508452.870 [NAL9602] No Fault, FailCount= 2 2024-09-16T17:40:57.343Z,1726508457.343 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-16T17:41:22.344Z,1726508482.344 [NAL9602](INFO): Powering up NAL9602 2024-09-16T17:41:33.257Z,1726508493.257 [NAL9602](INFO): NAL9602 initialized 2024-09-16T17:42:42.790Z,1726508562.790 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-16T17:43:35.729Z,1726508615.729 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2024-09-16T17:43:35.729Z,1726508615.729 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-16T17:43:35.730Z,1726508615.730 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8 2024-09-16T17:43:35.731Z,1726508615.731 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-09-16T17:43:35.742Z,1726508615.742 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-16T17:43:35.774Z,1726508615.774 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-09-16T17:43:36.110Z,1726508616.110 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-16T17:43:36.110Z,1726508616.110 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2024-09-16T17:43:36.114Z,1726508616.114 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-09-16T17:43:36.114Z,1726508616.114 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8 2024-09-16T17:43:36.497Z,1726508616.497 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-09-16T17:44:35.485Z,1726508675.485 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-16T17:44:35.485Z,1726508675.485 [Default:CheckIn:C.Wait] Stopped 2024-09-16T17:44:35.485Z,1726508675.485 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-16T17:44:35.485Z,1726508675.485 [Default:CheckIn:D] Running Loop=1 2024-09-16T17:44:35.912Z,1726508675.912 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:44:35.949Z,1726508675.949 [Default:CheckIn:D] Stopped 2024-09-16T17:44:35.949Z,1726508675.949 [Default:CheckIn:E] Running Loop=1 2024-09-16T17:44:36.296Z,1726508676.296 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 21.130465 min 2024-09-16T17:44:36.296Z,1726508676.296 [Default:CheckIn:E] Stopped 2024-09-16T17:44:36.296Z,1726508676.296 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-16T17:44:36.296Z,1726508676.296 [Default:CheckIn] Stopped 2024-09-16T17:44:36.297Z,1726508676.297 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-16T17:44:36.297Z,1726508676.297 [Default:CheckIn](INFO): Running loop #3 2024-09-16T17:44:36.297Z,1726508676.297 [Default:CheckIn] Running Loop=3 2024-09-16T17:44:36.297Z,1726508676.297 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-16T17:44:36.297Z,1726508676.297 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-16T17:45:18.333Z,1726508718.333 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-16T17:46:36.668Z,1726508796.668 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2024-09-16T17:46:36.668Z,1726508796.668 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-16T17:46:36.669Z,1726508796.669 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9 2024-09-16T17:46:36.669Z,1726508796.669 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-09-16T17:46:36.680Z,1726508796.680 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-16T17:46:36.680Z,1726508796.680 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-09-16T17:46:37.097Z,1726508797.097 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-16T17:46:37.097Z,1726508797.097 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2024-09-16T17:46:37.098Z,1726508797.098 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-09-16T17:46:37.098Z,1726508797.098 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9 2024-09-16T17:46:37.499Z,1726508797.499 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-09-16T17:47:00.943Z,1726508820.943 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-16T17:47:04.988Z,1726508824.988 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:47:19.169Z,1726508839.169 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:47:51.033Z,1726508871.033 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-16T17:48:18.932Z,1726508898.932 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-16T17:49:36.445Z,1726508976.445 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-16T17:44:36.3Z 2024-09-16T17:49:36.445Z,1726508976.445 [Default:CheckIn:Read_GPS] Stopped 2024-09-16T17:49:36.446Z,1726508976.446 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-16T17:49:37.676Z,1726508977.676 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2024-09-16T17:49:37.676Z,1726508977.676 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-16T17:49:37.677Z,1726508977.677 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 10 2024-09-16T17:49:37.677Z,1726508977.677 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-09-16T17:49:37.687Z,1726508977.687 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-16T17:49:37.688Z,1726508977.688 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-09-16T17:49:38.092Z,1726508978.092 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-16T17:49:38.092Z,1726508978.092 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2024-09-16T17:49:38.092Z,1726508978.092 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-09-16T17:49:38.092Z,1726508978.092 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 10 2024-09-16T17:49:38.463Z,1726508978.463 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-09-16T17:49:42.870Z,1726508982.870 [DataOverHttps](INFO): Sending 38 bytes from file Logs/20240916T171915/Courier0010.lzma 2024-09-16T17:49:43.872Z,1726508983.872 [DataOverHttps](INFO): Moved sent file to Logs/20240916T171915/Courier0010.lzma.bak 2024-09-16T17:49:43.872Z,1726508983.872 [DataOverHttps](INFO): SBD MOMSN=23190663 2024-09-16T17:49:46.185Z,1726508986.185 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:49:55.068Z,1726508995.068 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2024-09-16T17:49:59.406Z,1726508999.406 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20240916T171915/Express0011.lzma 2024-09-16T17:50:00.408Z,1726509000.408 [DataOverHttps](INFO): Moved sent file to Logs/20240916T171915/Express0011.lzma.bak 2024-09-16T17:50:00.408Z,1726509000.408 [DataOverHttps](INFO): SBD MOMSN=23190665 2024-09-16T17:50:01.550Z,1726509001.550 [Default:CheckIn:Read_Iridium] Stopped 2024-09-16T17:50:01.550Z,1726509001.550 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-16T17:50:01.550Z,1726509001.550 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-16T17:50:28.999Z,1726509028.999 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2024-09-16T17:50:29.371Z,1726509029.371 [BPC1](INFO): Calculating totals. Valid battery stick count: 49. Valid reserve battery stick count: 5. 2024-09-16T17:50:29.375Z,1726509029.375 [BPC1](ERROR): Failed to receive data from all sticks prior to timeout. Will not retry this scan cycle. 2024-09-16T17:51:34.404Z,1726509094.404 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-09-16T17:51:34.404Z,1726509094.404 [NAL9602] Data Fault, FailCount= 3 2024-09-16T17:51:34.404Z,1726509094.404 [NAL9602](ERROR): Data Fault 2024-09-16T17:51:34.422Z,1726509094.422 [CBIT](ERROR): Data Fault in component: NAL9602 2024-09-16T17:51:34.808Z,1726509094.808 [NAL9602](INFO): Powering down 2024-09-16T17:51:35.640Z,1726509095.640 [CBIT](INFO): Clearing failed state for component NAL9602 2024-09-16T17:51:35.640Z,1726509095.640 [NAL9602] No Fault, FailCount= 3 2024-09-16T17:52:05.104Z,1726509125.104 [NAL9602](INFO): Powering up NAL9602 2024-09-16T17:52:16.017Z,1726509136.017 [NAL9602](INFO): NAL9602 initialized 2024-09-16T17:52:38.659Z,1726509158.659 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2024-09-16T17:52:38.659Z,1726509158.659 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-16T17:52:38.660Z,1726509158.660 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 11 2024-09-16T17:52:38.660Z,1726509158.660 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-09-16T17:52:38.671Z,1726509158.671 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-16T17:52:38.671Z,1726509158.671 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-09-16T17:52:39.084Z,1726509159.084 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-16T17:52:39.084Z,1726509159.084 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2024-09-16T17:52:39.084Z,1726509159.084 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-09-16T17:52:39.084Z,1726509159.084 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 11 2024-09-16T17:52:39.488Z,1726509159.488 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-09-16T17:55:02.076Z,1726509302.076 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2024-09-16T17:55:02.077Z,1726509302.077 [Default:CheckIn:C.Wait] Stopped 2024-09-16T17:55:02.077Z,1726509302.077 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-16T17:55:02.077Z,1726509302.077 [Default:CheckIn:D] Running Loop=1 2024-09-16T17:55:02.487Z,1726509302.487 [Default:CheckIn:D] Stopped 2024-09-16T17:55:02.487Z,1726509302.487 [Default:CheckIn:E] Running Loop=1 2024-09-16T17:55:02.904Z,1726509302.904 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 31.572760 min 2024-09-16T17:55:02.904Z,1726509302.904 [Default:CheckIn:E] Stopped 2024-09-16T17:55:02.905Z,1726509302.905 [Default:CheckIn](INFO): Completed Default:CheckIn 2024-09-16T17:55:02.905Z,1726509302.905 [Default:CheckIn] Stopped 2024-09-16T17:55:02.905Z,1726509302.905 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-16T17:55:02.905Z,1726509302.905 [Default:CheckIn](INFO): Running loop #4 2024-09-16T17:55:02.905Z,1726509302.905 [Default:CheckIn] Running Loop=4 2024-09-16T17:55:02.905Z,1726509302.905 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2024-09-16T17:55:02.905Z,1726509302.905 [Default:CheckIn:Read_GPS] Running Loop=1 2024-09-16T17:55:39.656Z,1726509339.656 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2024-09-16T17:55:39.656Z,1726509339.656 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-16T17:55:39.657Z,1726509339.657 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 12 2024-09-16T17:55:39.657Z,1726509339.657 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-09-16T17:55:39.668Z,1726509339.668 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-16T17:55:39.668Z,1726509339.668 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-09-16T17:55:40.059Z,1726509340.059 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-16T17:55:40.059Z,1726509340.059 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2024-09-16T17:55:40.060Z,1726509340.060 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-09-16T17:55:40.060Z,1726509340.060 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 12 2024-09-16T17:55:40.447Z,1726509340.447 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-09-16T17:58:40.655Z,1726509520.655 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2024-09-16T17:58:40.655Z,1726509520.655 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-16T17:58:40.656Z,1726509520.656 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 13 2024-09-16T17:58:40.656Z,1726509520.656 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-09-16T17:58:40.719Z,1726509520.719 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-16T17:58:40.720Z,1726509520.720 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-09-16T17:58:41.068Z,1726509521.068 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-16T17:58:41.069Z,1726509521.069 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2024-09-16T17:58:41.069Z,1726509521.069 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-09-16T17:58:41.069Z,1726509521.069 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 13 2024-09-16T17:58:41.439Z,1726509521.439 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-09-16T18:00:03.054Z,1726509603.054 [Default:CheckIn:Read_GPS](INFO): Timed out from 2024-09-16T17:55:02.9Z 2024-09-16T18:00:03.054Z,1726509603.054 [Default:CheckIn:Read_GPS] Stopped 2024-09-16T18:00:03.054Z,1726509603.054 [Default:CheckIn:Read_Iridium] Running Loop=1 2024-09-16T18:00:09.026Z,1726509609.026 [DataOverHttps](INFO): Sending 169 bytes from file Logs/20240916T171915/Courier0013.lzma 2024-09-16T18:00:10.028Z,1726509610.028 [DataOverHttps](INFO): Moved sent file to Logs/20240916T171915/Courier0013.lzma.bak 2024-09-16T18:00:10.028Z,1726509610.028 [DataOverHttps](INFO): SBD MOMSN=23190717 2024-09-16T18:00:25.538Z,1726509625.538 [DataOverHttps](INFO): Sending 152 bytes from file Logs/20240916T171915/Express0014.lzma 2024-09-16T18:00:26.540Z,1726509626.540 [DataOverHttps](INFO): Moved sent file to Logs/20240916T171915/Express0014.lzma.bak 2024-09-16T18:00:26.540Z,1726509626.540 [DataOverHttps](INFO): SBD MOMSN=23190719 2024-09-16T18:00:27.712Z,1726509627.712 [Default:CheckIn:Read_Iridium] Stopped 2024-09-16T18:00:27.712Z,1726509627.712 [Default:CheckIn:C.Wait] Running Loop=1 2024-09-16T18:00:27.713Z,1726509627.713 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2024-09-16T18:01:41.638Z,1726509701.638 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2024-09-16T18:01:41.638Z,1726509701.638 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-16T18:01:41.643Z,1726509701.643 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 14 2024-09-16T18:01:41.643Z,1726509701.643 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-09-16T18:01:41.667Z,1726509701.667 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-16T18:01:41.667Z,1726509701.667 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-09-16T18:01:42.068Z,1726509702.068 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-16T18:01:42.068Z,1726509702.068 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2024-09-16T18:01:42.068Z,1726509702.068 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-09-16T18:01:42.068Z,1726509702.068 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 14 2024-09-16T18:01:42.440Z,1726509702.440 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-09-16T18:02:17.164Z,1726509737.164 [NAL9602](FAULT): GPS failed to acquire within timeout. 2024-09-16T18:02:17.164Z,1726509737.164 [NAL9602] Data Fault, FailCount= 4 2024-09-16T18:02:17.164Z,1726509737.164 [NAL9602](ERROR): Data Fault 2024-09-16T18:02:17.206Z,1726509737.206 [CBIT](ERROR): Data Fault in component: NAL9602 2024-09-16T18:02:17.576Z,1726509737.576 [NAL9602](INFO): Powering down 2024-09-16T18:02:18.429Z,1726509738.429 [CBIT](INFO): Clearing failed state for component NAL9602 2024-09-16T18:02:18.429Z,1726509738.429 [NAL9602] No Fault, FailCount= 4 2024-09-16T18:02:47.872Z,1726509767.872 [NAL9602](INFO): Powering up NAL9602 2024-09-16T18:02:58.780Z,1726509778.780 [NAL9602](INFO): NAL9602 initialized 2024-09-16T18:04:42.659Z,1726509882.659 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2024-09-16T18:04:42.659Z,1726509882.659 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2024-09-16T18:04:42.660Z,1726509882.660 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 15 2024-09-16T18:04:42.661Z,1726509882.661 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault 2024-09-16T18:04:42.708Z,1726509882.708 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2024-09-16T18:04:42.708Z,1726509882.708 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator 2024-09-16T18:04:43.096Z,1726509883.096 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2024-09-16T18:04:43.096Z,1726509883.096 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2024-09-16T18:04:43.097Z,1726509883.097 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator 2024-09-16T18:04:43.097Z,1726509883.097 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 15 2024-09-16T18:04:43.466Z,1726509883.466 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 2024-09-16T18:04:44.080Z,1726509884.080 [DataOverHttps](IMPORTANT): SBD MTMSN=20240916T180443 2024-09-16T18:04:51.314Z,1726509891.314 [DataOverHttps](INFO): Received command: restart sys 2024-09-16T18:04:51.317Z,1726509891.317 [CommandExec](IMPORTANT): got command restart system 2024-09-16T18:04:53.438Z,1726509893.438 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2024-09-16T18:04:53.439Z,1726509893.439 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-16T18:04:53.439Z,1726509893.439 [CommandExec](INFO): Uninitializing the command executive. 2024-09-16T18:04:53.439Z,1726509893.439 [CommandExec](INFO): Uninitializing the command scheduler. 2024-09-16T18:04:53.439Z,1726509893.439 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:53.514Z,1726509893.514 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2024-09-16T18:04:53.514Z,1726509893.514 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2024-09-16T18:04:53.515Z,1726509893.515 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:53.515Z,1726509893.515 [NavChartDb](INFO): Join timeout helper Thread ID is 1030 2024-09-16T18:04:53.730Z,1726509893.730 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-16T18:04:53.731Z,1726509893.731 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:53.746Z,1726509893.746 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2024-09-16T18:04:53.746Z,1726509893.746 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:53.747Z,1726509893.747 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 1031 2024-09-16T18:04:54.246Z,1726509894.246 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-16T18:04:54.247Z,1726509894.247 [WetLabsBB2FL](INFO): Powering down 2024-09-16T18:04:54.248Z,1726509894.248 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:54.250Z,1726509894.250 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2024-09-16T18:04:54.250Z,1726509894.250 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:54.251Z,1726509894.251 [CTD_Seabird](INFO): Join timeout helper Thread ID is 1032 2024-09-16T18:04:54.986Z,1726509894.986 [CTD_Seabird](INFO): Powering down 2024-09-16T18:04:54.998Z,1726509894.998 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-16T18:04:54.999Z,1726509894.999 [CTD_Seabird](INFO): Powering down 2024-09-16T18:04:55.010Z,1726509895.010 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:55.011Z,1726509895.011 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2024-09-16T18:04:55.011Z,1726509895.011 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:55.011Z,1726509895.011 [Radio_Surface](INFO): Join timeout helper Thread ID is 1033 2024-09-16T18:04:55.370Z,1726509895.370 [Radio_Surface](INFO): Powering down 2024-09-16T18:04:55.371Z,1726509895.371 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-16T18:04:55.372Z,1726509895.372 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:55.378Z,1726509895.378 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2024-09-16T18:04:55.378Z,1726509895.378 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:55.379Z,1726509895.379 [Onboard](INFO): Join timeout helper Thread ID is 1034 2024-09-16T18:04:56.007Z,1726509896.007 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-16T18:04:56.007Z,1726509896.007 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:56.021Z,1726509896.021 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2024-09-16T18:04:56.022Z,1726509896.022 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:56.022Z,1726509896.022 [DataOverHttps](INFO): Join timeout helper Thread ID is 1035 2024-09-16T18:04:56.330Z,1726509896.330 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-16T18:04:56.331Z,1726509896.331 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:56.347Z,1726509896.347 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 2024-09-16T18:04:56.347Z,1726509896.347 [DAT ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:56.347Z,1726509896.347 [DAT](INFO): Join timeout helper Thread ID is 1036 2024-09-16T18:04:56.546Z,1726509896.546 [DAT](INFO): Powering down 2024-09-16T18:04:56.619Z,1726509896.619 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-16T18:04:56.619Z,1726509896.619 [DAT](INFO): Powering down 2024-09-16T18:04:56.620Z,1726509896.620 [DAT ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:56.627Z,1726509896.627 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2024-09-16T18:04:56.627Z,1726509896.627 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:56.627Z,1726509896.627 [BackseatComponent](INFO): Join timeout helper Thread ID is 1037 2024-09-16T18:04:56.645Z,1726509896.645 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-16T18:04:56.645Z,1726509896.645 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:56.649Z,1726509896.649 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2024-09-16T18:04:56.649Z,1726509896.649 [logger ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:56.649Z,1726509896.649 [logger](INFO): Join timeout helper Thread ID is 1038 2024-09-16T18:04:56.685Z,1726509896.685 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-16T18:04:56.685Z,1726509896.685 [logger ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:56.703Z,1726509896.703 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2024-09-16T18:04:56.703Z,1726509896.703 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:56.704Z,1726509896.704 [CommandLine](INFO): Join timeout helper Thread ID is 1039 2024-09-16T18:04:56.743Z,1726509896.743 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-16T18:04:56.743Z,1726509896.743 [CommandLine ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:56.763Z,1726509896.763 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2024-09-16T18:04:56.763Z,1726509896.763 [CommandExec ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:56.763Z,1726509896.763 [CommandExec](INFO): Join timeout helper Thread ID is 1040 2024-09-16T18:04:56.765Z,1726509896.765 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2024-09-16T18:04:56.765Z,1726509896.765 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:56.765Z,1726509896.765 [controlThread](INFO): Join timeout helper Thread ID is 1041 2024-09-16T18:04:56.783Z,1726509896.783 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2024-09-16T18:04:56.783Z,1726509896.783 [controlThread](DEBUG): Uninitializing ControlThread 2024-09-16T18:04:56.783Z,1726509896.783 [AHRS_M2](INFO): Powering down 2024-09-16T18:04:56.855Z,1726509896.855 [NAL9602](INFO): Powering down 2024-09-16T18:04:56.857Z,1726509896.857 [Sonardyne_Nano](INFO): Powering down 2024-09-16T18:04:56.975Z,1726509896.975 [Waterlinked](INFO): Powering down 2024-09-16T18:04:56.976Z,1726509896.976 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2024-09-16T18:04:56.977Z,1726509896.977 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2024-09-16T18:04:56.978Z,1726509896.978 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2024-09-16T18:04:56.978Z,1726509896.978 [MissionManager](INFO): Uninitializing Mission Default 2024-09-16T18:04:56.978Z,1726509896.978 [Default] Stopped 2024-09-16T18:04:56.978Z,1726509896.978 [Default](DEBUG): Aggregate::uninitialize Default 2024-09-16T18:04:56.978Z,1726509896.978 [Default:B.GoToSurface] Stopped 2024-09-16T18:04:56.979Z,1726509896.979 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2024-09-16T18:04:56.979Z,1726509896.979 [Default:CheckIn] Stopped 2024-09-16T18:04:56.979Z,1726509896.979 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2024-09-16T18:04:56.979Z,1726509896.979 [Default:CheckIn:C.Wait] Stopped 2024-09-16T18:04:56.979Z,1726509896.979 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2024-09-16T18:04:56.982Z,1726509896.982 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2024-09-16T18:04:56.982Z,1726509896.982 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2024-09-16T18:04:56.983Z,1726509896.983 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2024-09-16T18:04:56.983Z,1726509896.983 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2024-09-16T18:04:56.983Z,1726509896.983 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2024-09-16T18:04:56.984Z,1726509896.984 [BuoyancyServo](INFO): Powering down 2024-09-16T18:04:56.998Z,1726509896.998 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2024-09-16T18:04:56.999Z,1726509896.999 [ElevatorServo](INFO): Powering down 2024-09-16T18:04:56.000Z,1726509897.000 [MassServo](DEBUG): Uninitialize Mass Servo. 2024-09-16T18:04:56.000Z,1726509897.000 [MassServo](INFO): Powering down 2024-09-16T18:04:57.000Z,1726509897.000 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2024-09-16T18:04:57.001Z,1726509897.001 [RudderServo](INFO): Powering down 2024-09-16T18:04:57.001Z,1726509897.001 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2024-09-16T18:04:57.002Z,1726509897.002 [ThrusterHE](INFO): Powering down 2024-09-16T18:04:57.003Z,1726509897.003 [SBIT](DEBUG): Uninitialize SBIT Component. 2024-09-16T18:04:57.003Z,1726509897.003 [IBIT](DEBUG): Uninitialize IBIT Component. 2024-09-16T18:04:57.003Z,1726509897.003 [CBIT](DEBUG): Uninitialize CBIT Component. 2024-09-16T18:04:57.003Z,1726509897.003 [CBIT](DEBUG): Powering off loads. 2024-09-16T18:04:57.014Z,1726509897.014 [CBIT](DEBUG): Disabling WDT. 2024-09-16T18:04:57.026Z,1726509897.026 [CBIT](DEBUG): Opening all GF detection circuits. 2024-09-16T18:04:57.027Z,1726509897.027 [controlThread ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:57.061Z,1726509897.061 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:57.064Z,1726509897.064 [Onboard ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:57.070Z,1726509897.070 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:57.078Z,1726509897.078 [DAT ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:57.122Z,1726509897.122 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:57.180Z,1726509897.180 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:57.185Z,1726509897.185 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:57.253Z,1726509897.253 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2024-09-16T18:04:57.301Z,1726509897.301 [logger ThreadHandler](INFO): Thread cancelled.