2023-02-23T17:47:45.930Z,1677174465.930 [Supervisor](DEBUG): Initializing supervisor. 2023-02-23T17:47:45.935Z,1677174465.935 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2023-02-23T17:47:45.935Z,1677174465.935 [SyncHandler](INFO): Protected caller Thread ID is 2051 2023-02-23T17:47:45.936Z,1677174465.936 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2023-02-23T17:47:45.937Z,1677174465.937 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2023-02-23T17:47:45.937Z,1677174465.937 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 2052 2023-02-23T17:47:45.954Z,1677174465.954 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2023-02-23T17:47:45.971Z,1677174465.971 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2023-02-23T17:47:45.972Z,1677174465.972 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2023-02-23T17:47:45.972Z,1677174465.972 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 2053 2023-02-23T17:47:45.977Z,1677174465.977 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2023-02-23T17:47:45.978Z,1677174465.978 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2023-02-23T17:47:45.978Z,1677174465.978 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 2054 2023-02-23T17:47:45.980Z,1677174465.980 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2023-02-23T17:47:45.981Z,1677174465.981 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2023-02-23T17:47:45.981Z,1677174465.981 [logger ThreadHandler](INFO): Protected caller Thread ID is 2055 2023-02-23T17:47:45.985Z,1677174465.985 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2023-02-23T17:47:45.985Z,1677174465.985 [Supervisor](INFO): Looking for Config files in directory: Config/ 2023-02-23T17:47:45.991Z,1677174465.991 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2023-02-23T17:47:46.150Z,1677174466.150 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2023-02-23T17:47:46.152Z,1677174466.152 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2023-02-23T17:47:46.385Z,1677174466.385 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2023-02-23T17:47:46.386Z,1677174466.386 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2023-02-23T17:47:46.633Z,1677174466.633 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2023-02-23T17:47:46.635Z,1677174466.635 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2023-02-23T17:47:46.741Z,1677174466.741 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2023-02-23T17:47:46.743Z,1677174466.743 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2023-02-23T17:47:47.410Z,1677174467.410 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2023-02-23T17:47:47.410Z,1677174467.410 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2023-02-23T17:47:47.877Z,1677174467.877 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2023-02-23T17:47:47.878Z,1677174467.878 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2023-02-23T17:47:48.349Z,1677174468.349 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2023-02-23T17:47:48.350Z,1677174468.350 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2023-02-23T17:47:48.850Z,1677174468.850 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2023-02-23T17:47:49.187Z,1677174469.187 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2023-02-23T17:47:49.536Z,1677174469.536 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2023-02-23T17:47:49.538Z,1677174469.538 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2023-02-23T17:47:49.895Z,1677174469.895 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2023-02-23T17:47:49.896Z,1677174469.896 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2023-02-23T17:47:50.115Z,1677174470.115 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2023-02-23T17:47:50.115Z,1677174470.115 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2023-02-23T17:47:50.254Z,1677174470.254 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2023-02-23T17:47:50.254Z,1677174470.254 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2023-02-23T17:47:50.337Z,1677174470.337 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2023-02-23T17:47:50.417Z,1677174470.417 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2023-02-23T17:47:50.603Z,1677174470.603 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2023-02-23T17:47:50.604Z,1677174470.604 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2023-02-23T17:47:50.822Z,1677174470.822 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2023-02-23T17:47:50.824Z,1677174470.824 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/ 2023-02-23T17:47:50.827Z,1677174470.827 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg 2023-02-23T17:47:50.909Z,1677174470.909 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg 2023-02-23T17:47:51.186Z,1677174471.186 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2023-02-23T17:47:51.186Z,1677174471.186 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg 2023-02-23T17:47:51.286Z,1677174471.286 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg 2023-02-23T17:47:51.441Z,1677174471.441 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg 2023-02-23T17:47:51.614Z,1677174471.614 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg 2023-02-23T17:47:51.698Z,1677174471.698 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg 2023-02-23T17:47:51.803Z,1677174471.803 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg 2023-02-23T17:47:51.906Z,1677174471.906 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg 2023-02-23T17:47:52.058Z,1677174472.058 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg 2023-02-23T17:47:52.159Z,1677174472.159 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg 2023-02-23T17:47:52.257Z,1677174472.257 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/ 2023-02-23T17:47:52.257Z,1677174472.257 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2023-02-23T17:47:52.273Z,1677174472.273 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2023-02-23T17:47:52.459Z,1677174472.459 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2023-02-23T17:47:52.460Z,1677174472.460 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2023-02-23T17:47:52.655Z,1677174472.655 [BuoyancyServo] Loaded 2023-02-23T17:47:52.655Z,1677174472.655 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2023-02-23T17:47:52.676Z,1677174472.676 [ElevatorServo] Loaded 2023-02-23T17:47:52.676Z,1677174472.676 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2023-02-23T17:47:52.696Z,1677174472.696 [MassServo] Loaded 2023-02-23T17:47:52.696Z,1677174472.696 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2023-02-23T17:47:52.716Z,1677174472.716 [RudderServo] Loaded 2023-02-23T17:47:52.716Z,1677174472.716 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2023-02-23T17:47:52.732Z,1677174472.732 [ThrusterHE] Loaded 2023-02-23T17:47:52.732Z,1677174472.732 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 2023-02-23T17:47:52.733Z,1677174472.733 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2023-02-23T17:47:52.734Z,1677174472.734 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2023-02-23T17:47:52.906Z,1677174472.906 [SBIT](DEBUG): Construct Startup Built In Test. 2023-02-23T17:47:52.921Z,1677174472.921 [SBIT] Loaded 2023-02-23T17:47:52.921Z,1677174472.921 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2023-02-23T17:47:52.925Z,1677174472.925 [IBIT](DEBUG): Construct Initiated Built In Test. 2023-02-23T17:47:52.945Z,1677174472.945 [IBIT] Loaded 2023-02-23T17:47:52.946Z,1677174472.946 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2023-02-23T17:47:52.951Z,1677174472.951 [CBIT](DEBUG): Construct Continuous Built In Test. 2023-02-23T17:47:53.185Z,1677174473.185 [CBIT] Loaded 2023-02-23T17:47:53.185Z,1677174473.185 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2023-02-23T17:47:53.185Z,1677174473.185 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2023-02-23T17:47:53.186Z,1677174473.186 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2023-02-23T17:47:53.425Z,1677174473.425 [CTD_Seabird] Loaded 2023-02-23T17:47:53.425Z,1677174473.425 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2023-02-23T17:47:53.426Z,1677174473.426 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 406644E0 2023-02-23T17:47:53.427Z,1677174473.427 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 2138 2023-02-23T17:47:53.458Z,1677174473.458 [ESPComponent] Loaded 2023-02-23T17:47:53.458Z,1677174473.458 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2023-02-23T17:47:53.478Z,1677174473.478 [PAR_Licor] Loaded 2023-02-23T17:47:53.478Z,1677174473.478 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2023-02-23T17:47:53.509Z,1677174473.509 [WetLabsBB2FL] Loaded 2023-02-23T17:47:53.509Z,1677174473.509 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2023-02-23T17:47:53.510Z,1677174473.510 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 406944E0 2023-02-23T17:47:53.510Z,1677174473.510 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 2139 2023-02-23T17:47:53.511Z,1677174473.511 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2023-02-23T17:47:53.513Z,1677174473.513 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2023-02-23T17:47:53.583Z,1677174473.583 [DepthRateCalculator] Loaded 2023-02-23T17:47:53.584Z,1677174473.584 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2023-02-23T17:47:53.589Z,1677174473.589 [PitchRateCalculator] Loaded 2023-02-23T17:47:53.589Z,1677174473.589 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2023-02-23T17:47:53.599Z,1677174473.599 [SpeedCalculator] Loaded 2023-02-23T17:47:53.600Z,1677174473.600 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2023-02-23T17:47:53.604Z,1677174473.604 [YawRateCalculator] Loaded 2023-02-23T17:47:53.605Z,1677174473.605 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2023-02-23T17:47:53.624Z,1677174473.624 [ElevatorOffsetCalculator] Loaded 2023-02-23T17:47:53.624Z,1677174473.624 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2023-02-23T17:47:53.624Z,1677174473.624 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2023-02-23T17:47:53.626Z,1677174473.626 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2023-02-23T17:47:53.781Z,1677174473.781 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2023-02-23T17:47:53.782Z,1677174473.782 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2023-02-23T17:47:53.824Z,1677174473.824 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2023-02-23T17:47:53.825Z,1677174473.825 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2023-02-23T17:47:53.972Z,1677174473.972 [DeadReckonUsingMultipleVelocitySources] Loaded 2023-02-23T17:47:53.972Z,1677174473.972 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2023-02-23T17:47:53.986Z,1677174473.986 [NavChart] Loaded 2023-02-23T17:47:53.986Z,1677174473.986 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2023-02-23T17:47:53.992Z,1677174473.992 [UniversalFixResidualReporter] Loaded 2023-02-23T17:47:53.992Z,1677174473.992 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2023-02-23T17:47:53.993Z,1677174473.993 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2023-02-23T17:47:53.995Z,1677174473.995 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2023-02-23T17:47:55.445Z,1677174475.445 [AHRS_M2] Loaded 2023-02-23T17:47:55.446Z,1677174475.446 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2023-02-23T17:47:55.710Z,1677174475.710 [BackseatComponent] Loaded 2023-02-23T17:47:55.710Z,1677174475.710 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2023-02-23T17:47:55.780Z,1677174475.780 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 40A154E0 2023-02-23T17:47:55.780Z,1677174475.780 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 2140 2023-02-23T17:47:55.783Z,1677174475.783 [LcmUniversalReporter] Loaded 2023-02-23T17:47:55.784Z,1677174475.784 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2023-02-23T17:47:56.521Z,1677174476.521 [BPC1] Loaded 2023-02-23T17:47:56.522Z,1677174476.522 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2023-02-23T17:47:56.820Z,1677174476.820 [DataOverHttps] Loaded 2023-02-23T17:47:56.820Z,1677174476.820 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2023-02-23T17:47:56.821Z,1677174476.821 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 40A454E0 2023-02-23T17:47:56.821Z,1677174476.821 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 2141 2023-02-23T17:47:56.842Z,1677174476.842 [Depth_Keller] Loaded 2023-02-23T17:47:56.842Z,1677174476.842 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2023-02-23T17:47:56.880Z,1677174476.880 [DVL_micro] Loaded 2023-02-23T17:47:56.881Z,1677174476.881 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread. 2023-02-23T17:47:56.941Z,1677174476.941 [NAL9602] Loaded 2023-02-23T17:47:56.941Z,1677174476.941 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2023-02-23T17:47:56.968Z,1677174476.968 [Onboard] Loaded 2023-02-23T17:47:56.968Z,1677174476.968 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2023-02-23T17:47:56.969Z,1677174476.969 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 40A754E0 2023-02-23T17:47:56.970Z,1677174476.970 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 2142 2023-02-23T17:47:56.982Z,1677174476.982 [Power24vConverter] Loaded 2023-02-23T17:47:56.982Z,1677174476.982 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2023-02-23T17:47:56.996Z,1677174476.996 [Radio_Surface] Loaded 2023-02-23T17:47:56.996Z,1677174476.996 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2023-02-23T17:47:56.997Z,1677174476.997 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 40AA54E0 2023-02-23T17:47:56.997Z,1677174476.997 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 2143 2023-02-23T17:47:56.998Z,1677174476.998 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2023-02-23T17:47:56.999Z,1677174476.999 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2023-02-23T17:47:57.081Z,1677174477.081 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2023-02-23T17:47:57.082Z,1677174477.082 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2023-02-23T17:47:57.149Z,1677174477.149 [VerticalControl](DEBUG): Construct VerticalControl. 2023-02-23T17:47:57.200Z,1677174477.200 [VerticalControl] Loaded 2023-02-23T17:47:57.200Z,1677174477.200 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2023-02-23T17:47:57.203Z,1677174477.203 [HorizontalControl](DEBUG): Construct HorizontalControl. 2023-02-23T17:47:57.240Z,1677174477.240 [HorizontalControl] Loaded 2023-02-23T17:47:57.241Z,1677174477.241 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2023-02-23T17:47:57.243Z,1677174477.243 [SpeedControl](DEBUG): Construct SpeedControl. 2023-02-23T17:47:57.245Z,1677174477.245 [SpeedControl] Loaded 2023-02-23T17:47:57.245Z,1677174477.245 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2023-02-23T17:47:57.248Z,1677174477.248 [LoopControl](DEBUG): Construct LoopControl. 2023-02-23T17:47:57.248Z,1677174477.248 [LoopControl] Loaded 2023-02-23T17:47:57.249Z,1677174477.249 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2023-02-23T17:47:57.249Z,1677174477.249 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2023-02-23T17:47:57.250Z,1677174477.250 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2023-02-23T17:47:57.265Z,1677174477.265 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2023-02-23T17:47:57.266Z,1677174477.266 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2023-02-23T17:47:57.629Z,1677174477.629 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2023-02-23T17:47:57.635Z,1677174477.635 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2023-02-23T17:47:57.638Z,1677174477.638 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2023-02-23T17:47:57.649Z,1677174477.649 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2023-02-23T17:47:57.716Z,1677174477.716 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B9F4E0 2023-02-23T17:47:57.717Z,1677174477.717 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 2144 2023-02-23T17:47:57.721Z,1677174477.721 [Supervisor](INFO): Main Thread ID is 2050 2023-02-23T17:47:57.721Z,1677174477.721 [Supervisor](DEBUG): Running supervisor. 2023-02-23T17:47:57.722Z,1677174477.722 [CommandExec ThreadHandler](INFO): Handler Thread ID is 2145 2023-02-23T17:47:57.722Z,1677174477.722 [CommandExec](INFO): Initializing the command executive. 2023-02-23T17:47:57.726Z,1677174477.726 [CommandLine ThreadHandler](INFO): Handler Thread ID is 2146 2023-02-23T17:47:57.748Z,1677174477.748 [controlThread ThreadHandler](INFO): Handler Thread ID is 2147 2023-02-23T17:47:57.748Z,1677174477.748 [controlThread](DEBUG): Initializing ControlThread 2023-02-23T17:47:57.750Z,1677174477.750 [SBIT](INFO): Initialize SBIT Component. 2023-02-23T17:47:57.750Z,1677174477.750 [SBIT](IMPORTANT): git: 2023-02-15A-1-g98c560e2e 2023-02-23T17:47:57.750Z,1677174477.750 [SBIT](INFO): git hash: 98c560e2e862bfc439cbc2881c3a6b20e1bb1b72 2023-02-23T17:47:57.751Z,1677174477.751 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2023-02-23T17:47:57.752Z,1677174477.752 [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 2023-02-23T17:47:57.753Z,1677174477.753 [SBIT](INFO): Beginning SBIT in 46.000000 seconds. 2023-02-23T17:47:57.754Z,1677174477.754 [IBIT](INFO): Initialize IBIT Component. 2023-02-23T17:47:57.754Z,1677174477.754 [CBIT](DEBUG): Initialize CBIT Component. 2023-02-23T17:47:57.764Z,1677174477.764 [logger ThreadHandler](INFO): Handler Thread ID is 2148 2023-02-23T17:47:57.783Z,1677174477.783 [CBIT](DEBUG): Initialized mux pins. 2023-02-23T17:47:57.783Z,1677174477.783 [CBIT](DEBUG): Initializing the watchdog timer. 2023-02-23T17:47:57.807Z,1677174477.807 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2023-02-23T17:47:57.808Z,1677174477.808 [CBIT](DEBUG): Initializing heartbeat. 2023-02-23T17:47:57.816Z,1677174477.816 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 2149 2023-02-23T17:47:57.816Z,1677174477.816 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2023-02-23T17:47:57.824Z,1677174477.824 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 2151 2023-02-23T17:47:57.832Z,1677174477.832 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 2153 2023-02-23T17:47:57.833Z,1677174477.833 [WetLabsBB2FL](INFO): Powering up 2023-02-23T17:47:57.844Z,1677174477.844 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 2154 2023-02-23T17:47:57.845Z,1677174477.845 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2023-02-23T17:47:57.860Z,1677174477.860 [Onboard ThreadHandler](INFO): Handler Thread ID is 2155 2023-02-23T17:47:57.888Z,1677174477.888 [CBIT](DEBUG): Deactivating GF circuits. 2023-02-23T17:47:57.888Z,1677174477.888 [CBIT](DEBUG): Deactivating emergency mode. 2023-02-23T17:47:57.892Z,1677174477.892 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 2156 2023-02-23T17:47:57.920Z,1677174477.920 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 2157 2023-02-23T17:47:57.923Z,1677174477.923 [CBIT](DEBUG): Backplane powered. 2023-02-23T17:47:57.929Z,1677174477.929 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2023-02-23T17:47:57.929Z,1677174477.929 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2023-02-23T17:47:57.929Z,1677174477.929 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2023-02-23T17:47:57.930Z,1677174477.930 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2023-02-23T17:47:57.930Z,1677174477.930 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2023-02-23T17:47:57.932Z,1677174477.932 [NavChart](DEBUG): Initialize NavChart Navigation. 2023-02-23T17:47:57.932Z,1677174477.932 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2023-02-23T17:47:57.937Z,1677174477.937 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2023-02-23T17:47:57.938Z,1677174477.938 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2023-02-23T17:47:57.939Z,1677174477.939 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2023-02-23T17:47:57.945Z,1677174477.945 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2023-02-23T17:47:57.945Z,1677174477.945 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2023-02-23T17:47:57.946Z,1677174477.946 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2023-02-23T17:47:57.946Z,1677174477.946 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2023-02-23T17:47:57.946Z,1677174477.946 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2023-02-23T17:47:57.946Z,1677174477.946 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2023-02-23T17:47:57.946Z,1677174477.946 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2023-02-23T17:47:57.946Z,1677174477.946 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2023-02-23T17:47:57.946Z,1677174477.946 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA69M.000 2023-02-23T17:47:57.947Z,1677174477.947 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA69M.000 2023-02-23T17:47:57.948Z,1677174477.948 [LoopControl](DEBUG): Initialize LoopControlComponent. 2023-02-23T17:47:57.951Z,1677174477.951 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml 2023-02-23T17:47:58.047Z,1677174478.047 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2023-02-23T17:47:58.091Z,1677174478.091 [MissionManager](DEBUG): 2023-02-23T17:47:58.092Z,1677174478.092 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 2023-02-23T17:47:58.196Z,1677174478.196 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2023-02-23T17:47:58.197Z,1677174478.197 [Default:A.Wait](DEBUG): Construct Wait. 2023-02-23T17:47:58.207Z,1677174478.207 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2023-02-23T17:47:58.255Z,1677174478.255 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2023-02-23T17:47:58.286Z,1677174478.286 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2023-02-23T17:47:58.296Z,1677174478.296 [Radio_Surface](INFO): Powering up 2023-02-23T17:47:58.301Z,1677174478.301 [Default:E.Execute](DEBUG): Construct Execute. 2023-02-23T17:47:58.329Z,1677174478.329 [MissionManager](DEBUG): 0 Wait a moment to see if the scheduler starts a new mission before starting to actually run Default. 13 Burn on Dropped weight due to communications timeout. 5 Default mission has been running for Restarting logs and Default mission. restart logs 2023-02-23T17:47:58.334Z,1677174478.334 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-02-23T17:47:58.362Z,1677174478.362 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2023-02-23T17:47:58.612Z,1677174478.612 [Depth_Keller](ERROR): Pressure reading out of range: 1895.444336 decibar 2023-02-23T17:47:58.625Z,1677174478.625 [Power24vConverter](INFO): Powering up. 2023-02-23T17:47:58.649Z,1677174478.649 [DepthRateCalculator](ERROR): Depth measurement is not active 2023-02-23T17:47:58.721Z,1677174478.721 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2023-02-23T17:47:58.732Z,1677174478.732 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2023-02-23T17:47:58.733Z,1677174478.733 [ElevatorServo](DEBUG): Initializing EZServoServo. 2023-02-23T17:47:58.744Z,1677174478.744 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2023-02-23T17:47:58.745Z,1677174478.745 [MassServo](DEBUG): Initializing EZServoServo. 2023-02-23T17:47:58.756Z,1677174478.756 [MassServo](DEBUG): Initializing MassServo. 2023-02-23T17:47:58.756Z,1677174478.756 [RudderServo](DEBUG): Initializing EZServoServo. 2023-02-23T17:47:58.768Z,1677174478.768 [RudderServo](DEBUG): Initializing RudderServo. 2023-02-23T17:47:58.769Z,1677174478.769 [ThrusterHE](DEBUG): Initializing EZServoServo. 2023-02-23T17:47:58.780Z,1677174478.780 [ThrusterHE](DEBUG): Initializing ThrusterHE. 2023-02-23T17:47:59.936Z,1677174479.936 [WetLabsBB2FL](INFO): Powering down 2023-02-23T17:48:04.289Z,1677174484.289 [ThrusterHE](ERROR): Zero Speed Commanded. 2023-02-23T17:48:11.902Z,1677174491.902 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004744 2023-02-23T17:48:27.101Z,1677174507.101 [NAL9602](INFO): Powering up NAL9602 2023-02-23T17:48:37.998Z,1677174517.998 [NAL9602](INFO): NAL9602 initialized 2023-02-23T17:48:44.470Z,1677174524.470 [SBIT](IMPORTANT): Beginning Startup BIT 2023-02-23T17:48:44.475Z,1677174524.475 [CBIT](IMPORTANT): Beginning ground fault scan 2023-02-23T17:48:55.486Z,1677174535.486 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.003224 CHAN A1 (24V): 0.000059 CHAN A2 (12V): -0.005385 CHAN A3 (5V): -0.002858 CHAN B0 (3.3V): -0.001104 CHAN B1 (3.15aV): -0.001462 CHAN B2 (3.15bV): -0.000805 CHAN B3 (GND): 0.004691 OPEN: 0.004475 Full Scale: +/- 1 mA 2023-02-23T17:48:57.486Z,1677174537.486 [SBIT](FAULT): Rudder: EXPECTED:15.000000 ACTUAL:14.527149 2023-02-23T17:49:38.302Z,1677174578.302 [SBIT](CRITICAL): SBIT FAILED 2023-02-23T17:49:38.302Z,1677174578.302 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2023-02-23T17:49:38.304Z,1677174578.304 [SBIT](IMPORTANT): CBIT.vehicleOpen=1 bool; 2023-02-23T17:49:38.304Z,1677174578.304 [SBIT](IMPORTANT): Depth_Keller.offset=-0.8 decibar; 2023-02-23T17:49:38.304Z,1677174578.304 [SBIT](IMPORTANT): DropWeight.loadAtStartup=0 bool; 2023-02-23T17:49:38.306Z,1677174578.306 [SBIT](IMPORTANT): ESPComponent.sampleTimeout=4 minute; 2023-02-23T17:49:38.306Z,1677174578.306 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool; 2023-02-23T17:49:38.306Z,1677174578.306 [SBIT](IMPORTANT): ElevatorServo.offsetAngle=1 degree; 2023-02-23T17:49:38.306Z,1677174578.306 [SBIT](IMPORTANT): Express none WetLabsBB2FL.BackscatteringCoeff470nm; 2023-02-23T17:49:38.306Z,1677174578.306 [SBIT](IMPORTANT): Express none WetLabsBB2FL.BackscatteringCoeff650nm; 2023-02-23T17:49:38.306Z,1677174578.306 [SBIT](IMPORTANT): VerticalControl.massDefault=-6.557592 millimeter; 2023-02-23T17:49:38.311Z,1677174578.311 [CommandExec](FAULT): Scheduling is paused 2023-02-23T17:49:38.312Z,1677174578.312 [CBIT](INFO): Critical error at 20230223T174938 2023-02-23T17:49:38.312Z,1677174578.312 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2023-02-23T17:49:38.663Z,1677174578.663 [MissionManager](IMPORTANT): Started mission Startup 2023-02-23T17:49:38.664Z,1677174578.664 [Startup] Running Loop=1 2023-02-23T17:49:38.664Z,1677174578.664 [Startup](DEBUG): Aggregate::initialize Startup 2023-02-23T17:49:38.664Z,1677174578.664 [Startup:A.GoToSurface] Running Loop=1 2023-02-23T17:49:38.664Z,1677174578.664 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-02-23T17:49:38.665Z,1677174578.665 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-02-23T17:49:38.665Z,1677174578.665 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-02-23T17:49:38.666Z,1677174578.666 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-02-23T17:49:38.666Z,1677174578.666 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-02-23T17:49:38.666Z,1677174578.666 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-02-23T17:49:38.668Z,1677174578.668 [Startup:StartupSatComms] Running Loop=1 2023-02-23T17:49:38.669Z,1677174578.669 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2023-02-23T17:49:38.669Z,1677174578.669 [Startup:StartupSatComms:A] Running Loop=1 2023-02-23T17:49:39.117Z,1677174579.117 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2023-02-23T17:50:04.622Z,1677174604.622 [CommandExec](IMPORTANT): got command get Onboard.Pressure 2023-02-23T17:50:04.623Z,1677174604.623 [CommandExec](IMPORTANT): Onboard.Pressure 67804.546875 Pa 2023-02-23T17:50:09.355Z,1677174609.355 [CommandExec](IMPORTANT): got command get Onboard.Pressure pound_per_square_inch 2023-02-23T17:50:09.356Z,1677174609.356 [CommandExec](IMPORTANT): Onboard.Pressure 9.867589 psi 2023-02-23T17:50:38.810Z,1677174638.810 [Startup:StartupSatComms:A](INFO): Timed out from 2023-02-23T17:49:38.7Z 2023-02-23T17:50:38.810Z,1677174638.810 [Startup:StartupSatComms:A] Stopped 2023-02-23T17:50:38.810Z,1677174638.810 [Startup:StartupSatComms:B] Running Loop=1 2023-02-23T17:50:39.216Z,1677174639.216 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2023-02-23T17:50:45.736Z,1677174645.736 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T17:50:45.736Z,1677174645.736 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+18.8,00000,000 2023-02-23T17:50:50.141Z,1677174650.141 [DataOverHttps](INFO): Sending 38 bytes from file Logs/20230222T222003/Courier0046.lzma 2023-02-23T17:50:51.142Z,1677174651.142 [DataOverHttps](INFO): Moved sent file to Logs/20230222T222003/Courier0046.lzma.bak 2023-02-23T17:50:51.142Z,1677174651.142 [DataOverHttps](INFO): SBD MOMSN=17487938 2023-02-23T17:50:53.351Z,1677174653.351 [DVL_micro](ERROR): only read 3 of 4 data items 2023-02-23T17:50:53.363Z,1677174653.363 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+99999.99,+9999.99 2023-02-23T17:50:57.981Z,1677174657.981 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2023-02-23T17:50:57.981Z,1677174657.981 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T17:50:58.090Z,1677174658.090 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T17:50:58.221Z,1677174658.221 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T17:50:58.221Z,1677174658.221 [DVL_micro](ERROR): Failed to parse: :TS,000000035.0,+18.9,0000.0,1489.0,000 2023-02-23T17:50:58.320Z,1677174658.320 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T17:50:58.320Z,1677174658.320 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2023-02-23T17:51:06.900Z,1677174666.900 [CommandExec](IMPORTANT): got command get Onboard.Pressure pound_per_square_inch 2023-02-23T17:51:06.901Z,1677174666.901 [CommandExec](IMPORTANT): Onboard.Pressure 9.834218 psi 2023-02-23T17:51:11.011Z,1677174671.011 [DataOverHttps](INFO): Sending 184 bytes from file Logs/20230223T174745/Courier0000.lzma 2023-02-23T17:51:12.013Z,1677174672.013 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Courier0000.lzma.bak 2023-02-23T17:51:12.013Z,1677174672.013 [DataOverHttps](INFO): SBD MOMSN=17487940 2023-02-23T17:51:32.737Z,1677174692.737 [CommandExec](IMPORTANT): got command get Onboard.Humidity 2023-02-23T17:51:32.738Z,1677174692.738 [CommandExec](IMPORTANT): Onboard.Humidity 9.473813 % 2023-02-23T17:51:39.049Z,1677174699.049 [Startup:StartupSatComms:B](INFO): Timed out from 2023-02-23T17:50:38.8Z 2023-02-23T17:51:39.049Z,1677174699.049 [Startup:StartupSatComms:B] Stopped 2023-02-23T17:51:39.049Z,1677174699.049 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2023-02-23T17:51:39.049Z,1677174699.049 [Startup:StartupSatComms] Stopped 2023-02-23T17:51:39.050Z,1677174699.050 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2023-02-23T17:51:39.050Z,1677174699.050 [Startup](INFO): Completed Startup 2023-02-23T17:51:39.050Z,1677174699.050 [MissionManager](INFO): Startup is completed. 2023-02-23T17:51:39.051Z,1677174699.051 [MissionManager](INFO): Uninitializing Mission Startup 2023-02-23T17:51:39.051Z,1677174699.051 [Startup] Stopped 2023-02-23T17:51:39.051Z,1677174699.051 [Startup](DEBUG): Aggregate::uninitialize Startup 2023-02-23T17:51:39.051Z,1677174699.051 [Startup:A.GoToSurface] Stopped 2023-02-23T17:51:39.051Z,1677174699.051 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-02-23T17:51:39.461Z,1677174699.461 [MissionManager](IMPORTANT): Started mission Default 2023-02-23T17:51:39.461Z,1677174699.461 [Default] Running Loop=1 2023-02-23T17:51:39.461Z,1677174699.461 [Default](DEBUG): Aggregate::initialize Default 2023-02-23T17:51:39.461Z,1677174699.461 [Default:B.GoToSurface] Running Loop=1 2023-02-23T17:51:39.461Z,1677174699.461 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-02-23T17:51:39.462Z,1677174699.462 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-02-23T17:51:39.462Z,1677174699.462 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-02-23T17:51:39.462Z,1677174699.462 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-02-23T17:51:39.462Z,1677174699.462 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-02-23T17:51:39.463Z,1677174699.463 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-02-23T17:51:39.463Z,1677174699.463 [Default:A.Wait] Running Loop=1 2023-02-23T17:51:39.463Z,1677174699.463 [Default:A.Wait](DEBUG): Initialize Wait Component. 2023-02-23T17:51:52.417Z,1677174712.417 [DataOverHttps](INFO): Sending 325 bytes from file Logs/20230222T222003/Express0044.lzma 2023-02-23T17:51:52.777Z,1677174712.777 [Default:A.Wait](INFO): Done Waiting. 2023-02-23T17:51:52.777Z,1677174712.777 [Default:A.Wait] Stopped 2023-02-23T17:51:52.777Z,1677174712.777 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2023-02-23T17:51:53.189Z,1677174713.189 [Default:CheckIn] Running Loop=1 2023-02-23T17:51:53.189Z,1677174713.189 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-23T17:51:53.189Z,1677174713.189 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-23T17:51:53.417Z,1677174713.417 [DataOverHttps](INFO): Moved sent file to Logs/20230222T222003/Express0044.lzma.bak 2023-02-23T17:51:53.418Z,1677174713.418 [DataOverHttps](INFO): SBD MOMSN=17487944 2023-02-23T17:51:53.581Z,1677174713.581 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2023-02-23T17:52:14.221Z,1677174734.221 [DVL_micro](ERROR): only read 1 of 4 data items 2023-02-23T17:52:14.221Z,1677174734.221 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,++9999.99,+9999.99 2023-02-23T17:52:34.756Z,1677174754.756 [CommandExec](IMPORTANT): got command get Onboard.Humidity 2023-02-23T17:52:34.757Z,1677174754.757 [CommandExec](IMPORTANT): Onboard.Humidity 9.449396 % 2023-02-23T17:52:37.316Z,1677174757.316 [DVL_micro](ERROR): only read 3 of 4 data items 2023-02-23T17:52:37.316Z,1677174757.316 [DVL_micro](ERROR): Failed to parse: :RD,+99999.99,+9999.99,+9999.99 2023-02-23T17:52:45.352Z,1677174765.352 [CommandExec](IMPORTANT): got command get Onboard.Pressure pound_per_square_inch 2023-02-23T17:52:45.353Z,1677174765.353 [CommandExec](IMPORTANT): Onboard.Pressure 9.817533 psi 2023-02-23T17:52:49.795Z,1677174769.795 [DVL_micro](ERROR): Failed to parse: :WI,+00132,-00061,-00923,+000I,+00132,-00061,-00923,+00000,I 2023-02-23T17:53:41.075Z,1677174821.075 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2023-02-23T17:53:58.876Z,1677174838.876 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2023-02-23T17:53:58.876Z,1677174838.876 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T17:53:58.887Z,1677174838.887 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T17:53:59.332Z,1677174839.332 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T17:53:59.332Z,1677174839.332 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2023-02-23T17:54:13.403Z,1677174853.403 [DVL_micro](ERROR): only read 2 of 4 data items 2023-02-23T17:54:13.403Z,1677174853.403 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+9999.99,,+9999.99 2023-02-23T17:55:25.718Z,1677174925.718 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2023-02-23T17:55:25.723Z,1677174925.723 [BPC1](INFO): Received data from all battery sticks. 2023-02-23T17:56:53.398Z,1677175013.398 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-23T17:51:53.2Z 2023-02-23T17:56:53.398Z,1677175013.398 [Default:CheckIn:Read_GPS] Stopped 2023-02-23T17:56:53.398Z,1677175013.398 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-23T17:56:53.809Z,1677175013.809 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2023-02-23T17:56:59.911Z,1677175019.911 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2023-02-23T17:56:59.911Z,1677175019.911 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T17:56:59.934Z,1677175019.934 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T17:57:00.124Z,1677175020.124 [DataOverHttps](INFO): Sending 168 bytes from file Logs/20230223T174745/Courier0004.lzma 2023-02-23T17:57:00.294Z,1677175020.294 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T17:57:00.295Z,1677175020.295 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2023-02-23T17:57:01.129Z,1677175021.129 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Courier0004.lzma.bak 2023-02-23T17:57:01.129Z,1677175021.129 [DataOverHttps](INFO): SBD MOMSN=17487953 2023-02-23T17:57:26.852Z,1677175046.852 [DataOverHttps](INFO): Sending 86 bytes from file Logs/20230222T222003/Express0047.lzma 2023-02-23T17:57:27.853Z,1677175047.853 [DataOverHttps](INFO): Moved sent file to Logs/20230222T222003/Express0047.lzma.bak 2023-02-23T17:57:27.854Z,1677175047.854 [DataOverHttps](INFO): SBD MOMSN=17487955 2023-02-23T17:57:33.405Z,1677175053.405 [DVL_micro](ERROR): only read 0 of 4 data items 2023-02-23T17:57:33.405Z,1677175053.405 [DVL_micro](ERROR): Failed to parse: :BI-00014,-00908,+00000,I 2023-02-23T17:57:54.314Z,1677175074.314 [DataOverHttps](INFO): Sending 965 bytes from file Logs/20230223T174745/Express0001.lzma 2023-02-23T17:57:55.293Z,1677175075.293 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Express0001.lzma.bak 2023-02-23T17:57:55.293Z,1677175075.293 [DataOverHttps](INFO): SBD MOMSN=17487958 2023-02-23T17:57:56.433Z,1677175076.433 [DVL_micro](ERROR): only read 3 of 4 data items 2023-02-23T17:57:56.433Z,1677175076.433 [DVL_micro](ERROR): Failed to parse: :BI,-00144,-00176,-0000,I 2023-02-23T17:58:21.391Z,1677175101.391 [DataOverHttps](INFO): Sending 322 bytes from file Logs/20230223T174745/Express0005.lzma 2023-02-23T17:58:22.393Z,1677175102.393 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Express0005.lzma.bak 2023-02-23T17:58:22.393Z,1677175102.393 [DataOverHttps](INFO): SBD MOMSN=17487983 2023-02-23T17:58:31.217Z,1677175111.217 [Default:CheckIn:Read_Iridium] Stopped 2023-02-23T17:58:31.217Z,1677175111.217 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-23T17:58:31.217Z,1677175111.217 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-23T17:58:32.004Z,1677175112.004 [DVL_micro](ERROR): only read 3 of 4 data items 2023-02-23T17:58:32.005Z,1677175112.005 [DVL_micro](ERROR): Failed to parse: :BI,+0122,-00930,+00000,I 2023-02-23T17:58:40.061Z,1677175120.061 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-02-23T17:58:40.061Z,1677175120.061 [NAL9602] Data Fault, FailCount= 1 2023-02-23T17:58:40.061Z,1677175120.061 [NAL9602](ERROR): Data Fault 2023-02-23T17:58:40.122Z,1677175120.122 [CBIT](ERROR): Data Fault in component: NAL9602 2023-02-23T17:58:40.473Z,1677175120.473 [NAL9602](INFO): Powering down 2023-02-23T17:58:41.305Z,1677175121.305 [CBIT](INFO): Clearing failed state for component NAL9602 2023-02-23T17:58:41.305Z,1677175121.305 [NAL9602] No Fault, FailCount= 1 2023-02-23T17:59:10.826Z,1677175150.826 [NAL9602](INFO): Powering up NAL9602 2023-02-23T17:59:21.677Z,1677175161.677 [NAL9602](INFO): NAL9602 initialized 2023-02-23T18:00:00.871Z,1677175200.871 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2023-02-23T18:00:00.871Z,1677175200.871 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:00:00.881Z,1677175200.881 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:00:01.290Z,1677175201.290 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:00:01.290Z,1677175201.290 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2023-02-23T18:03:01.884Z,1677175381.884 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2023-02-23T18:03:01.884Z,1677175381.884 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:03:01.919Z,1677175381.919 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:03:02.282Z,1677175382.282 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:03:02.282Z,1677175382.282 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2023-02-23T18:03:31.785Z,1677175411.785 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-23T18:03:31.785Z,1677175411.785 [Default:CheckIn:C.Wait] Stopped 2023-02-23T18:03:31.785Z,1677175411.785 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-23T18:03:31.785Z,1677175411.785 [Default:CheckIn:D] Running Loop=1 2023-02-23T18:03:32.189Z,1677175412.189 [Default:CheckIn:D] Stopped 2023-02-23T18:03:32.189Z,1677175412.189 [Default:CheckIn:E] Running Loop=1 2023-02-23T18:03:32.597Z,1677175412.597 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 11.878798 min 2023-02-23T18:03:32.597Z,1677175412.597 [Default:CheckIn:E] Stopped 2023-02-23T18:03:32.598Z,1677175412.598 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-23T18:03:32.598Z,1677175412.598 [Default:CheckIn] Stopped 2023-02-23T18:03:32.598Z,1677175412.598 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-23T18:03:32.598Z,1677175412.598 [Default:CheckIn](INFO): Running loop #2 2023-02-23T18:03:32.598Z,1677175412.598 [Default:CheckIn] Running Loop=2 2023-02-23T18:03:32.598Z,1677175412.598 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-23T18:03:32.598Z,1677175412.598 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-23T18:04:13.789Z,1677175453.789 [DVL_micro](ERROR): only read 3 of 4 data items 2023-02-23T18:04:13.789Z,1677175453.789 [DVL_micro](ERROR): Failed to parse: :RD,+99999.99,+9999.99,+9999.99 2023-02-23T18:05:34.984Z,1677175534.984 [DVL_micro](ERROR): only read 2 of 4 data items 2023-02-23T18:05:34.984Z,1677175534.984 [DVL_micro](ERROR): Failed to parse: :BI,-00368,-000999.99 2023-02-23T18:06:02.888Z,1677175562.888 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2023-02-23T18:06:02.888Z,1677175562.888 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:06:02.899Z,1677175562.899 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:06:03.298Z,1677175563.298 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:06:03.298Z,1677175563.298 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2023-02-23T18:08:32.769Z,1677175712.769 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-23T18:03:32.6Z 2023-02-23T18:08:32.769Z,1677175712.769 [Default:CheckIn:Read_GPS] Stopped 2023-02-23T18:08:32.769Z,1677175712.769 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-23T18:08:44.055Z,1677175724.055 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230223T174745/Courier0007.lzma 2023-02-23T18:08:45.057Z,1677175725.057 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Courier0007.lzma.bak 2023-02-23T18:08:45.057Z,1677175725.057 [DataOverHttps](INFO): SBD MOMSN=17487995 2023-02-23T18:08:49.720Z,1677175729.720 [DVL_micro](ERROR): Failed to parse: :WI,-00037,+00317,-00764,+00000,A 2023-02-23T18:09:03.861Z,1677175743.861 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2023-02-23T18:09:03.861Z,1677175743.861 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:09:03.905Z,1677175743.905 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:09:04.268Z,1677175744.268 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:09:04.268Z,1677175744.268 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2023-02-23T18:09:11.127Z,1677175751.127 [DataOverHttps](INFO): Sending 183 bytes from file Logs/20230223T174745/Express0008.lzma 2023-02-23T18:09:12.129Z,1677175752.129 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Express0008.lzma.bak 2023-02-23T18:09:12.129Z,1677175752.129 [DataOverHttps](INFO): SBD MOMSN=17487997 2023-02-23T18:09:22.851Z,1677175762.851 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-02-23T18:09:22.851Z,1677175762.851 [NAL9602] Data Fault, FailCount= 2 2023-02-23T18:09:22.851Z,1677175762.851 [NAL9602](ERROR): Data Fault 2023-02-23T18:09:22.920Z,1677175762.920 [CBIT](ERROR): Data Fault in component: NAL9602 2023-02-23T18:09:23.237Z,1677175763.237 [NAL9602](INFO): Powering down 2023-02-23T18:09:24.082Z,1677175764.082 [CBIT](INFO): Clearing failed state for component NAL9602 2023-02-23T18:09:24.082Z,1677175764.082 [NAL9602] No Fault, FailCount= 2 2023-02-23T18:09:26.084Z,1677175766.084 [Default:CheckIn:Read_Iridium] Stopped 2023-02-23T18:09:26.085Z,1677175766.085 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-23T18:09:26.085Z,1677175766.085 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-23T18:09:45.471Z,1677175785.471 [DVL_micro](ERROR): only read 3 of 4 data items 2023-02-23T18:09:45.471Z,1677175785.471 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+9999.99,+9999.999 2023-02-23T18:09:53.546Z,1677175793.546 [NAL9602](INFO): Powering up NAL9602 2023-02-23T18:10:04.445Z,1677175804.445 [NAL9602](INFO): NAL9602 initialized 2023-02-23T18:11:09.103Z,1677175869.103 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T18:11:09.103Z,1677175869.103 [DVL_micro](ERROR): Failed to parse: :TS,000000000000+19.5,0000.0,1489.0,000 2023-02-23T18:12:04.853Z,1677175924.853 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2023-02-23T18:12:04.853Z,1677175924.853 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:12:04.864Z,1677175924.864 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:12:05.260Z,1677175925.260 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:12:05.260Z,1677175925.260 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2023-02-23T18:14:26.784Z,1677176066.784 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-23T18:14:26.784Z,1677176066.784 [Default:CheckIn:C.Wait] Stopped 2023-02-23T18:14:26.784Z,1677176066.784 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-23T18:14:26.785Z,1677176066.785 [Default:CheckIn:D] Running Loop=1 2023-02-23T18:14:27.165Z,1677176067.165 [Default:CheckIn:D] Stopped 2023-02-23T18:14:27.165Z,1677176067.165 [Default:CheckIn:E] Running Loop=1 2023-02-23T18:14:27.565Z,1677176067.565 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 22.795068 min 2023-02-23T18:14:27.566Z,1677176067.566 [Default:CheckIn:E] Stopped 2023-02-23T18:14:27.566Z,1677176067.566 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-23T18:14:27.566Z,1677176067.566 [Default:CheckIn] Stopped 2023-02-23T18:14:27.566Z,1677176067.566 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-23T18:14:27.566Z,1677176067.566 [Default:CheckIn](INFO): Running loop #3 2023-02-23T18:14:27.566Z,1677176067.566 [Default:CheckIn] Running Loop=3 2023-02-23T18:14:27.566Z,1677176067.566 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-23T18:14:27.566Z,1677176067.566 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-23T18:14:34.420Z,1677176074.420 [DVL_micro](ERROR): only read 3 of 4 data items 2023-02-23T18:14:34.420Z,1677176074.420 [DVL_micro](ERROR): Failed to parse: :BI,+00177,+00134,-00753,+00BD,+00000000.00,+00000000.0000.00,9999.99,000.00 2023-02-23T18:15:05.955Z,1677176105.955 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2023-02-23T18:15:05.955Z,1677176105.955 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:15:05.965Z,1677176105.965 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:15:06.353Z,1677176106.353 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:15:06.353Z,1677176106.353 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2023-02-23T18:18:06.952Z,1677176286.952 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2023-02-23T18:18:06.952Z,1677176286.952 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:18:06.984Z,1677176286.984 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:18:07.369Z,1677176287.369 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:18:07.369Z,1677176287.369 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2023-02-23T18:19:27.714Z,1677176367.714 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-23T18:14:27.6Z 2023-02-23T18:19:27.714Z,1677176367.714 [Default:CheckIn:Read_GPS] Stopped 2023-02-23T18:19:27.714Z,1677176367.714 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-23T18:19:39.115Z,1677176379.115 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230223T174745/Courier0010.lzma 2023-02-23T18:19:40.117Z,1677176380.117 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Courier0010.lzma.bak 2023-02-23T18:19:40.117Z,1677176380.117 [DataOverHttps](INFO): SBD MOMSN=17488001 2023-02-23T18:19:45.892Z,1677176385.892 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T18:19:45.892Z,1677176385.892 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,38,0000.0,1489.0,000 2023-02-23T18:20:05.145Z,1677176405.145 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20230223T174745/Express0011.lzma 2023-02-23T18:20:06.145Z,1677176406.145 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Express0011.lzma.bak 2023-02-23T18:20:06.145Z,1677176406.145 [DataOverHttps](INFO): SBD MOMSN=17488003 2023-02-23T18:20:06.497Z,1677176406.497 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-02-23T18:20:06.497Z,1677176406.497 [NAL9602] Data Fault, FailCount= 3 2023-02-23T18:20:06.497Z,1677176406.497 [NAL9602](ERROR): Data Fault 2023-02-23T18:20:06.541Z,1677176406.541 [CBIT](ERROR): Data Fault in component: NAL9602 2023-02-23T18:20:06.898Z,1677176406.898 [NAL9602](INFO): Powering down 2023-02-23T18:20:07.738Z,1677176407.738 [CBIT](INFO): Clearing failed state for component NAL9602 2023-02-23T18:20:07.739Z,1677176407.739 [NAL9602] No Fault, FailCount= 3 2023-02-23T18:20:15.389Z,1677176415.389 [Default:CheckIn:Read_Iridium] Stopped 2023-02-23T18:20:15.389Z,1677176415.389 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-23T18:20:15.389Z,1677176415.389 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-23T18:20:23.868Z,1677176423.868 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T18:20:23.868Z,1677176423.868 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+19.8,489.0,000 2023-02-23T18:20:37.197Z,1677176437.197 [NAL9602](INFO): Powering up NAL9602 2023-02-23T18:20:48.106Z,1677176448.106 [NAL9602](INFO): NAL9602 initialized 2023-02-23T18:21:01.860Z,1677176461.860 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T18:21:01.860Z,1677176461.860 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+19.8,0000.0,1489:WI,+00204,-00068,-00746,+00000,A 2023-02-23T18:21:07.911Z,1677176467.911 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2023-02-23T18:21:07.911Z,1677176467.911 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:21:07.955Z,1677176467.955 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:21:08.360Z,1677176468.360 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:21:08.360Z,1677176468.360 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2023-02-23T18:21:34.600Z,1677176494.600 [DVL_micro](ERROR): only read 0 of 4 data items 2023-02-23T18:21:34.600Z,1677176494.600 [DVL_micro](ERROR): Failed to parse: :RD,++9999.99,+9999.99,+9999.99 2023-02-23T18:23:03.477Z,1677176583.477 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T18:23:03.477Z,1677176583.477 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+19.9,0000.0,1489.0I,+00064,-00069,-00624,+00000,A 2023-02-23T18:24:08.924Z,1677176648.924 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 12 2023-02-23T18:24:08.924Z,1677176648.924 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:24:08.934Z,1677176648.934 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:24:09.371Z,1677176649.371 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:24:09.371Z,1677176649.371 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 12 2023-02-23T18:25:02.645Z,1677176702.645 [DVL_micro](ERROR): Failed to parse: :6,-00025,00000,I 2023-02-23T18:25:15.993Z,1677176715.993 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-23T18:25:15.993Z,1677176715.993 [Default:CheckIn:C.Wait] Stopped 2023-02-23T18:25:15.993Z,1677176715.993 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-23T18:25:15.993Z,1677176715.993 [Default:CheckIn:D] Running Loop=1 2023-02-23T18:25:16.382Z,1677176716.382 [Default:CheckIn:D] Stopped 2023-02-23T18:25:16.382Z,1677176716.382 [Default:CheckIn:E] Running Loop=1 2023-02-23T18:25:16.796Z,1677176716.796 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 33.615348 min 2023-02-23T18:25:16.796Z,1677176716.796 [Default:CheckIn:E] Stopped 2023-02-23T18:25:16.796Z,1677176716.796 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-23T18:25:16.796Z,1677176716.796 [Default:CheckIn] Stopped 2023-02-23T18:25:16.796Z,1677176716.796 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-23T18:25:16.796Z,1677176716.796 [Default:CheckIn](INFO): Running loop #4 2023-02-23T18:25:16.796Z,1677176716.796 [Default:CheckIn] Running Loop=4 2023-02-23T18:25:16.796Z,1677176716.796 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-23T18:25:16.796Z,1677176716.796 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-23T18:27:09.907Z,1677176829.907 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 13 2023-02-23T18:27:09.907Z,1677176829.907 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:27:09.920Z,1677176829.920 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:27:10.328Z,1677176830.328 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:27:10.328Z,1677176830.328 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 13 2023-02-23T18:30:10.892Z,1677177010.892 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 14 2023-02-23T18:30:10.892Z,1677177010.892 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:30:10.902Z,1677177010.902 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:30:11.377Z,1677177011.377 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:30:11.377Z,1677177011.377 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 14 2023-02-23T18:30:16.973Z,1677177016.973 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-23T18:25:16.8Z 2023-02-23T18:30:16.974Z,1677177016.974 [Default:CheckIn:Read_GPS] Stopped 2023-02-23T18:30:16.974Z,1677177016.974 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-23T18:30:22.887Z,1677177022.887 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230223T174745/Courier0013.lzma 2023-02-23T18:30:23.893Z,1677177023.893 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Courier0013.lzma.bak 2023-02-23T18:30:23.893Z,1677177023.893 [DataOverHttps](INFO): SBD MOMSN=17488007 2023-02-23T18:30:31.495Z,1677177031.495 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T18:30:31.495Z,1677177031.495 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+20.1,0000.0,14 2023-02-23T18:30:50.073Z,1677177050.073 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-02-23T18:30:50.073Z,1677177050.073 [NAL9602] Data Fault, FailCount= 4 2023-02-23T18:30:50.074Z,1677177050.074 [NAL9602](ERROR): Data Fault 2023-02-23T18:30:50.106Z,1677177050.106 [CBIT](ERROR): Data Fault in component: NAL9602 2023-02-23T18:30:50.477Z,1677177050.477 [NAL9602](INFO): Powering down 2023-02-23T18:30:51.301Z,1677177051.301 [CBIT](INFO): Clearing failed state for component NAL9602 2023-02-23T18:30:51.301Z,1677177051.301 [NAL9602] No Fault, FailCount= 4 2023-02-23T18:31:05.143Z,1677177065.143 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230223T174745/Express0014.lzma 2023-02-23T18:31:06.145Z,1677177066.145 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Express0014.lzma.bak 2023-02-23T18:31:06.145Z,1677177066.145 [DataOverHttps](INFO): SBD MOMSN=17488009 2023-02-23T18:31:15.127Z,1677177075.127 [Default:CheckIn:Read_Iridium] Stopped 2023-02-23T18:31:15.127Z,1677177075.127 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-23T18:31:15.127Z,1677177075.127 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-23T18:31:20.778Z,1677177080.778 [NAL9602](INFO): Powering up NAL9602 2023-02-23T18:31:31.685Z,1677177091.685 [NAL9602](INFO): NAL9602 initialized 2023-02-23T18:32:02.818Z,1677177122.818 [DVL_micro](ERROR): Failed to parse:99.99,+9999.99,+9999.99,+9999.99 2023-02-23T18:32:43.206Z,1677177163.206 [DVL_micro](ERROR): only read 3 of 4 data items 2023-02-23T18:32:43.206Z,1677177163.206 [DVL_micro](ERROR): Failed to parse: :BI,+00237,-00196,-0000,I 2023-02-23T18:32:58.557Z,1677177178.557 [DVL_micro](ERROR): Failed to parse: 76,-00169,-00679,+00000,I 2023-02-23T18:33:11.956Z,1677177191.956 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 15 2023-02-23T18:33:11.956Z,1677177191.956 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:33:11.979Z,1677177191.979 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:33:12.330Z,1677177192.330 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:33:12.330Z,1677177192.330 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 15 2023-02-23T18:33:36.561Z,1677177216.561 [DVL_micro](ERROR): only read 3 of 4 data items 2023-02-23T18:33:36.561Z,1677177216.561 [DVL_micro](ERROR): Failed to parse: :RD,+99999.99,+9999.99,+9999.99 2023-02-23T18:35:35.337Z,1677177335.337 [DVL_micro](ERROR): Failed to parse: :WI,-00148,-00100,-00620,+00000,00148,-00100,-00620,+00000,I 2023-02-23T18:36:12.916Z,1677177372.916 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 16 2023-02-23T18:36:12.916Z,1677177372.916 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:36:12.935Z,1677177372.935 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:36:13.345Z,1677177373.345 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:36:13.345Z,1677177373.345 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 16 2023-02-23T18:36:15.759Z,1677177375.759 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-23T18:36:15.759Z,1677177375.759 [Default:CheckIn:C.Wait] Stopped 2023-02-23T18:36:15.759Z,1677177375.759 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-23T18:36:15.759Z,1677177375.759 [Default:CheckIn:D] Running Loop=1 2023-02-23T18:36:16.154Z,1677177376.154 [Default:CheckIn:D] Stopped 2023-02-23T18:36:16.154Z,1677177376.154 [Default:CheckIn:E] Running Loop=1 2023-02-23T18:36:16.565Z,1677177376.565 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 44.611544 min 2023-02-23T18:36:16.565Z,1677177376.565 [Default:CheckIn:E] Stopped 2023-02-23T18:36:16.565Z,1677177376.565 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-23T18:36:16.566Z,1677177376.566 [Default:CheckIn] Stopped 2023-02-23T18:36:16.566Z,1677177376.566 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-23T18:36:16.566Z,1677177376.566 [Default:CheckIn](INFO): Running loop #5 2023-02-23T18:36:16.566Z,1677177376.566 [Default:CheckIn] Running Loop=5 2023-02-23T18:36:16.566Z,1677177376.566 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-23T18:36:16.566Z,1677177376.566 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-23T18:37:42.022Z,1677177462.022 [CommandExec](IMPORTANT): got command strobe off 2023-02-23T18:37:42.022Z,1677177462.022 [CommandExec](IMPORTANT): Deactivating strobe 2023-02-23T18:39:00.575Z,1677177540.575 [DVL_micro](ERROR): Failed to parse: :T00000000,35.0,+20.3,0000.0,1489.0,000 2023-02-23T18:39:13.896Z,1677177553.896 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 17 2023-02-23T18:39:13.896Z,1677177553.896 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:39:13.906Z,1677177553.906 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:39:14.359Z,1677177554.359 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:39:14.360Z,1677177554.360 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 17 2023-02-23T18:41:16.745Z,1677177676.745 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-23T18:36:16.6Z 2023-02-23T18:41:16.745Z,1677177676.745 [Default:CheckIn:Read_GPS] Stopped 2023-02-23T18:41:16.745Z,1677177676.745 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-23T18:41:22.828Z,1677177682.828 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230223T174745/Courier0016.lzma 2023-02-23T18:41:23.833Z,1677177683.833 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Courier0016.lzma.bak 2023-02-23T18:41:23.833Z,1677177683.833 [DataOverHttps](INFO): SBD MOMSN=17488014 2023-02-23T18:41:30.082Z,1677177690.082 [DVL_micro](ERROR): only read 3 of 4 data items 2023-02-23T18:41:30.082Z,1677177690.082 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+99999.99,+9999.99 2023-02-23T18:41:33.709Z,1677177693.709 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-02-23T18:41:33.709Z,1677177693.709 [NAL9602] Data Fault, FailCount= 5 2023-02-23T18:41:33.710Z,1677177693.710 [NAL9602](ERROR): Data Fault 2023-02-23T18:41:33.778Z,1677177693.778 [CBIT](ERROR): Data Fault in component: NAL9602 2023-02-23T18:41:33.778Z,1677177693.778 [CBIT](CRITICAL): Data Fault in component: NAL9602 2023-02-23T18:41:34.109Z,1677177694.109 [NAL9602](INFO): Powering down 2023-02-23T18:41:34.157Z,1677177694.157 [CBIT](INFO): Critical error at 20230223T184133 2023-02-23T18:41:51.119Z,1677177711.119 [DataOverHttps](INFO): Sending 191 bytes from file Logs/20230223T174745/Express0017.lzma 2023-02-23T18:41:52.121Z,1677177712.121 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Express0017.lzma.bak 2023-02-23T18:41:52.121Z,1677177712.121 [DataOverHttps](INFO): SBD MOMSN=17488016 2023-02-23T18:42:03.692Z,1677177723.692 [Default:CheckIn:Read_Iridium] Stopped 2023-02-23T18:42:03.692Z,1677177723.692 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-23T18:42:03.692Z,1677177723.692 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-23T18:42:15.132Z,1677177735.132 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 18 2023-02-23T18:42:15.133Z,1677177735.133 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:42:15.175Z,1677177735.175 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:42:15.513Z,1677177735.513 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:42:15.514Z,1677177735.514 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 18 2023-02-23T18:42:25.939Z,1677177745.939 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T18:42:25.939Z,1677177745.939 [DVL_micro](ERROR): Failed to parse: :TS,000000035.0,+20.4,0000.0,1489.0,000 2023-02-23T18:43:11.592Z,1677177791.592 [DVL_micro](ERROR): Failed to parse: 0000000000,35.0,+20.4,0000.0,1489.0,000 2023-02-23T18:43:33.822Z,1677177813.822 [CBIT](INFO): Clearing failed state for component NAL9602 2023-02-23T18:43:33.822Z,1677177813.822 [NAL9602] No Fault, FailCount= 5 2023-02-23T18:43:34.217Z,1677177814.217 [NAL9602](INFO): Powering up NAL9602 2023-02-23T18:43:45.117Z,1677177825.117 [NAL9602](INFO): NAL9602 initialized 2023-02-23T18:45:16.429Z,1677177916.429 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 19 2023-02-23T18:45:16.429Z,1677177916.429 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:45:16.440Z,1677177916.440 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:45:16.852Z,1677177916.852 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:45:16.852Z,1677177916.852 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 19 2023-02-23T18:45:56.012Z,1677177956.012 [DVL_micro](ERROR): Failed to parse: :T00000000,35,0000.0,1489.0,000 2023-02-23T18:47:04.333Z,1677178024.333 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-23T18:47:04.333Z,1677178024.333 [Default:CheckIn:C.Wait] Stopped 2023-02-23T18:47:04.333Z,1677178024.333 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-23T18:47:04.333Z,1677178024.333 [Default:CheckIn:D] Running Loop=1 2023-02-23T18:47:04.726Z,1677178024.726 [Default:CheckIn:D] Stopped 2023-02-23T18:47:04.726Z,1677178024.726 [Default:CheckIn:E] Running Loop=1 2023-02-23T18:47:05.136Z,1677178025.136 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 55.421082 min 2023-02-23T18:47:05.136Z,1677178025.136 [Default:CheckIn:E] Stopped 2023-02-23T18:47:05.137Z,1677178025.137 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-23T18:47:05.137Z,1677178025.137 [Default:CheckIn] Stopped 2023-02-23T18:47:05.137Z,1677178025.137 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-23T18:47:05.137Z,1677178025.137 [Default:CheckIn](INFO): Running loop #6 2023-02-23T18:47:05.137Z,1677178025.137 [Default:CheckIn] Running Loop=6 2023-02-23T18:47:05.137Z,1677178025.137 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-23T18:47:05.137Z,1677178025.137 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-23T18:48:17.420Z,1677178097.420 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 20 2023-02-23T18:48:17.420Z,1677178097.420 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:48:17.430Z,1677178097.430 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:48:17.842Z,1677178097.842 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:48:17.842Z,1677178097.842 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 20 2023-02-23T18:49:21.263Z,1677178161.263 [DVL_micro](ERROR): only read 3 of 4 data items 2023-02-23T18:49:21.263Z,1677178161.263 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+9999.99,+9999.999 2023-02-23T18:50:54.689Z,1677178254.689 [CommandExec](IMPORTANT): got command get Onboard.Pressure 2023-02-23T18:50:54.689Z,1677178254.689 [CommandExec](IMPORTANT): Onboard.Pressure 67949.054688 Pa 2023-02-23T18:50:58.436Z,1677178258.436 [CommandExec](IMPORTANT): got command get Onboard.Pressure pound_per_square_inch 2023-02-23T18:50:58.437Z,1677178258.437 [CommandExec](IMPORTANT): Onboard.Pressure 9.838833 psi 2023-02-23T18:51:03.996Z,1677178263.996 [CommandExec](IMPORTANT): got command get Onboard.Humidity 2023-02-23T18:51:03.997Z,1677178263.997 [CommandExec](IMPORTANT): Onboard.Humidity 9.168600 % 2023-02-23T18:51:18.444Z,1677178278.444 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 21 2023-02-23T18:51:18.444Z,1677178278.444 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:51:18.454Z,1677178278.454 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:51:18.867Z,1677178278.867 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:51:18.867Z,1677178278.867 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 21 2023-02-23T18:52:05.313Z,1677178325.313 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-23T18:47:05.1Z 2023-02-23T18:52:05.313Z,1677178325.313 [Default:CheckIn:Read_GPS] Stopped 2023-02-23T18:52:05.313Z,1677178325.313 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-23T18:52:21.683Z,1677178341.683 [DataOverHttps](INFO): Sending 105 bytes from file Logs/20230223T174745/Courier0019.lzma 2023-02-23T18:52:22.686Z,1677178342.686 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Courier0019.lzma.bak 2023-02-23T18:52:22.686Z,1677178342.686 [DataOverHttps](INFO): SBD MOMSN=17488022 2023-02-23T18:52:43.743Z,1677178363.743 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T18:52:43.744Z,1677178363.744 [DVL_micro](ERROR): Failed to parse: :TS0000000,35.0,+20.6,0000.0,1489.0,000 2023-02-23T18:53:14.862Z,1677178394.862 [DataOverHttps](INFO): Sending 276 bytes from file Logs/20230223T174745/Express0020.lzma 2023-02-23T18:53:15.806Z,1677178395.806 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Express0020.lzma.bak 2023-02-23T18:53:15.806Z,1677178395.806 [DataOverHttps](INFO): SBD MOMSN=17488025 2023-02-23T18:53:24.210Z,1677178404.210 [DVL_micro](ERROR): Failed to parse: 12,+00130,-00606,+00000,I 2023-02-23T18:53:34.349Z,1677178414.349 [DVL_micro](ERROR): only read 1 of 4 data items 2023-02-23T18:53:34.349Z,1677178414.349 [DVL_micro](ERROR): Failed to parse: :BI,+00213-00582,+00000,I 2023-02-23T18:53:38.737Z,1677178418.737 [Default:CheckIn:Read_Iridium] Stopped 2023-02-23T18:53:38.737Z,1677178418.737 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-23T18:53:38.738Z,1677178418.738 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-23T18:53:47.191Z,1677178427.191 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-02-23T18:53:47.191Z,1677178427.191 [NAL9602] Data Fault, FailCount= 1 2023-02-23T18:53:47.191Z,1677178427.191 [NAL9602](ERROR): Data Fault 2023-02-23T18:53:47.260Z,1677178427.260 [CBIT](ERROR): Data Fault in component: NAL9602 2023-02-23T18:53:47.581Z,1677178427.581 [NAL9602](INFO): Powering down 2023-02-23T18:53:48.472Z,1677178428.472 [CBIT](INFO): Clearing failed state for component NAL9602 2023-02-23T18:53:48.472Z,1677178428.472 [NAL9602] No Fault, FailCount= 1 2023-02-23T18:53:52.043Z,1677178432.043 [DVL_micro](ERROR): Failed to parse:99.99,+9999.99,+9999.99,+9999.99 2023-02-23T18:53:54.443Z,1677178434.443 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T18:53:54.443Z,1677178434.443 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0000.0,1489.0,000 2023-02-23T18:53:57.273Z,1677178437.273 [DVL_micro](ERROR): No DVL communication! Re-initializing 2023-02-23T18:53:57.273Z,1677178437.273 [DVL_micro] Communications Fault, FailCount= 1 2023-02-23T18:53:57.273Z,1677178437.273 [DVL_micro](ERROR): Communications Fault 2023-02-23T18:53:57.337Z,1677178437.337 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-23T18:53:57.743Z,1677178437.743 [DVL_micro](INFO): Powering down 2023-02-23T18:53:58.498Z,1677178438.498 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-23T18:53:58.498Z,1677178438.498 [DVL_micro] No Fault, FailCount= 1 2023-02-23T18:54:17.867Z,1677178457.867 [NAL9602](INFO): Powering up NAL9602 2023-02-23T18:54:19.558Z,1677178459.558 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 22 2023-02-23T18:54:19.558Z,1677178459.558 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:54:19.586Z,1677178459.586 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:54:19.950Z,1677178459.950 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:54:19.950Z,1677178459.950 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 22 2023-02-23T18:54:28.781Z,1677178468.781 [NAL9602](INFO): NAL9602 initialized 2023-02-23T18:57:20.495Z,1677178640.495 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 23 2023-02-23T18:57:20.495Z,1677178640.495 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T18:57:20.505Z,1677178640.505 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T18:57:20.912Z,1677178640.912 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T18:57:20.912Z,1677178640.912 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 23 2023-02-23T18:58:39.284Z,1677178719.284 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-23T18:58:39.285Z,1677178719.285 [Default:CheckIn:C.Wait] Stopped 2023-02-23T18:58:39.285Z,1677178719.285 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-23T18:58:39.285Z,1677178719.285 [Default:CheckIn:D] Running Loop=1 2023-02-23T18:58:39.682Z,1677178719.682 [Default:CheckIn:D] Stopped 2023-02-23T18:58:39.682Z,1677178719.682 [Default:CheckIn:E] Running Loop=1 2023-02-23T18:58:40.081Z,1677178720.081 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 67.003678 min 2023-02-23T18:58:40.081Z,1677178720.081 [Default:CheckIn:E] Stopped 2023-02-23T18:58:40.081Z,1677178720.081 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-23T18:58:40.081Z,1677178720.081 [Default:CheckIn] Stopped 2023-02-23T18:58:40.081Z,1677178720.081 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-23T18:58:40.081Z,1677178720.081 [Default:CheckIn](INFO): Running loop #7 2023-02-23T18:58:40.081Z,1677178720.081 [Default:CheckIn] Running Loop=7 2023-02-23T18:58:40.081Z,1677178720.081 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-23T18:58:40.081Z,1677178720.081 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-23T19:00:21.501Z,1677178821.501 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 24 2023-02-23T19:00:21.501Z,1677178821.501 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:00:21.512Z,1677178821.512 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:00:21.982Z,1677178821.982 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:00:21.982Z,1677178821.982 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 24 2023-02-23T19:01:14.869Z,1677178874.869 [BPC1](ERROR): BPC1B: No match for serial number 1717 in BPC1B's battery stick inventory (sticks 32-62 in onboard configuration file). 2023-02-23T19:02:53.020Z,1677178973.020 [DVL_micro](ERROR): only read 3 of 4 data items 2023-02-23T19:02:53.020Z,1677178973.020 [DVL_micro](ERROR): Failed to parse: :BI,+00261,+00182,-0000,I 2023-02-23T19:02:58.368Z,1677178978.368 [DVL_micro](ERROR): DVL uart error: serial timeout 2023-02-23T19:02:58.368Z,1677178978.368 [DVL_micro] Communications Fault, FailCount= 1 2023-02-23T19:02:58.368Z,1677178978.368 [DVL_micro](ERROR): Communications Fault 2023-02-23T19:02:58.368Z,1677178978.368 [DVL_micro](ERROR): Failed to parse: 2023-02-23T19:02:58.515Z,1677178978.515 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-23T19:02:58.712Z,1677178978.712 [DVL_micro](INFO): Powering down 2023-02-23T19:02:59.616Z,1677178979.616 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-23T19:02:59.616Z,1677178979.616 [DVL_micro] No Fault, FailCount= 1 2023-02-23T19:03:01.516Z,1677178981.516 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2023-02-23T19:03:01.518Z,1677178981.518 [BPC1](INFO): Received data from all battery sticks. 2023-02-23T19:03:22.493Z,1677179002.493 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 25 2023-02-23T19:03:22.493Z,1677179002.493 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:03:22.503Z,1677179002.503 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:03:22.921Z,1677179002.921 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:03:22.921Z,1677179002.921 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 25 2023-02-23T19:03:40.360Z,1677179020.360 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-23T18:58:40.1Z 2023-02-23T19:03:40.360Z,1677179020.360 [Default:CheckIn:Read_GPS] Stopped 2023-02-23T19:03:40.360Z,1677179020.360 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-23T19:03:51.058Z,1677179031.058 [DataOverHttps](INFO): Sending 49 bytes from file Logs/20230223T174745/Courier0022.lzma 2023-02-23T19:03:52.066Z,1677179032.066 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Courier0022.lzma.bak 2023-02-23T19:03:52.066Z,1677179032.066 [DataOverHttps](INFO): SBD MOMSN=17488035 2023-02-23T19:04:08.018Z,1677179048.018 [DVL_micro](ERROR): Failed to parse:00000000000,35.0,+20.9,0000.0,1489.0,000 2023-02-23T19:04:15.319Z,1677179055.319 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230223T174745/Express0023.lzma 2023-02-23T19:04:16.314Z,1677179056.314 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Express0023.lzma.bak 2023-02-23T19:04:16.314Z,1677179056.314 [DataOverHttps](INFO): SBD MOMSN=17488037 2023-02-23T19:04:25.420Z,1677179065.420 [Default:CheckIn:Read_Iridium] Stopped 2023-02-23T19:04:25.420Z,1677179065.420 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-23T19:04:25.420Z,1677179065.420 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-23T19:04:31.061Z,1677179071.061 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-02-23T19:04:31.061Z,1677179071.061 [NAL9602] Data Fault, FailCount= 2 2023-02-23T19:04:31.061Z,1677179071.061 [NAL9602](ERROR): Data Fault 2023-02-23T19:04:31.088Z,1677179071.088 [CBIT](ERROR): Data Fault in component: NAL9602 2023-02-23T19:04:31.470Z,1677179071.470 [NAL9602](INFO): Powering down 2023-02-23T19:04:32.306Z,1677179072.306 [CBIT](INFO): Clearing failed state for component NAL9602 2023-02-23T19:04:32.307Z,1677179072.307 [NAL9602] No Fault, FailCount= 2 2023-02-23T19:05:01.747Z,1677179101.747 [NAL9602](INFO): Powering up NAL9602 2023-02-23T19:05:12.659Z,1677179112.659 [NAL9602](INFO): NAL9602 initialized 2023-02-23T19:05:59.526Z,1677179159.526 [DVL_micro](ERROR): Failed to parse:00000000000,35.0,+200,1489.0,000 2023-02-23T19:06:23.372Z,1677179183.372 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 26 2023-02-23T19:06:23.372Z,1677179183.372 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:06:23.382Z,1677179183.382 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:06:23.801Z,1677179183.801 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:06:23.802Z,1677179183.802 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 26 2023-02-23T19:09:24.355Z,1677179364.355 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 27 2023-02-23T19:09:24.355Z,1677179364.355 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:09:24.370Z,1677179364.370 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:09:24.806Z,1677179364.806 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:09:24.806Z,1677179364.806 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 27 2023-02-23T19:09:25.978Z,1677179365.978 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-23T19:09:25.978Z,1677179365.978 [Default:CheckIn:C.Wait] Stopped 2023-02-23T19:09:25.978Z,1677179365.978 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-23T19:09:25.978Z,1677179365.978 [Default:CheckIn:D] Running Loop=1 2023-02-23T19:09:26.384Z,1677179366.384 [Default:CheckIn:D] Stopped 2023-02-23T19:09:26.384Z,1677179366.384 [Default:CheckIn:E] Running Loop=1 2023-02-23T19:09:26.781Z,1677179366.781 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 77.782056 min 2023-02-23T19:09:26.781Z,1677179366.781 [Default:CheckIn:E] Stopped 2023-02-23T19:09:26.782Z,1677179366.782 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-23T19:09:26.782Z,1677179366.782 [Default:CheckIn] Stopped 2023-02-23T19:09:26.782Z,1677179366.782 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-23T19:09:26.782Z,1677179366.782 [Default:CheckIn](INFO): Running loop #8 2023-02-23T19:09:26.782Z,1677179366.782 [Default:CheckIn] Running Loop=8 2023-02-23T19:09:26.782Z,1677179366.782 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-23T19:09:26.782Z,1677179366.782 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-23T19:12:25.372Z,1677179545.372 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 28 2023-02-23T19:12:25.372Z,1677179545.372 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:12:25.419Z,1677179545.419 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:12:25.833Z,1677179545.833 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:12:25.833Z,1677179545.833 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 28 2023-02-23T19:12:49.999Z,1677179569.999 [DVL_micro](ERROR): Failed to parse: :000000000,35.0,+21.0,0000.0,1489.0,000 2023-02-23T19:14:26.961Z,1677179666.961 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-23T19:09:26.8Z 2023-02-23T19:14:26.961Z,1677179666.961 [Default:CheckIn:Read_GPS] Stopped 2023-02-23T19:14:26.961Z,1677179666.961 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-23T19:14:38.286Z,1677179678.286 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230223T174745/Courier0025.lzma 2023-02-23T19:14:39.321Z,1677179679.321 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Courier0025.lzma.bak 2023-02-23T19:14:39.322Z,1677179679.322 [DataOverHttps](INFO): SBD MOMSN=17488041 2023-02-23T19:15:03.175Z,1677179703.175 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230223T174745/Express0026.lzma 2023-02-23T19:15:04.177Z,1677179704.177 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Express0026.lzma.bak 2023-02-23T19:15:04.178Z,1677179704.178 [DataOverHttps](INFO): SBD MOMSN=17488043 2023-02-23T19:15:13.445Z,1677179713.445 [Default:CheckIn:Read_Iridium] Stopped 2023-02-23T19:15:13.445Z,1677179713.445 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-23T19:15:13.445Z,1677179713.445 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-23T19:15:13.822Z,1677179713.822 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-02-23T19:15:13.822Z,1677179713.822 [NAL9602] Data Fault, FailCount= 3 2023-02-23T19:15:13.822Z,1677179713.822 [NAL9602](ERROR): Data Fault 2023-02-23T19:15:13.890Z,1677179713.890 [CBIT](ERROR): Data Fault in component: NAL9602 2023-02-23T19:15:14.259Z,1677179714.259 [NAL9602](INFO): Powering down 2023-02-23T19:15:15.082Z,1677179715.082 [CBIT](INFO): Clearing failed state for component NAL9602 2023-02-23T19:15:15.082Z,1677179715.082 [NAL9602] No Fault, FailCount= 3 2023-02-23T19:15:26.392Z,1677179726.392 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 29 2023-02-23T19:15:26.393Z,1677179726.393 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:15:26.453Z,1677179726.453 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:15:26.809Z,1677179726.809 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:15:26.809Z,1677179726.809 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 29 2023-02-23T19:15:44.547Z,1677179744.547 [NAL9602](INFO): Powering up NAL9602 2023-02-23T19:15:55.426Z,1677179755.426 [NAL9602](INFO): NAL9602 initialized 2023-02-23T19:16:12.415Z,1677179772.415 [DVL_micro](ERROR): only read 2 of 4 data items 2023-02-23T19:16:12.415Z,1677179772.415 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+9999.99,,+9999.99 2023-02-23T19:18:27.337Z,1677179907.337 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 30 2023-02-23T19:18:27.337Z,1677179907.337 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:18:27.348Z,1677179907.348 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:18:27.774Z,1677179907.774 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:18:27.774Z,1677179907.774 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 30 2023-02-23T19:19:50.163Z,1677179990.163 [DVL_micro](ERROR): Failed to parse: 9.99,+99999.99, 2023-02-23T19:20:14.003Z,1677180014.003 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-23T19:20:14.003Z,1677180014.003 [Default:CheckIn:C.Wait] Stopped 2023-02-23T19:20:14.003Z,1677180014.003 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-23T19:20:14.003Z,1677180014.003 [Default:CheckIn:D] Running Loop=1 2023-02-23T19:20:14.404Z,1677180014.404 [Default:CheckIn:D] Stopped 2023-02-23T19:20:14.404Z,1677180014.404 [Default:CheckIn:E] Running Loop=1 2023-02-23T19:20:14.836Z,1677180014.836 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 88.582381 min 2023-02-23T19:20:14.836Z,1677180014.836 [Default:CheckIn:E] Stopped 2023-02-23T19:20:14.836Z,1677180014.836 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-23T19:20:14.836Z,1677180014.836 [Default:CheckIn] Stopped 2023-02-23T19:20:14.836Z,1677180014.836 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-23T19:20:14.836Z,1677180014.836 [Default:CheckIn](INFO): Running loop #9 2023-02-23T19:20:14.837Z,1677180014.837 [Default:CheckIn] Running Loop=9 2023-02-23T19:20:14.837Z,1677180014.837 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-23T19:20:14.837Z,1677180014.837 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-23T19:21:28.332Z,1677180088.332 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 31 2023-02-23T19:21:28.332Z,1677180088.332 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:21:28.343Z,1677180088.343 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:21:28.790Z,1677180088.790 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:21:28.790Z,1677180088.790 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 31 2023-02-23T19:22:29.753Z,1677180149.753 [DVL_micro](ERROR): Failed to parse: 40,+00029,-00386,+00000,I 2023-02-23T19:23:27.951Z,1677180207.951 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T19:23:27.951Z,1677180207.951 [DVL_micro](ERROR): Failed to parse: :TS,00000000000,+21.3,0000.0000 2023-02-23T19:24:29.348Z,1677180269.348 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 32 2023-02-23T19:24:29.348Z,1677180269.348 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:24:29.358Z,1677180269.358 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:24:29.786Z,1677180269.786 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:24:29.786Z,1677180269.786 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 32 2023-02-23T19:25:14.998Z,1677180314.998 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-23T19:20:14.8Z 2023-02-23T19:25:14.998Z,1677180314.998 [Default:CheckIn:Read_GPS] Stopped 2023-02-23T19:25:14.998Z,1677180314.998 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-23T19:25:21.879Z,1677180321.879 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T19:25:21.879Z,1677180321.879 [DVL_micro](ERROR): Failed to parse: :TS,000000,.3,0000.0,1489.0,000 2023-02-23T19:25:30.666Z,1677180330.666 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230223T174745/Courier0028.lzma 2023-02-23T19:25:31.637Z,1677180331.637 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Courier0028.lzma.bak 2023-02-23T19:25:31.638Z,1677180331.638 [DataOverHttps](INFO): SBD MOMSN=17488047 2023-02-23T19:25:56.631Z,1677180356.631 [DataOverHttps](INFO): Sending 150 bytes from file Logs/20230223T174745/Express0029.lzma 2023-02-23T19:25:57.633Z,1677180357.633 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Express0029.lzma.bak 2023-02-23T19:25:57.633Z,1677180357.633 [DataOverHttps](INFO): SBD MOMSN=17488049 2023-02-23T19:25:58.626Z,1677180358.626 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-02-23T19:25:58.626Z,1677180358.626 [NAL9602] Data Fault, FailCount= 4 2023-02-23T19:25:58.626Z,1677180358.626 [NAL9602](ERROR): Data Fault 2023-02-23T19:25:58.687Z,1677180358.687 [CBIT](ERROR): Data Fault in component: NAL9602 2023-02-23T19:25:59.037Z,1677180359.037 [NAL9602](INFO): Powering down 2023-02-23T19:25:59.903Z,1677180359.903 [CBIT](INFO): Clearing failed state for component NAL9602 2023-02-23T19:25:59.903Z,1677180359.903 [NAL9602] No Fault, FailCount= 4 2023-02-23T19:26:07.124Z,1677180367.124 [Default:CheckIn:Read_Iridium] Stopped 2023-02-23T19:26:07.125Z,1677180367.125 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-23T19:26:07.125Z,1677180367.125 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-23T19:26:29.338Z,1677180389.338 [NAL9602](INFO): Powering up NAL9602 2023-02-23T19:26:40.249Z,1677180400.249 [NAL9602](INFO): NAL9602 initialized 2023-02-23T19:26:58.099Z,1677180418.099 [DVL_micro](ERROR): DVL uart error: serial timeout 2023-02-23T19:26:58.100Z,1677180418.100 [DVL_micro] Communications Fault, FailCount= 1 2023-02-23T19:26:58.100Z,1677180418.100 [DVL_micro](ERROR): Communications Fault 2023-02-23T19:26:58.100Z,1677180418.100 [DVL_micro](ERROR): Failed to parse: 2023-02-23T19:26:58.188Z,1677180418.188 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-23T19:26:58.500Z,1677180418.500 [DVL_micro](INFO): Powering down 2023-02-23T19:26:58.848Z,1677180418.848 [Power24vConverter](INFO): Powering down. 2023-02-23T19:26:59.328Z,1677180419.328 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-23T19:26:59.328Z,1677180419.328 [DVL_micro] No Fault, FailCount= 1 2023-02-23T19:26:59.641Z,1677180419.641 [Power24vConverter](INFO): Powering up. 2023-02-23T19:27:30.364Z,1677180450.364 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 33 2023-02-23T19:27:30.364Z,1677180450.364 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:27:30.375Z,1677180450.375 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:27:30.769Z,1677180450.769 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:27:30.769Z,1677180450.769 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 33 2023-02-23T19:30:31.335Z,1677180631.335 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 34 2023-02-23T19:30:31.335Z,1677180631.335 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:30:31.383Z,1677180631.383 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:30:31.782Z,1677180631.782 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:30:31.782Z,1677180631.782 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 34 2023-02-23T19:31:07.714Z,1677180667.714 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-23T19:31:07.714Z,1677180667.714 [Default:CheckIn:C.Wait] Stopped 2023-02-23T19:31:07.714Z,1677180667.714 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-23T19:31:07.714Z,1677180667.714 [Default:CheckIn:D] Running Loop=1 2023-02-23T19:31:08.147Z,1677180668.147 [Default:CheckIn:D] Stopped 2023-02-23T19:31:08.147Z,1677180668.147 [Default:CheckIn:E] Running Loop=1 2023-02-23T19:31:08.512Z,1677180668.512 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 99.478101 min 2023-02-23T19:31:08.512Z,1677180668.512 [Default:CheckIn:E] Stopped 2023-02-23T19:31:08.512Z,1677180668.512 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-23T19:31:08.512Z,1677180668.512 [Default:CheckIn] Stopped 2023-02-23T19:31:08.512Z,1677180668.512 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-23T19:31:08.512Z,1677180668.512 [Default:CheckIn](INFO): Running loop #10 2023-02-23T19:31:08.512Z,1677180668.512 [Default:CheckIn] Running Loop=10 2023-02-23T19:31:08.512Z,1677180668.512 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-23T19:31:08.513Z,1677180668.513 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-23T19:31:53.340Z,1677180713.340 [DVL_micro](ERROR): only read 3 of 4 data items 2023-02-23T19:31:53.340Z,1677180713.340 [DVL_micro](ERROR): Failed to parse: :BI,+00137,-0029,+00000,I0000000.00,0.00,+00000000.00,9999.99,000.00 2023-02-23T19:32:56.936Z,1677180776.936 [DVL_micro](ERROR): DVL uart error: serial timeout 2023-02-23T19:32:56.936Z,1677180776.936 [DVL_micro] Communications Fault, FailCount= 1 2023-02-23T19:32:56.936Z,1677180776.936 [DVL_micro](ERROR): Communications Fault 2023-02-23T19:32:56.936Z,1677180776.936 [DVL_micro](ERROR): Failed to parse: 2023-02-23T19:32:56.966Z,1677180776.966 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-23T19:32:57.308Z,1677180777.308 [DVL_micro](INFO): Powering down 2023-02-23T19:32:58.102Z,1677180778.102 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-23T19:32:58.102Z,1677180778.102 [DVL_micro] No Fault, FailCount= 1 2023-02-23T19:33:15.821Z,1677180795.821 [DVL_micro](FAULT): Failed to initialize within timeout. 2023-02-23T19:33:15.821Z,1677180795.821 [DVL_micro] Communications Fault, FailCount= 2 2023-02-23T19:33:15.821Z,1677180795.821 [DVL_micro](ERROR): Communications Fault 2023-02-23T19:33:15.933Z,1677180795.933 [CBIT](ERROR): Communications Fault in component: DVL_micro 2023-02-23T19:33:16.296Z,1677180796.296 [DVL_micro](INFO): Powering down 2023-02-23T19:33:17.070Z,1677180797.070 [CBIT](INFO): Clearing failed state for component DVL_micro 2023-02-23T19:33:17.070Z,1677180797.070 [DVL_micro] No Fault, FailCount= 2 2023-02-23T19:33:32.650Z,1677180812.650 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 35 2023-02-23T19:33:32.651Z,1677180812.651 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:33:32.696Z,1677180812.696 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:33:32.831Z,1677180812.831 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:33:32.848Z,1677180812.848 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 35 2023-02-23T19:36:08.737Z,1677180968.737 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-23T19:31:08.5Z 2023-02-23T19:36:08.737Z,1677180968.737 [Default:CheckIn:Read_GPS] Stopped 2023-02-23T19:36:08.737Z,1677180968.737 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-23T19:36:21.187Z,1677180981.187 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230223T174745/Courier0031.lzma 2023-02-23T19:36:22.189Z,1677180982.189 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Courier0031.lzma.bak 2023-02-23T19:36:22.189Z,1677180982.189 [DataOverHttps](INFO): SBD MOMSN=17488107 2023-02-23T19:36:33.444Z,1677180993.444 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 36 2023-02-23T19:36:33.444Z,1677180993.444 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:36:33.480Z,1677180993.480 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:36:33.824Z,1677180993.824 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:36:33.824Z,1677180993.824 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 36 2023-02-23T19:36:37.431Z,1677180997.431 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T19:36:37.432Z,1677180997.432 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+21.5,0000.0,00 2023-02-23T19:36:42.261Z,1677181002.261 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-02-23T19:36:42.261Z,1677181002.261 [NAL9602] Data Fault, FailCount= 5 2023-02-23T19:36:42.261Z,1677181002.261 [NAL9602](ERROR): Data Fault 2023-02-23T19:36:42.362Z,1677181002.362 [CBIT](ERROR): Data Fault in component: NAL9602 2023-02-23T19:36:42.362Z,1677181002.362 [CBIT](CRITICAL): Data Fault in component: NAL9602 2023-02-23T19:36:42.680Z,1677181002.680 [NAL9602](INFO): Powering down 2023-02-23T19:36:42.777Z,1677181002.777 [CBIT](INFO): Critical error at 20230223T193642 2023-02-23T19:36:48.951Z,1677181008.951 [DataOverHttps](INFO): Sending 198 bytes from file Logs/20230223T174745/Express0032.lzma 2023-02-23T19:36:49.953Z,1677181009.953 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Express0032.lzma.bak 2023-02-23T19:36:49.954Z,1677181009.954 [DataOverHttps](INFO): SBD MOMSN=17488109 2023-02-23T19:36:59.649Z,1677181019.649 [Default:CheckIn:Read_Iridium] Stopped 2023-02-23T19:36:59.649Z,1677181019.649 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-23T19:36:59.650Z,1677181019.650 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-23T19:37:28.334Z,1677181048.334 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T19:37:28.334Z,1677181048.334 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+21.,1489.0,000 2023-02-23T19:38:28.927Z,1677181108.927 [DVL_micro](ERROR): only read 3 of 4 data items 2023-02-23T19:38:28.927Z,1677181108.927 [DVL_micro](ERROR): Failed to parse: :RD,+9999.99,+9999.99,+99999.99 2023-02-23T19:38:42.264Z,1677181122.264 [CBIT](INFO): Clearing failed state for component NAL9602 2023-02-23T19:38:42.264Z,1677181122.264 [NAL9602] No Fault, FailCount= 5 2023-02-23T19:38:42.654Z,1677181122.654 [NAL9602](INFO): Powering up NAL9602 2023-02-23T19:38:53.562Z,1677181133.562 [NAL9602](INFO): NAL9602 initialized 2023-02-23T19:39:34.388Z,1677181174.388 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 37 2023-02-23T19:39:34.388Z,1677181174.388 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:39:34.398Z,1677181174.398 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:39:34.820Z,1677181174.820 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:39:34.820Z,1677181174.820 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 37 2023-02-23T19:42:00.217Z,1677181320.217 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-23T19:42:00.217Z,1677181320.217 [Default:CheckIn:C.Wait] Stopped 2023-02-23T19:42:00.217Z,1677181320.217 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-23T19:42:00.217Z,1677181320.217 [Default:CheckIn:D] Running Loop=1 2023-02-23T19:42:00.655Z,1677181320.655 [Default:CheckIn:D] Stopped 2023-02-23T19:42:00.655Z,1677181320.655 [Default:CheckIn:E] Running Loop=1 2023-02-23T19:42:01.049Z,1677181321.049 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 110.353223 min 2023-02-23T19:42:01.049Z,1677181321.049 [Default:CheckIn:E] Stopped 2023-02-23T19:42:01.049Z,1677181321.049 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-23T19:42:01.049Z,1677181321.049 [Default:CheckIn] Stopped 2023-02-23T19:42:01.050Z,1677181321.050 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-23T19:42:01.050Z,1677181321.050 [Default:CheckIn](INFO): Running loop #11 2023-02-23T19:42:01.050Z,1677181321.050 [Default:CheckIn] Running Loop=11 2023-02-23T19:42:01.050Z,1677181321.050 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-23T19:42:01.050Z,1677181321.050 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-23T19:42:35.366Z,1677181355.366 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 38 2023-02-23T19:42:35.366Z,1677181355.366 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:42:35.376Z,1677181355.376 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:42:35.868Z,1677181355.868 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:42:35.868Z,1677181355.868 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 38 2023-02-23T19:42:37.185Z,1677181357.185 [CommandExec](IMPORTANT): got command show variable par 2023-02-23T19:42:37.431Z,1677181357.431 [DVL_micro](ERROR): Failed to parse: :WI,+00122,-00053,-00317,+00000,A 2023-02-23T19:42:37.524Z,1677181357.524 [CommandExec](IMPORTANT): PAR_Licor.loadControl (none) 2023-02-23T19:42:37.525Z,1677181357.525 [CommandExec](IMPORTANT): PAR_Licor.ad (none) 2023-02-23T19:42:37.525Z,1677181357.525 [CommandExec](IMPORTANT): PAR_Licor.adRes (bit) 2023-02-23T19:42:37.525Z,1677181357.525 [CommandExec](IMPORTANT): PAR_Licor.adTimeout (millisecond) 2023-02-23T19:42:37.526Z,1677181357.526 [CommandExec](IMPORTANT): PAR_Licor.adVref (volt) 2023-02-23T19:42:37.639Z,1677181357.639 [CommandExec](IMPORTANT): PAR_Licor.loadAtStartup (bool) 2023-02-23T19:42:37.639Z,1677181357.639 [CommandExec](IMPORTANT): PAR_Licor.simulateHardware (bool) 2023-02-23T19:42:37.656Z,1677181357.656 [CommandExec](IMPORTANT): PAR_Licor.adcCal (microampere_per_count) 2023-02-23T19:42:37.656Z,1677181357.656 [CommandExec](IMPORTANT): PAR_Licor.darkCount (count) 2023-02-23T19:42:37.657Z,1677181357.657 [CommandExec](IMPORTANT): PAR_Licor.maxBound (micromole_per_second_per_square_meter) 2023-02-23T19:42:37.657Z,1677181357.657 [CommandExec](IMPORTANT): PAR_Licor.maxValidPitch (degree) 2023-02-23T19:42:37.657Z,1677181357.657 [CommandExec](IMPORTANT): PAR_Licor.minBound (micromole_per_second_per_square_meter) 2023-02-23T19:42:37.658Z,1677181357.658 [CommandExec](IMPORTANT): PAR_Licor.minValidPitch (degree) 2023-02-23T19:42:37.658Z,1677181357.658 [CommandExec](IMPORTANT): PAR_Licor.multiplier (micromole_per_second_per_square_meter_per_microampere) 2023-02-23T19:42:37.658Z,1677181357.658 [CommandExec](IMPORTANT): PAR_Licor.parCal (none) 2023-02-23T19:42:37.659Z,1677181357.659 [CommandExec](IMPORTANT): PAR_Licor.serial (none) 2023-02-23T19:42:37.830Z,1677181357.830 [CommandExec](IMPORTANT): PAR_Licor.enableBroadcast (bool) 2023-02-23T19:42:37.830Z,1677181357.830 [CommandExec](IMPORTANT): PAR_Licor.component_voltage (volt) 2023-02-23T19:42:37.831Z,1677181357.831 [CommandExec](IMPORTANT): PAR_Licor.component_avgVoltage (volt) 2023-02-23T19:42:37.831Z,1677181357.831 [CommandExec](IMPORTANT): PAR_Licor.component_current (milliampere) 2023-02-23T19:42:37.868Z,1677181357.868 [CommandExec](IMPORTANT): PAR_Licor.component_avgCurrent (milliampere) 2023-02-23T19:42:37.876Z,1677181357.876 [CommandExec](IMPORTANT): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water (micromole_per_second_per_square_meter) 2023-02-23T19:42:37.876Z,1677181357.876 [CommandExec](IMPORTANT): PAR_Licor.adcCount (count) 2023-02-23T19:43:15.392Z,1677181395.392 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T19:43:15.392Z,1677181395.392 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+21.6,009.0,000 2023-02-23T19:43:17.128Z,1677181397.128 [CommandExec](IMPORTANT): got command report touch PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 2023-02-23T19:43:17.444Z,1677181397.444 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.551444 umol/s/m2 2023-02-23T19:43:17.832Z,1677181397.832 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.539827 umol/s/m2 2023-02-23T19:43:18.244Z,1677181398.244 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.531115 umol/s/m2 2023-02-23T19:43:18.711Z,1677181398.711 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.555800 umol/s/m2 2023-02-23T19:43:19.084Z,1677181399.084 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.561609 umol/s/m2 2023-02-23T19:43:19.456Z,1677181399.456 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.541279 umol/s/m2 2023-02-23T19:43:19.836Z,1677181399.836 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.534019 umol/s/m2 2023-02-23T19:43:20.242Z,1677181400.242 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.513689 umol/s/m2 2023-02-23T19:43:20.661Z,1677181400.661 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.531115 umol/s/m2 2023-02-23T19:43:21.103Z,1677181401.103 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.526757 umol/s/m2 2023-02-23T19:43:21.455Z,1677181401.455 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.544183 umol/s/m2 2023-02-23T19:43:21.879Z,1677181401.879 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.525306 umol/s/m2 2023-02-23T19:43:22.295Z,1677181402.295 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.523853 umol/s/m2 2023-02-23T19:43:22.687Z,1677181402.687 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.493359 umol/s/m2 2023-02-23T19:43:23.096Z,1677181403.096 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.542731 umol/s/m2 2023-02-23T19:43:23.485Z,1677181403.485 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.544183 umol/s/m2 2023-02-23T19:43:23.908Z,1677181403.908 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.519497 umol/s/m2 2023-02-23T19:43:24.314Z,1677181404.314 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.520948 umol/s/m2 2023-02-23T19:43:24.736Z,1677181404.736 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.570322 umol/s/m2 2023-02-23T19:43:25.128Z,1677181405.128 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.545636 umol/s/m2 2023-02-23T19:43:25.647Z,1677181405.647 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.535470 umol/s/m2 2023-02-23T19:43:25.980Z,1677181405.980 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.538375 umol/s/m2 2023-02-23T19:43:26.337Z,1677181406.337 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.499167 umol/s/m2 2023-02-23T19:43:26.740Z,1677181406.740 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.532566 umol/s/m2 2023-02-23T19:43:27.124Z,1677181407.124 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.563062 umol/s/m2 2023-02-23T19:43:27.543Z,1677181407.543 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.544183 umol/s/m2 2023-02-23T19:43:27.983Z,1677181407.983 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.545636 umol/s/m2 2023-02-23T19:43:28.366Z,1677181408.366 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.522402 umol/s/m2 2023-02-23T19:43:28.787Z,1677181408.787 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.568871 umol/s/m2 2023-02-23T19:43:29.158Z,1677181409.158 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.526757 umol/s/m2 2023-02-23T19:43:29.598Z,1677181409.598 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.544183 umol/s/m2 2023-02-23T19:43:29.992Z,1677181409.992 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.532566 umol/s/m2 2023-02-23T19:43:30.365Z,1677181410.365 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.552896 umol/s/m2 2023-02-23T19:43:30.727Z,1677181410.727 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T19:43:30.728Z,1677181410.728 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+0.0,1489.0,000 2023-02-23T19:43:30.804Z,1677181410.804 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.558704 umol/s/m2 2023-02-23T19:43:31.196Z,1677181411.196 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.547088 umol/s/m2 2023-02-23T19:43:31.605Z,1677181411.605 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.519497 umol/s/m2 2023-02-23T19:43:31.983Z,1677181411.983 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.534019 umol/s/m2 2023-02-23T19:43:32.392Z,1677181412.392 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.551444 umol/s/m2 2023-02-23T19:43:32.792Z,1677181412.792 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.516593 umol/s/m2 2023-02-23T19:43:33.294Z,1677181413.294 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.529662 umol/s/m2 2023-02-23T19:43:33.596Z,1677181413.596 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.549992 umol/s/m2 2023-02-23T19:43:33.995Z,1677181413.995 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.551444 umol/s/m2 2023-02-23T19:43:34.408Z,1677181414.408 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.525306 umol/s/m2 2023-02-23T19:43:34.784Z,1677181414.784 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.542731 umol/s/m2 2023-02-23T19:43:35.188Z,1677181415.188 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.551444 umol/s/m2 2023-02-23T19:43:35.630Z,1677181415.630 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.535470 umol/s/m2 2023-02-23T19:43:36.038Z,1677181416.038 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.554349 umol/s/m2 2023-02-23T19:43:36.432Z,1677181416.432 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.545636 umol/s/m2 2023-02-23T19:43:36.806Z,1677181416.806 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.529662 umol/s/m2 2023-02-23T19:43:37.218Z,1677181417.218 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.516593 umol/s/m2 2023-02-23T19:43:37.639Z,1677181417.639 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.515141 umol/s/m2 2023-02-23T19:43:38.050Z,1677181418.050 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.565966 umol/s/m2 2023-02-23T19:43:38.471Z,1677181418.471 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.560157 umol/s/m2 2023-02-23T19:43:38.834Z,1677181418.834 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.551444 umol/s/m2 2023-02-23T19:43:39.245Z,1677181419.245 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.561609 umol/s/m2 2023-02-23T19:43:39.634Z,1677181419.634 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.573226 umol/s/m2 2023-02-23T19:43:40.038Z,1677181420.038 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.576130 umol/s/m2 2023-02-23T19:43:40.447Z,1677181420.447 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.567417 umol/s/m2 2023-02-23T19:43:40.884Z,1677181420.884 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.554349 umol/s/m2 2023-02-23T19:43:41.283Z,1677181421.283 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.571774 umol/s/m2 2023-02-23T19:43:41.671Z,1677181421.671 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.563062 umol/s/m2 2023-02-23T19:43:42.065Z,1677181422.065 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.557253 umol/s/m2 2023-02-23T19:43:42.459Z,1677181422.459 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.548540 umol/s/m2 2023-02-23T19:43:42.864Z,1677181422.864 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.552896 umol/s/m2 2023-02-23T19:43:43.278Z,1677181423.278 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.570322 umol/s/m2 2023-02-23T19:43:43.707Z,1677181423.707 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.547088 umol/s/m2 2023-02-23T19:43:44.107Z,1677181424.107 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.576130 umol/s/m2 2023-02-23T19:43:44.512Z,1677181424.512 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.567417 umol/s/m2 2023-02-23T19:43:44.884Z,1677181424.884 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.554349 umol/s/m2 2023-02-23T19:43:45.299Z,1677181425.299 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.552896 umol/s/m2 2023-02-23T19:43:45.691Z,1677181425.691 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.567417 umol/s/m2 2023-02-23T19:43:46.105Z,1677181426.105 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.529662 umol/s/m2 2023-02-23T19:43:46.502Z,1677181426.502 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.560157 umol/s/m2 2023-02-23T19:43:46.931Z,1677181426.931 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.547088 umol/s/m2 2023-02-23T19:43:47.335Z,1677181427.335 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.568871 umol/s/m2 2023-02-23T19:43:47.743Z,1677181427.743 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.568871 umol/s/m2 2023-02-23T19:43:48.115Z,1677181428.115 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.539827 umol/s/m2 2023-02-23T19:43:48.533Z,1677181428.533 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.570322 umol/s/m2 2023-02-23T19:43:48.937Z,1677181428.937 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.554349 umol/s/m2 2023-02-23T19:43:49.328Z,1677181429.328 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.579035 umol/s/m2 2023-02-23T19:43:49.768Z,1677181429.768 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.548540 umol/s/m2 2023-02-23T19:43:50.158Z,1677181430.158 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.571774 umol/s/m2 2023-02-23T19:43:50.560Z,1677181430.560 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.570322 umol/s/m2 2023-02-23T19:43:50.980Z,1677181430.980 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.573226 umol/s/m2 2023-02-23T19:43:51.350Z,1677181431.350 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.586296 umol/s/m2 2023-02-23T19:43:51.754Z,1677181431.754 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.564513 umol/s/m2 2023-02-23T19:43:52.164Z,1677181432.164 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.571774 umol/s/m2 2023-02-23T19:43:52.575Z,1677181432.575 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.571774 umol/s/m2 2023-02-23T19:43:52.993Z,1677181432.993 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.563062 umol/s/m2 2023-02-23T19:43:53.391Z,1677181433.391 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.574678 umol/s/m2 2023-02-23T19:43:53.832Z,1677181433.832 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.565966 umol/s/m2 2023-02-23T19:43:54.207Z,1677181434.207 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.574678 umol/s/m2 2023-02-23T19:43:54.612Z,1677181434.612 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.567417 umol/s/m2 2023-02-23T19:43:54.999Z,1677181434.999 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.565966 umol/s/m2 2023-02-23T19:43:55.411Z,1677181435.411 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.579035 umol/s/m2 2023-02-23T19:43:55.827Z,1677181435.827 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.568871 umol/s/m2 2023-02-23T19:43:56.278Z,1677181436.278 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.535470 umol/s/m2 2023-02-23T19:43:56.655Z,1677181436.655 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.573226 umol/s/m2 2023-02-23T19:43:57.047Z,1677181437.047 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.574678 umol/s/m2 2023-02-23T19:43:57.419Z,1677181437.419 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.558704 umol/s/m2 2023-02-23T19:43:57.828Z,1677181437.828 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.587748 umol/s/m2 2023-02-23T19:43:58.217Z,1677181438.217 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.589200 umol/s/m2 2023-02-23T19:43:58.684Z,1677181438.684 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.567417 umol/s/m2 2023-02-23T19:43:59.057Z,1677181439.057 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.555800 umol/s/m2 2023-02-23T19:43:59.456Z,1677181439.456 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.576130 umol/s/m2 2023-02-23T19:43:59.831Z,1677181439.831 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.555800 umol/s/m2 2023-02-23T19:44:00.239Z,1677181440.239 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.560157 umol/s/m2 2023-02-23T19:44:00.652Z,1677181440.652 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.534019 umol/s/m2 2023-02-23T19:44:01.078Z,1677181441.078 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.548540 umol/s/m2 2023-02-23T19:44:01.454Z,1677181441.454 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.532566 umol/s/m2 2023-02-23T19:44:01.871Z,1677181441.871 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.528210 umol/s/m2 2023-02-23T19:44:02.272Z,1677181442.272 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.489001 umol/s/m2 2023-02-23T19:44:02.687Z,1677181442.687 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.494810 umol/s/m2 2023-02-23T19:44:03.068Z,1677181443.068 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.489001 umol/s/m2 2023-02-23T19:44:03.471Z,1677181443.471 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.502071 umol/s/m2 2023-02-23T19:44:03.896Z,1677181443.896 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1.241586 umol/s/m2 2023-02-23T19:44:04.292Z,1677181444.292 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 0.002904 umol/s/m2 2023-02-23T19:44:04.711Z,1677181444.711 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.039208 umol/s/m2 2023-02-23T19:44:05.126Z,1677181445.126 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.010165 umol/s/m2 2023-02-23T19:44:05.511Z,1677181445.511 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.008713 umol/s/m2 2023-02-23T19:44:05.906Z,1677181445.906 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.027591 umol/s/m2 2023-02-23T19:44:06.328Z,1677181446.328 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.002904 umol/s/m2 2023-02-23T19:44:06.702Z,1677181446.702 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.024687 umol/s/m2 2023-02-23T19:44:07.105Z,1677181447.105 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.052277 umol/s/m2 2023-02-23T19:44:07.519Z,1677181447.519 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.024687 umol/s/m2 2023-02-23T19:44:07.935Z,1677181447.935 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.030495 umol/s/m2 2023-02-23T19:44:08.350Z,1677181448.350 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.023234 umol/s/m2 2023-02-23T19:44:08.796Z,1677181448.796 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 0.008713 umol/s/m2 2023-02-23T19:44:09.133Z,1677181449.133 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.034852 umol/s/m2 2023-02-23T19:44:09.527Z,1677181449.527 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.023234 umol/s/m2 2023-02-23T19:44:09.932Z,1677181449.932 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.053729 umol/s/m2 2023-02-23T19:44:10.333Z,1677181450.333 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.027591 umol/s/m2 2023-02-23T19:44:10.767Z,1677181450.767 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.024687 umol/s/m2 2023-02-23T19:44:11.201Z,1677181451.201 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.034852 umol/s/m2 2023-02-23T19:44:11.577Z,1677181451.577 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.042112 umol/s/m2 2023-02-23T19:44:11.951Z,1677181451.951 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water -0.029043 umol/s/m2 2023-02-23T19:44:12.360Z,1677181452.360 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 0.127789 umol/s/m2 2023-02-23T19:44:12.773Z,1677181452.773 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.455602 umol/s/m2 2023-02-23T19:44:13.167Z,1677181453.167 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.535470 umol/s/m2 2023-02-23T19:44:13.568Z,1677181453.568 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.532566 umol/s/m2 2023-02-23T19:44:14.030Z,1677181454.030 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.592104 umol/s/m2 2023-02-23T19:44:14.392Z,1677181454.392 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.576130 umol/s/m2 2023-02-23T19:44:14.807Z,1677181454.807 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.571774 umol/s/m2 2023-02-23T19:44:15.183Z,1677181455.183 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.547088 umol/s/m2 2023-02-23T19:44:15.588Z,1677181455.588 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.603722 umol/s/m2 2023-02-23T19:44:16.003Z,1677181456.003 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.570322 umol/s/m2 2023-02-23T19:44:16.420Z,1677181456.420 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.586296 umol/s/m2 2023-02-23T19:44:16.835Z,1677181456.835 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.565966 umol/s/m2 2023-02-23T19:44:17.224Z,1677181457.224 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.587748 umol/s/m2 2023-02-23T19:44:17.624Z,1677181457.624 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.544183 umol/s/m2 2023-02-23T19:44:18.011Z,1677181458.011 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.587748 umol/s/m2 2023-02-23T19:44:18.415Z,1677181458.415 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.583391 umol/s/m2 2023-02-23T19:44:18.841Z,1677181458.841 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.583391 umol/s/m2 2023-02-23T19:44:19.233Z,1677181459.233 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.583391 umol/s/m2 2023-02-23T19:44:19.655Z,1677181459.655 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.580487 umol/s/m2 2023-02-23T19:44:20.061Z,1677181460.061 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.581939 umol/s/m2 2023-02-23T19:44:20.473Z,1677181460.473 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.573226 umol/s/m2 2023-02-23T19:44:20.844Z,1677181460.844 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.583391 umol/s/m2 2023-02-23T19:44:21.275Z,1677181461.275 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.564513 umol/s/m2 2023-02-23T19:44:21.684Z,1677181461.684 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.541279 umol/s/m2 2023-02-23T19:44:22.052Z,1677181462.052 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.571774 umol/s/m2 2023-02-23T19:44:22.457Z,1677181462.457 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.586296 umol/s/m2 2023-02-23T19:44:22.879Z,1677181462.879 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.603722 umol/s/m2 2023-02-23T19:44:23.292Z,1677181463.292 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.574678 umol/s/m2 2023-02-23T19:44:23.699Z,1677181463.699 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.561609 umol/s/m2 2023-02-23T19:44:24.062Z,1677181464.062 [DVL_micro](ERROR): Failed to parse: :BD,+.00,+0000000000000.00,9999.99,000.00 2023-02-23T19:44:24.080Z,1677181464.080 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.595009 umol/s/m2 2023-02-23T19:44:24.498Z,1677181464.498 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.552896 umol/s/m2 2023-02-23T19:44:24.912Z,1677181464.912 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.580487 umol/s/m2 2023-02-23T19:44:25.320Z,1677181465.320 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.596460 umol/s/m2 2023-02-23T19:44:25.744Z,1677181465.744 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.554349 umol/s/m2 2023-02-23T19:44:26.131Z,1677181466.131 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.548540 umol/s/m2 2023-02-23T19:44:26.137Z,1677181466.137 [CommandExec](IMPORTANT): got command report clear 2023-02-23T19:44:57.538Z,1677181497.538 [CommandExec](IMPORTANT): got command get platform_mass_position 2023-02-23T19:44:57.539Z,1677181497.539 [CommandExec](IMPORTANT): platform_mass_position -0.006554 m 2023-02-23T19:45:36.392Z,1677181536.392 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 39 2023-02-23T19:45:36.392Z,1677181536.392 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:45:36.402Z,1677181536.402 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:45:36.798Z,1677181536.798 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:45:36.798Z,1677181536.798 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 39 2023-02-23T19:45:38.260Z,1677181538.260 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction 35 millimeter 2023-02-23T19:45:38.269Z,1677181538.269 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.massPositionAction" handled in the control thread. 2023-02-23T19:45:38.440Z,1677181538.440 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.massPositionAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-02-23T19:46:22.185Z,1677181582.185 [CommandExec](IMPORTANT): got command get platform_mass_position 2023-02-23T19:46:22.185Z,1677181582.185 [CommandExec](IMPORTANT): platform_mass_position 0.026011 m 2023-02-23T19:46:29.955Z,1677181589.955 [CommandExec](IMPORTANT): got command get platform_mass_position 2023-02-23T19:46:29.960Z,1677181589.960 [CommandExec](IMPORTANT): platform_mass_position 0.032053 m 2023-02-23T19:46:36.546Z,1677181596.546 [CommandExec](IMPORTANT): got command get platform_mass_position 2023-02-23T19:46:36.546Z,1677181596.546 [CommandExec](IMPORTANT): platform_mass_position 0.035000 m 2023-02-23T19:46:49.203Z,1677181609.203 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction 39 millimeter 2023-02-23T19:47:01.236Z,1677181621.236 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-23T19:42:01.1Z 2023-02-23T19:47:01.237Z,1677181621.237 [Default:CheckIn:Read_GPS] Stopped 2023-02-23T19:47:01.237Z,1677181621.237 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-23T19:47:09.939Z,1677181629.939 [CommandExec](IMPORTANT): got command get platform_mass_position 2023-02-23T19:47:09.940Z,1677181629.940 [CommandExec](IMPORTANT): platform_mass_position 0.038999 m 2023-02-23T19:47:15.787Z,1677181635.787 [DataOverHttps](INFO): Sending 82 bytes from file Logs/20230223T174745/Courier0034.lzma 2023-02-23T19:47:16.789Z,1677181636.789 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Courier0034.lzma.bak 2023-02-23T19:47:16.789Z,1677181636.789 [DataOverHttps](INFO): SBD MOMSN=17488120 2023-02-23T19:47:21.450Z,1677181641.450 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T19:47:21.451Z,1677181641.451 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+21.7,0000.0,1489.W,+00074,-00292,+00000,A 2023-02-23T19:47:27.585Z,1677181647.585 [CommandExec](IMPORTANT): got command get platform_mass_position 2023-02-23T19:47:27.586Z,1677181647.586 [CommandExec](IMPORTANT): platform_mass_position 0.038999 m 2023-02-23T19:47:48.808Z,1677181668.808 [DataOverHttps](INFO): Sending 729 bytes from file Logs/20230223T174745/Express0035.lzma 2023-02-23T19:47:57.884Z,1677181677.884 [DataOverHttps](INFO): Sending 729 bytes from file Logs/20230223T174745/Express0035.lzma 2023-02-23T19:48:01.738Z,1677181681.738 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction -15 millimeter 2023-02-23T19:48:06.249Z,1677181686.249 [DataOverHttps](INFO): Sending 729 bytes from file Logs/20230223T174745/Express0035.lzma 2023-02-23T19:48:14.640Z,1677181694.640 [DataOverHttps](INFO): Sending 729 bytes from file Logs/20230223T174745/Express0035.lzma 2023-02-23T19:48:23.108Z,1677181703.108 [DataOverHttps](INFO): Sending 729 bytes from file Logs/20230223T174745/Express0035.lzma 2023-02-23T19:48:32.554Z,1677181712.554 [DataOverHttps](INFO): Sending 729 bytes from file Logs/20230223T174745/Express0035.lzma 2023-02-23T19:48:37.440Z,1677181717.440 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 40 2023-02-23T19:48:37.440Z,1677181717.440 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:48:37.503Z,1677181717.503 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:48:37.845Z,1677181717.845 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:48:37.845Z,1677181717.845 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 40 2023-02-23T19:48:41.849Z,1677181721.849 [DataOverHttps](INFO): Sending 729 bytes from file Logs/20230223T174745/Express0035.lzma 2023-02-23T19:48:42.849Z,1677181722.849 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Express0035.lzma.bak 2023-02-23T19:48:42.850Z,1677181722.850 [DataOverHttps](INFO): SBD MOMSN=17488123 2023-02-23T19:48:46.192Z,1677181726.192 [CommandExec](IMPORTANT): got command get platform_mass_position 2023-02-23T19:48:46.192Z,1677181726.192 [CommandExec](IMPORTANT): platform_mass_position 0.006087 m 2023-02-23T19:48:53.330Z,1677181733.330 [CommandExec](IMPORTANT): got command get platform_mass_position 2023-02-23T19:48:53.330Z,1677181733.330 [CommandExec](IMPORTANT): platform_mass_position 0.000410 m 2023-02-23T19:48:54.746Z,1677181734.746 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-02-23T19:48:54.747Z,1677181734.747 [NAL9602] Data Fault, FailCount= 1 2023-02-23T19:48:54.747Z,1677181734.747 [NAL9602](ERROR): Data Fault 2023-02-23T19:48:54.840Z,1677181734.840 [CBIT](ERROR): Data Fault in component: NAL9602 2023-02-23T19:48:55.175Z,1677181735.175 [NAL9602](INFO): Powering down 2023-02-23T19:48:55.214Z,1677181735.214 [Default:CheckIn:Read_Iridium] Stopped 2023-02-23T19:48:55.215Z,1677181735.215 [Default:CheckIn:C.Wait] Running Loop=1 2023-02-23T19:48:55.215Z,1677181735.215 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2023-02-23T19:48:56.030Z,1677181736.030 [CBIT](INFO): Clearing failed state for component NAL9602 2023-02-23T19:48:56.030Z,1677181736.030 [NAL9602] No Fault, FailCount= 1 2023-02-23T19:49:08.077Z,1677181748.077 [DVL_micro](ERROR): DVL BIT error. See manual. Result code: 62 2023-02-23T19:49:08.079Z,1677181748.079 [DVL_micro](ERROR): Failed to parse: :BD,+00000000.00,+00000000.00,+00000000.00,9999.99,000.00 2023-02-23T19:49:25.449Z,1677181765.449 [NAL9602](INFO): Powering up NAL9602 2023-02-23T19:49:32.861Z,1677181772.861 [CommandExec](IMPORTANT): got command get platform_mass_position 2023-02-23T19:49:32.862Z,1677181772.862 [CommandExec](IMPORTANT): platform_mass_position -0.015000 m 2023-02-23T19:49:36.350Z,1677181776.350 [NAL9602](INFO): NAL9602 initialized 2023-02-23T19:49:39.109Z,1677181779.109 [CommandExec](IMPORTANT): got command maintain clear 2023-02-23T19:49:39.206Z,1677181779.206 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-02-23T19:50:08.797Z,1677181808.797 [CommandExec](IMPORTANT): got command get platform_buoyancy_position 2023-02-23T19:50:08.797Z,1677181808.797 [CommandExec](IMPORTANT): platform_buoyancy_position 945.864868 cc 2023-02-23T19:50:32.769Z,1677181832.769 [CommandExec](IMPORTANT): got command maintain control VerticalControl.buoyancyAction 200 cubic_centimeter 2023-02-23T19:50:32.773Z,1677181832.773 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.buoyancyAction" handled in the control thread. 2023-02-23T19:50:32.941Z,1677181832.941 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.buoyancyAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-02-23T19:50:36.979Z,1677181836.979 [DVL_micro](ERROR): Failed to parse: :SA,-02.68,-01.10,232.0 2023-02-23T19:51:03.380Z,1677181863.380 [CommandExec](IMPORTANT): got command report mod platform_buoyancy_position 2023-02-23T19:51:03.688Z,1677181863.688 [Reporter](INFO): platform_buoyancy_position 593.461609 cc 2023-02-23T19:51:04.082Z,1677181864.082 [Reporter](INFO): platform_buoyancy_position 589.298340 cc 2023-02-23T19:51:04.498Z,1677181864.498 [Reporter](INFO): platform_buoyancy_position 582.851929 cc 2023-02-23T19:51:04.886Z,1677181864.886 [Reporter](INFO): platform_buoyancy_position 578.420044 cc 2023-02-23T19:51:05.301Z,1677181865.301 [Reporter](INFO): platform_buoyancy_position 572.510803 cc 2023-02-23T19:51:05.694Z,1677181865.694 [Reporter](INFO): platform_buoyancy_position 567.676025 cc 2023-02-23T19:51:06.086Z,1677181866.086 [Reporter](INFO): platform_buoyancy_position 563.244141 cc 2023-02-23T19:51:06.502Z,1677181866.502 [Reporter](INFO): platform_buoyancy_position 557.200623 cc 2023-02-23T19:51:06.917Z,1677181866.917 [Reporter](INFO): platform_buoyancy_position 552.365845 cc 2023-02-23T19:51:07.335Z,1677181867.335 [Reporter](INFO): platform_buoyancy_position 546.188049 cc 2023-02-23T19:51:07.698Z,1677181867.698 [Reporter](INFO): platform_buoyancy_position 541.756104 cc 2023-02-23T19:51:08.110Z,1677181868.110 [Reporter](INFO): platform_buoyancy_position 535.444031 cc 2023-02-23T19:51:08.529Z,1677181868.529 [Reporter](INFO): platform_buoyancy_position 531.012146 cc 2023-02-23T19:51:08.922Z,1677181868.922 [Reporter](INFO): platform_buoyancy_position 524.700012 cc 2023-02-23T19:51:09.334Z,1677181869.334 [Reporter](INFO): platform_buoyancy_position 520.133789 cc 2023-02-23T19:51:09.774Z,1677181869.774 [Reporter](INFO): platform_buoyancy_position 513.821716 cc 2023-02-23T19:51:10.142Z,1677181870.142 [Reporter](INFO): platform_buoyancy_position 509.658478 cc 2023-02-23T19:51:10.556Z,1677181870.556 [Reporter](INFO): platform_buoyancy_position 503.212036 cc 2023-02-23T19:51:10.950Z,1677181870.950 [Reporter](INFO): platform_buoyancy_position 498.780121 cc 2023-02-23T19:51:11.338Z,1677181871.338 [Reporter](INFO): platform_buoyancy_position 492.870911 cc 2023-02-23T19:51:11.757Z,1677181871.757 [Reporter](INFO): platform_buoyancy_position 488.170441 cc 2023-02-23T19:51:12.146Z,1677181872.146 [Reporter](INFO): platform_buoyancy_position 483.738556 cc 2023-02-23T19:51:12.582Z,1677181872.582 [Reporter](INFO): platform_buoyancy_position 477.426422 cc 2023-02-23T19:51:12.996Z,1677181872.996 [Reporter](INFO): platform_buoyancy_position 471.248627 cc 2023-02-23T19:51:13.376Z,1677181873.376 [Reporter](INFO): platform_buoyancy_position 466.682465 cc 2023-02-23T19:51:13.762Z,1677181873.762 [Reporter](INFO): platform_buoyancy_position 462.250519 cc 2023-02-23T19:51:14.201Z,1677181874.201 [Reporter](INFO): platform_buoyancy_position 455.938446 cc 2023-02-23T19:51:14.570Z,1677181874.570 [Reporter](INFO): platform_buoyancy_position 451.506561 cc 2023-02-23T19:51:14.982Z,1677181874.982 [Reporter](INFO): platform_buoyancy_position 446.806061 cc 2023-02-23T19:51:15.401Z,1677181875.401 [Reporter](INFO): platform_buoyancy_position 440.762543 cc 2023-02-23T19:51:15.814Z,1677181875.814 [Reporter](INFO): platform_buoyancy_position 434.719025 cc 2023-02-23T19:51:16.202Z,1677181876.202 [Reporter](INFO): platform_buoyancy_position 430.152863 cc 2023-02-23T19:51:16.622Z,1677181876.622 [Reporter](INFO): platform_buoyancy_position 423.706451 cc 2023-02-23T19:51:16.994Z,1677181876.994 [Reporter](INFO): platform_buoyancy_position 419.274567 cc 2023-02-23T19:51:17.434Z,1677181877.434 [Reporter](INFO): platform_buoyancy_position 414.976959 cc 2023-02-23T19:51:17.809Z,1677181877.809 [Reporter](INFO): platform_buoyancy_position 408.664856 cc 2023-02-23T19:51:18.210Z,1677181878.210 [Reporter](INFO): platform_buoyancy_position 404.232941 cc 2023-02-23T19:51:18.630Z,1677181878.630 [Reporter](INFO): platform_buoyancy_position 397.920837 cc 2023-02-23T19:51:19.040Z,1677181879.040 [Reporter](INFO): platform_buoyancy_position 393.488953 cc 2023-02-23T19:51:19.454Z,1677181879.454 [Reporter](INFO): platform_buoyancy_position 387.042542 cc 2023-02-23T19:51:19.850Z,1677181879.850 [Reporter](INFO): platform_buoyancy_position 382.207733 cc 2023-02-23T19:51:20.246Z,1677181880.246 [Reporter](INFO): platform_buoyancy_position 376.432831 cc 2023-02-23T19:51:20.638Z,1677181880.638 [Reporter](INFO): platform_buoyancy_position 372.000946 cc 2023-02-23T19:51:21.034Z,1677181881.034 [Reporter](INFO): platform_buoyancy_position 365.957428 cc 2023-02-23T19:51:21.470Z,1677181881.470 [Reporter](INFO): platform_buoyancy_position 361.122650 cc 2023-02-23T19:51:21.859Z,1677181881.859 [Reporter](INFO): platform_buoyancy_position 354.810547 cc 2023-02-23T19:51:22.269Z,1677181882.269 [Reporter](INFO): platform_buoyancy_position 350.512939 cc 2023-02-23T19:51:22.673Z,1677181882.673 [Reporter](INFO): platform_buoyancy_position 344.335144 cc 2023-02-23T19:51:23.062Z,1677181883.062 [Reporter](INFO): platform_buoyancy_position 339.768951 cc 2023-02-23T19:51:23.474Z,1677181883.474 [Reporter](INFO): platform_buoyancy_position 333.591125 cc 2023-02-23T19:51:23.893Z,1677181883.893 [Reporter](INFO): platform_buoyancy_position 329.159241 cc 2023-02-23T19:51:24.302Z,1677181884.302 [Reporter](INFO): platform_buoyancy_position 324.727325 cc 2023-02-23T19:51:24.750Z,1677181884.750 [Reporter](INFO): platform_buoyancy_position 318.012329 cc 2023-02-23T19:51:25.090Z,1677181885.090 [Reporter](INFO): platform_buoyancy_position 314.117645 cc 2023-02-23T19:51:25.502Z,1677181885.502 [Reporter](INFO): platform_buoyancy_position 307.671234 cc 2023-02-23T19:51:25.898Z,1677181885.898 [Reporter](INFO): platform_buoyancy_position 303.373627 cc 2023-02-23T19:51:26.294Z,1677181886.294 [Reporter](INFO): platform_buoyancy_position 297.061523 cc 2023-02-23T19:51:26.730Z,1677181886.730 [Reporter](INFO): platform_buoyancy_position 292.495331 cc 2023-02-23T19:51:27.118Z,1677181887.118 [Reporter](INFO): platform_buoyancy_position 286.183228 cc 2023-02-23T19:51:27.538Z,1677181887.538 [Reporter](INFO): platform_buoyancy_position 281.751343 cc 2023-02-23T19:51:27.909Z,1677181887.909 [Reporter](INFO): platform_buoyancy_position 275.842133 cc 2023-02-23T19:51:28.313Z,1677181888.313 [Reporter](INFO): platform_buoyancy_position 271.141632 cc 2023-02-23T19:51:28.733Z,1677181888.733 [Reporter](INFO): platform_buoyancy_position 264.560944 cc 2023-02-23T19:51:29.145Z,1677181889.145 [Reporter](INFO): platform_buoyancy_position 260.263336 cc 2023-02-23T19:51:29.561Z,1677181889.561 [Reporter](INFO): platform_buoyancy_position 253.951233 cc 2023-02-23T19:51:29.971Z,1677181889.971 [Reporter](INFO): platform_buoyancy_position 248.847855 cc 2023-02-23T19:51:30.393Z,1677181890.393 [Reporter](INFO): platform_buoyancy_position 243.072937 cc 2023-02-23T19:51:30.752Z,1677181890.752 [Reporter](INFO): platform_buoyancy_position 238.909637 cc 2023-02-23T19:51:31.166Z,1677181891.166 [Reporter](INFO): platform_buoyancy_position 234.477722 cc 2023-02-23T19:51:31.554Z,1677181891.554 [Reporter](INFO): platform_buoyancy_position 228.165619 cc 2023-02-23T19:51:31.977Z,1677181891.977 [Reporter](INFO): platform_buoyancy_position 223.733734 cc 2023-02-23T19:51:32.358Z,1677181892.358 [Reporter](INFO): platform_buoyancy_position 217.421631 cc 2023-02-23T19:51:32.794Z,1677181892.794 [Reporter](INFO): platform_buoyancy_position 212.989716 cc 2023-02-23T19:51:33.190Z,1677181893.190 [Reporter](INFO): platform_buoyancy_position 208.692139 cc 2023-02-23T19:51:38.388Z,1677181898.388 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 41 2023-02-23T19:51:38.388Z,1677181898.388 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:51:38.423Z,1677181898.423 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:51:38.802Z,1677181898.802 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:51:38.802Z,1677181898.802 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 41 2023-02-23T19:51:41.997Z,1677181901.997 [CommandExec](IMPORTANT): got command maintain clear 2023-02-23T19:51:42.022Z,1677181902.022 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-02-23T19:51:44.494Z,1677181904.494 [Reporter](INFO): platform_buoyancy_position 202.380035 cc 2023-02-23T19:51:45.301Z,1677181905.301 [Reporter](INFO): platform_buoyancy_position 203.991638 cc 2023-02-23T19:51:45.706Z,1677181905.706 [Reporter](INFO): platform_buoyancy_position 206.543335 cc 2023-02-23T19:51:46.124Z,1677181906.124 [Reporter](INFO): platform_buoyancy_position 210.975220 cc 2023-02-23T19:51:46.521Z,1677181906.521 [Reporter](INFO): platform_buoyancy_position 216.750122 cc 2023-02-23T19:51:46.890Z,1677181906.890 [Reporter](INFO): platform_buoyancy_position 221.584930 cc 2023-02-23T19:51:47.317Z,1677181907.317 [Reporter](INFO): platform_buoyancy_position 225.882538 cc 2023-02-23T19:51:47.728Z,1677181907.728 [Reporter](INFO): platform_buoyancy_position 232.328918 cc 2023-02-23T19:51:48.122Z,1677181908.122 [Reporter](INFO): platform_buoyancy_position 236.760834 cc 2023-02-23T19:51:48.530Z,1677181908.530 [Reporter](INFO): platform_buoyancy_position 243.072937 cc 2023-02-23T19:51:48.953Z,1677181908.953 [Reporter](INFO): platform_buoyancy_position 247.639145 cc 2023-02-23T19:51:49.338Z,1677181909.338 [Reporter](INFO): platform_buoyancy_position 253.816925 cc 2023-02-23T19:51:49.722Z,1677181909.722 [Reporter](INFO): platform_buoyancy_position 258.248840 cc 2023-02-23T19:51:50.138Z,1677181910.138 [Reporter](INFO): platform_buoyancy_position 264.695221 cc 2023-02-23T19:51:50.554Z,1677181910.554 [Reporter](INFO): platform_buoyancy_position 268.858521 cc 2023-02-23T19:51:50.946Z,1677181910.946 [Reporter](INFO): platform_buoyancy_position 275.304932 cc 2023-02-23T19:51:51.334Z,1677181911.334 [Reporter](INFO): platform_buoyancy_position 279.602539 cc 2023-02-23T19:51:51.758Z,1677181911.758 [Reporter](INFO): platform_buoyancy_position 285.780334 cc 2023-02-23T19:51:52.172Z,1677181912.172 [Reporter](INFO): platform_buoyancy_position 290.480835 cc 2023-02-23T19:51:52.584Z,1677181912.584 [Reporter](INFO): platform_buoyancy_position 296.927246 cc 2023-02-23T19:51:52.958Z,1677181912.958 [Reporter](INFO): platform_buoyancy_position 301.090546 cc 2023-02-23T19:51:53.379Z,1677181913.379 [Reporter](INFO): platform_buoyancy_position 305.656738 cc 2023-02-23T19:51:53.769Z,1677181913.769 [Reporter](INFO): platform_buoyancy_position 311.834534 cc 2023-02-23T19:51:54.166Z,1677181914.166 [Reporter](INFO): platform_buoyancy_position 316.266449 cc 2023-02-23T19:51:54.602Z,1677181914.602 [Reporter](INFO): platform_buoyancy_position 322.712830 cc 2023-02-23T19:51:55.010Z,1677181915.010 [Reporter](INFO): platform_buoyancy_position 327.144745 cc 2023-02-23T19:51:55.418Z,1677181915.418 [Reporter](INFO): platform_buoyancy_position 333.456848 cc 2023-02-23T19:51:55.774Z,1677181915.774 [Reporter](INFO): platform_buoyancy_position 337.754425 cc 2023-02-23T19:51:56.190Z,1677181916.190 [Reporter](INFO): platform_buoyancy_position 344.066528 cc 2023-02-23T19:51:56.602Z,1677181916.602 [Reporter](INFO): platform_buoyancy_position 348.498444 cc 2023-02-23T19:51:57.002Z,1677181917.002 [Reporter](INFO): platform_buoyancy_position 354.004730 cc 2023-02-23T19:51:57.418Z,1677181917.418 [Reporter](INFO): platform_buoyancy_position 359.242432 cc 2023-02-23T19:51:57.842Z,1677181917.842 [Reporter](INFO): platform_buoyancy_position 365.554535 cc 2023-02-23T19:51:58.241Z,1677181918.241 [Reporter](INFO): platform_buoyancy_position 371.732330 cc 2023-02-23T19:51:58.618Z,1677181918.618 [Reporter](INFO): platform_buoyancy_position 376.298553 cc 2023-02-23T19:51:59.014Z,1677181919.014 [Reporter](INFO): platform_buoyancy_position 380.730438 cc 2023-02-23T19:51:59.462Z,1677181919.462 [Reporter](INFO): platform_buoyancy_position 387.042542 cc 2023-02-23T19:51:59.889Z,1677181919.889 [Reporter](INFO): platform_buoyancy_position 391.340149 cc 2023-02-23T19:52:00.266Z,1677181920.266 [Reporter](INFO): platform_buoyancy_position 397.786530 cc 2023-02-23T19:52:00.682Z,1677181920.682 [Reporter](INFO): platform_buoyancy_position 402.084137 cc 2023-02-23T19:52:01.105Z,1677181921.105 [Reporter](INFO): platform_buoyancy_position 408.530548 cc 2023-02-23T19:52:01.525Z,1677181921.525 [Reporter](INFO): platform_buoyancy_position 412.962433 cc 2023-02-23T19:52:01.926Z,1677181921.926 [Reporter](INFO): platform_buoyancy_position 419.005951 cc 2023-02-23T19:52:02.384Z,1677181922.384 [Reporter](INFO): platform_buoyancy_position 423.975067 cc 2023-02-23T19:52:02.722Z,1677181922.722 [Reporter](INFO): platform_buoyancy_position 429.884247 cc 2023-02-23T19:52:03.193Z,1677181923.193 [Reporter](INFO): platform_buoyancy_position 434.450470 cc 2023-02-23T19:52:03.556Z,1677181923.556 [Reporter](INFO): platform_buoyancy_position 440.762543 cc 2023-02-23T19:52:03.990Z,1677181923.990 [Reporter](INFO): platform_buoyancy_position 445.194427 cc 2023-02-23T19:52:04.369Z,1677181924.369 [Reporter](INFO): platform_buoyancy_position 451.506561 cc 2023-02-23T19:52:04.853Z,1677181924.853 [Reporter](INFO): platform_buoyancy_position 455.938446 cc 2023-02-23T19:52:05.186Z,1677181925.186 [Reporter](INFO): platform_buoyancy_position 461.981964 cc 2023-02-23T19:52:05.648Z,1677181925.648 [Reporter](INFO): platform_buoyancy_position 468.159760 cc 2023-02-23T19:52:06.049Z,1677181926.049 [Reporter](INFO): platform_buoyancy_position 473.128876 cc 2023-02-23T19:52:06.457Z,1677181926.457 [Reporter](INFO): platform_buoyancy_position 479.440948 cc 2023-02-23T19:52:06.841Z,1677181926.841 [Reporter](INFO): platform_buoyancy_position 483.872833 cc 2023-02-23T19:52:07.174Z,1677181927.174 [Reporter](INFO): platform_buoyancy_position 487.901825 cc 2023-02-23T19:52:07.566Z,1677181927.566 [Reporter](INFO): platform_buoyancy_position 492.468079 cc 2023-02-23T19:52:07.958Z,1677181927.958 [Reporter](INFO): platform_buoyancy_position 498.780121 cc 2023-02-23T19:52:08.394Z,1677181928.394 [Reporter](INFO): platform_buoyancy_position 503.077759 cc 2023-02-23T19:52:08.769Z,1677181928.769 [Reporter](INFO): platform_buoyancy_position 509.658478 cc 2023-02-23T19:52:09.178Z,1677181929.178 [Reporter](INFO): platform_buoyancy_position 513.955994 cc 2023-02-23T19:52:09.595Z,1677181929.595 [Reporter](INFO): platform_buoyancy_position 520.268127 cc 2023-02-23T19:52:09.978Z,1677181929.978 [Reporter](INFO): platform_buoyancy_position 524.565735 cc 2023-02-23T19:52:10.386Z,1677181930.386 [Reporter](INFO): platform_buoyancy_position 531.012146 cc 2023-02-23T19:52:10.814Z,1677181930.814 [Reporter](INFO): platform_buoyancy_position 535.309692 cc 2023-02-23T19:52:11.235Z,1677181931.235 [Reporter](INFO): platform_buoyancy_position 541.890442 cc 2023-02-23T19:52:11.655Z,1677181931.655 [Reporter](INFO): platform_buoyancy_position 546.322327 cc 2023-02-23T19:52:12.020Z,1677181932.020 [Reporter](INFO): platform_buoyancy_position 550.619934 cc 2023-02-23T19:52:12.437Z,1677181932.437 [Reporter](INFO): platform_buoyancy_position 556.797729 cc 2023-02-23T19:52:12.818Z,1677181932.818 [Reporter](INFO): platform_buoyancy_position 561.095337 cc 2023-02-23T19:52:13.268Z,1677181933.268 [Reporter](INFO): platform_buoyancy_position 567.541748 cc 2023-02-23T19:52:13.682Z,1677181933.682 [Reporter](INFO): platform_buoyancy_position 572.510803 cc 2023-02-23T19:52:14.096Z,1677181934.096 [Reporter](INFO): platform_buoyancy_position 578.420044 cc 2023-02-23T19:52:14.461Z,1677181934.461 [Reporter](INFO): platform_buoyancy_position 582.717651 cc 2023-02-23T19:52:14.849Z,1677181934.849 [Reporter](INFO): platform_buoyancy_position 589.029724 cc 2023-02-23T19:52:15.278Z,1677181935.278 [Reporter](INFO): platform_buoyancy_position 593.461609 cc 2023-02-23T19:52:15.655Z,1677181935.655 [Reporter](INFO): platform_buoyancy_position 599.773743 cc 2023-02-23T19:52:16.090Z,1677181936.090 [Reporter](INFO): platform_buoyancy_position 604.339905 cc 2023-02-23T19:52:16.513Z,1677181936.513 [Reporter](INFO): platform_buoyancy_position 610.517700 cc 2023-02-23T19:52:16.880Z,1677181936.880 [Reporter](INFO): platform_buoyancy_position 614.949646 cc 2023-02-23T19:52:17.285Z,1677181937.285 [Reporter](INFO): platform_buoyancy_position 619.515808 cc 2023-02-23T19:52:17.666Z,1677181937.666 [Reporter](INFO): platform_buoyancy_position 625.559326 cc 2023-02-23T19:52:18.083Z,1677181938.083 [Reporter](INFO): platform_buoyancy_position 629.991211 cc 2023-02-23T19:52:18.554Z,1677181938.554 [Reporter](INFO): platform_buoyancy_position 636.437622 cc 2023-02-23T19:52:18.904Z,1677181938.904 [Reporter](INFO): platform_buoyancy_position 640.735229 cc 2023-02-23T19:52:19.318Z,1677181939.318 [Reporter](INFO): platform_buoyancy_position 647.047302 cc 2023-02-23T19:52:19.682Z,1677181939.682 [Reporter](INFO): platform_buoyancy_position 651.479248 cc 2023-02-23T19:52:20.074Z,1677181940.074 [Reporter](INFO): platform_buoyancy_position 657.388428 cc 2023-02-23T19:52:20.512Z,1677181940.512 [Reporter](INFO): platform_buoyancy_position 662.223206 cc 2023-02-23T19:52:20.922Z,1677181940.922 [Reporter](INFO): platform_buoyancy_position 668.535339 cc 2023-02-23T19:52:21.386Z,1677181941.386 [Reporter](INFO): platform_buoyancy_position 674.981750 cc 2023-02-23T19:52:21.763Z,1677181941.763 [Reporter](INFO): platform_buoyancy_position 679.279358 cc 2023-02-23T19:52:22.138Z,1677181942.138 [Reporter](INFO): platform_buoyancy_position 683.576904 cc 2023-02-23T19:52:22.570Z,1677181942.570 [Reporter](INFO): platform_buoyancy_position 690.023315 cc 2023-02-23T19:52:22.922Z,1677181942.922 [Reporter](INFO): platform_buoyancy_position 694.320923 cc 2023-02-23T19:52:23.390Z,1677181943.390 [Reporter](INFO): platform_buoyancy_position 700.767334 cc 2023-02-23T19:52:23.749Z,1677181943.749 [Reporter](INFO): platform_buoyancy_position 705.064941 cc 2023-02-23T19:52:24.130Z,1677181944.130 [Reporter](INFO): platform_buoyancy_position 709.362549 cc 2023-02-23T19:52:24.554Z,1677181944.554 [Reporter](INFO): platform_buoyancy_position 715.943237 cc 2023-02-23T19:52:24.957Z,1677181944.957 [Reporter](INFO): platform_buoyancy_position 720.240845 cc 2023-02-23T19:52:25.370Z,1677181945.370 [Reporter](INFO): platform_buoyancy_position 726.552917 cc 2023-02-23T19:52:25.808Z,1677181945.808 [Reporter](INFO): platform_buoyancy_position 730.850525 cc 2023-02-23T19:52:26.218Z,1677181946.218 [Reporter](INFO): platform_buoyancy_position 737.431213 cc 2023-02-23T19:52:26.571Z,1677181946.571 [Reporter](INFO): platform_buoyancy_position 741.594543 cc 2023-02-23T19:52:26.954Z,1677181946.954 [Reporter](INFO): platform_buoyancy_position 748.175232 cc 2023-02-23T19:52:27.405Z,1677181947.405 [Reporter](INFO): platform_buoyancy_position 752.472839 cc 2023-02-23T19:52:27.787Z,1677181947.787 [Reporter](INFO): platform_buoyancy_position 758.382019 cc 2023-02-23T19:52:27.984Z,1677181947.984 [DataOverHttps](INFO): Exceeded connection timeout, disconnecting. 2023-02-23T19:52:28.206Z,1677181948.206 [Reporter](INFO): platform_buoyancy_position 763.082520 cc 2023-02-23T19:52:28.634Z,1677181948.634 [Reporter](INFO): platform_buoyancy_position 769.528931 cc 2023-02-23T19:52:28.983Z,1677181948.983 [Reporter](INFO): platform_buoyancy_position 773.826538 cc 2023-02-23T19:52:29.390Z,1677181949.390 [Reporter](INFO): platform_buoyancy_position 778.527039 cc 2023-02-23T19:52:29.882Z,1677181949.882 [Reporter](INFO): platform_buoyancy_position 784.704834 cc 2023-02-23T19:52:30.238Z,1677181950.238 [Reporter](INFO): platform_buoyancy_position 791.016968 cc 2023-02-23T19:52:30.650Z,1677181950.650 [Reporter](INFO): platform_buoyancy_position 795.448853 cc 2023-02-23T19:52:31.206Z,1677181951.206 [Reporter](INFO): platform_buoyancy_position 802.835327 cc 2023-02-23T19:52:31.514Z,1677181951.514 [Reporter](INFO): platform_buoyancy_position 806.327148 cc 2023-02-23T19:52:31.851Z,1677181951.851 [Reporter](INFO): platform_buoyancy_position 811.161926 cc 2023-02-23T19:52:32.260Z,1677181952.260 [Reporter](INFO): platform_buoyancy_position 816.802551 cc 2023-02-23T19:52:32.696Z,1677181952.696 [Reporter](INFO): platform_buoyancy_position 823.248962 cc 2023-02-23T19:52:33.058Z,1677181953.058 [Reporter](INFO): platform_buoyancy_position 827.546570 cc 2023-02-23T19:52:33.502Z,1677181953.502 [Reporter](INFO): platform_buoyancy_position 833.724365 cc 2023-02-23T19:52:33.788Z,1677181953.788 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T19:52:33.789Z,1677181953.789 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+21.8,0000.0,1489.WI,00150,-00298,+000I,+00028,-00150,-00298,+00000,I 2023-02-23T19:52:33.993Z,1677181953.993 [Reporter](INFO): platform_buoyancy_position 838.424866 cc 2023-02-23T19:52:34.352Z,1677181954.352 [Reporter](INFO): platform_buoyancy_position 843.125366 cc 2023-02-23T19:52:34.628Z,1677181954.628 [Reporter](INFO): platform_buoyancy_position 847.020020 cc 2023-02-23T19:52:35.045Z,1677181955.045 [Reporter](INFO): platform_buoyancy_position 853.466431 cc 2023-02-23T19:52:35.498Z,1677181955.498 [Reporter](INFO): platform_buoyancy_position 859.778564 cc 2023-02-23T19:52:35.898Z,1677181955.898 [Reporter](INFO): platform_buoyancy_position 864.210449 cc 2023-02-23T19:52:36.334Z,1677181956.334 [Reporter](INFO): platform_buoyancy_position 870.522522 cc 2023-02-23T19:52:36.699Z,1677181956.699 [Reporter](INFO): platform_buoyancy_position 874.954468 cc 2023-02-23T19:52:37.078Z,1677181957.078 [Reporter](INFO): platform_buoyancy_position 879.117737 cc 2023-02-23T19:52:37.490Z,1677181957.490 [Reporter](INFO): platform_buoyancy_position 885.698425 cc 2023-02-23T19:52:37.890Z,1677181957.890 [Reporter](INFO): platform_buoyancy_position 889.996033 cc 2023-02-23T19:52:38.318Z,1677181958.318 [Reporter](INFO): platform_buoyancy_position 896.308167 cc 2023-02-23T19:52:38.762Z,1677181958.762 [Reporter](INFO): platform_buoyancy_position 902.888855 cc 2023-02-23T19:52:39.102Z,1677181959.102 [Reporter](INFO): platform_buoyancy_position 907.052124 cc 2023-02-23T19:52:39.569Z,1677181959.569 [Reporter](INFO): platform_buoyancy_position 912.155518 cc 2023-02-23T19:52:39.906Z,1677181959.906 [Reporter](INFO): platform_buoyancy_position 917.796143 cc 2023-02-23T19:52:40.318Z,1677181960.318 [Reporter](INFO): platform_buoyancy_position 922.093750 cc 2023-02-23T19:52:40.734Z,1677181960.734 [Reporter](INFO): platform_buoyancy_position 928.540161 cc 2023-02-23T19:52:41.159Z,1677181961.159 [Reporter](INFO): platform_buoyancy_position 932.972046 cc 2023-02-23T19:52:41.545Z,1677181961.545 [Reporter](INFO): platform_buoyancy_position 937.403931 cc 2023-02-23T19:52:41.957Z,1677181961.957 [Reporter](INFO): platform_buoyancy_position 943.581787 cc 2023-02-23T19:52:42.350Z,1677181962.350 [Reporter](INFO): platform_buoyancy_position 947.879395 cc 2023-02-23T19:52:51.293Z,1677181971.293 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction -15 degree 2023-02-23T19:52:51.313Z,1677181971.313 [ComponentRegistry](DEBUG): SyncComponent "Maintain_HorizontalControl.rudderAngleAction" handled in the control thread. 2023-02-23T19:52:51.686Z,1677181971.686 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_HorizontalControl.rudderAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-02-23T19:53:55.788Z,1677182035.788 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2023-02-23T19:53:55.788Z,1677182035.788 [Default:CheckIn:C.Wait] Stopped 2023-02-23T19:53:55.789Z,1677182035.789 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2023-02-23T19:53:55.789Z,1677182035.789 [Default:CheckIn:D] Running Loop=1 2023-02-23T19:53:56.206Z,1677182036.206 [Default:CheckIn:D] Stopped 2023-02-23T19:53:56.206Z,1677182036.206 [Default:CheckIn:E] Running Loop=1 2023-02-23T19:53:56.599Z,1677182036.599 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 122.279077 min 2023-02-23T19:53:56.599Z,1677182036.599 [Default:CheckIn:E] Stopped 2023-02-23T19:53:56.599Z,1677182036.599 [Default:CheckIn](INFO): Completed Default:CheckIn 2023-02-23T19:53:56.599Z,1677182036.599 [Default:CheckIn] Stopped 2023-02-23T19:53:56.599Z,1677182036.599 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-23T19:53:56.616Z,1677182036.616 [Default:CheckIn](INFO): Running loop #12 2023-02-23T19:53:56.616Z,1677182036.616 [Default:CheckIn] Running Loop=12 2023-02-23T19:53:56.616Z,1677182036.616 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-23T19:53:56.616Z,1677182036.616 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-23T19:54:39.449Z,1677182079.449 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 42 2023-02-23T19:54:39.449Z,1677182079.449 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:54:39.504Z,1677182079.504 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:54:39.865Z,1677182079.865 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:54:39.866Z,1677182079.866 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 42 2023-02-23T19:56:04.361Z,1677182164.361 [CommandExec](IMPORTANT): got command maintain 2023-02-23T19:56:04.361Z,1677182164.361 [Maintain_HorizontalControl.rudderAngleAction](INFO): HorizontalControl.rudderAngleAction maintaining -15.000000 arcdeg 2023-02-23T19:56:21.574Z,1677182181.574 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction -15 degree 2023-02-23T19:56:24.874Z,1677182184.874 [DVL_micro](ERROR): Failed to parse: :WI,+00182,-00114,-00247,+00000,A 2023-02-23T19:56:27.612Z,1677182187.612 [CommandExec](IMPORTANT): got command failComponent 2023-02-23T19:56:27.616Z,1677182187.616 [CommandExec](IMPORTANT): Failed components: 2023-02-23T19:56:27.616Z,1677182187.616 [CommandExec](IMPORTANT): No failed Components. 2023-02-23T19:56:31.780Z,1677182191.780 [CommandExec](IMPORTANT): got command maintain 2023-02-23T19:56:31.781Z,1677182191.781 [Maintain_HorizontalControl.rudderAngleAction](INFO): HorizontalControl.rudderAngleAction maintaining -15.000000 arcdeg 2023-02-23T19:56:42.475Z,1677182202.475 [CommandExec](IMPORTANT): got command get platform_rudder_angle degree 2023-02-23T19:56:42.475Z,1677182202.475 [CommandExec](IMPORTANT): platform_rudder_angle -15.030812 arcdeg 2023-02-23T19:57:02.189Z,1677182222.189 [CommandExec](IMPORTANT): got command maintain control HorizontalControl.rudderAngleAction 15 degree 2023-02-23T19:57:13.355Z,1677182233.355 [CommandExec](IMPORTANT): got command maintain clear 2023-02-23T19:57:13.449Z,1677182233.449 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-02-23T19:57:40.436Z,1677182260.436 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 43 2023-02-23T19:57:40.436Z,1677182260.436 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T19:57:40.447Z,1677182260.447 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T19:57:40.891Z,1677182260.891 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T19:57:40.891Z,1677182260.891 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 43 2023-02-23T19:57:46.828Z,1677182266.828 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction 15 degree 2023-02-23T19:57:46.832Z,1677182266.832 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.elevatorAngleAction" handled in the control thread. 2023-02-23T19:57:46.923Z,1677182266.923 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.elevatorAngleAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-02-23T19:57:59.820Z,1677182279.820 [CommandExec](IMPORTANT): got command maintain control VerticalControl.elevatorAngleAction -15 degree 2023-02-23T19:58:08.769Z,1677182288.769 [CommandExec](IMPORTANT): got command maintain clear 2023-02-23T19:58:09.154Z,1677182289.154 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-02-23T19:58:25.911Z,1677182305.911 [CommandExec](IMPORTANT): got command maintain control SpeedControl.propOmegaAction 300 revolution_per_minute 2023-02-23T19:58:25.914Z,1677182305.914 [ComponentRegistry](DEBUG): SyncComponent "Maintain_SpeedControl.propOmegaAction" handled in the control thread. 2023-02-23T19:58:26.100Z,1677182306.100 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_SpeedControl.propOmegaAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-02-23T19:58:37.485Z,1677182317.485 [CommandExec](IMPORTANT): got command maintain clear 2023-02-23T19:58:37.512Z,1677182317.512 [controlThread](DEBUG): Component order: CycleStarter,ESPComponent,PAR_Licor,AHRS_M2,BPC1,Depth_Keller,DVL_micro,NAL9602,Power24vConverter,PAR_Licor,Depth_Keller,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2023-02-23T19:58:56.793Z,1677182336.793 [Default:CheckIn:Read_GPS](INFO): Timed out from 2023-02-23T19:53:56.6Z 2023-02-23T19:58:56.794Z,1677182336.794 [Default:CheckIn:Read_GPS] Stopped 2023-02-23T19:58:56.794Z,1677182336.794 [Default:CheckIn:Read_Iridium] Running Loop=1 2023-02-23T19:59:08.524Z,1677182348.524 [CommandExec](IMPORTANT): got command run ./Missions/Insert/Science.xml 2023-02-23T19:59:08.524Z,1677182348.524 [MissionManager](INFO): Loading Mission from file: ./Missions/Insert/Science.xml 2023-02-23T19:59:08.691Z,1677182348.691 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20230223T174745/Courier0037.lzma 2023-02-23T19:59:09.021Z,1677182349.021 [MissionManager](INFO): DefineArg Science.PeakDetectChlActive = 0 bool 2023-02-23T19:59:09.025Z,1677182349.025 [MissionManager](INFO): DefineArg Science.TimeWindowPeakReport = nan min 2023-02-23T19:59:09.028Z,1677182349.028 [MissionManager](INFO): DefineArg Science.HighestChlPeakReportActive = 0 bool 2023-02-23T19:59:09.031Z,1677182349.031 [MissionManager](INFO): DefineArg Science.HighestSaltPeakReportActive = 0 bool 2023-02-23T19:59:09.034Z,1677182349.034 [MissionManager](INFO): DefineArg Science.HighestOilPeakReportActive = 0 bool 2023-02-23T19:59:09.037Z,1677182349.037 [MissionManager](INFO): DefineArg Science.PatchTracking = 0 bool 2023-02-23T19:59:09.040Z,1677182349.040 [MissionManager](INFO): DefineArg Science.DetectTrough = 0 bool 2023-02-23T19:59:09.043Z,1677182349.043 [MissionManager](INFO): DefineArg Science.FilterWidthHorizontal = 3.000000 count 2023-02-23T19:59:09.048Z,1677182349.048 [MissionManager](INFO): DefineArg Science.NumProfilesSlidingwindow = 100.000000 count 2023-02-23T19:59:09.062Z,1677182349.062 [MissionManager](INFO): DefineArg Science.OffPeakFractionHorizontal = 80.000000 % 2023-02-23T19:59:09.117Z,1677182349.117 [MissionManager](INFO): DefineArg Science.PeakDetectNO3Active = 0 bool 2023-02-23T19:59:09.124Z,1677182349.124 [MissionManager](INFO): DefineArg Science.PeakDetectOilActive = 0 bool 2023-02-23T19:59:09.127Z,1677182349.127 [MissionManager](INFO): DefineArg Science.PeakDetectFDOMActive = 0 bool 2023-02-23T19:59:09.138Z,1677182349.138 [MissionManager](INFO): DefineArg Science.PeakDetectSalinityActive = 0 bool 2023-02-23T19:59:09.144Z,1677182349.144 [MissionManager](INFO): DefineArg Science.UpwardDerivativeOfTemperatureActive = 0 bool 2023-02-23T19:59:09.160Z,1677182349.160 [MissionManager](INFO): DefineArg Science.EnabledAanderaaO2 = 0 bool 2023-02-23T19:59:09.169Z,1677182349.169 [MissionManager](INFO): DefineArg Science.EnabledNeilBrown = 0 bool 2023-02-23T19:59:09.182Z,1677182349.182 [MissionManager](INFO): DefineArg Science.EnabledSeabird = 1 bool 2023-02-23T19:59:09.234Z,1677182349.234 [MissionManager](INFO): DefineArg Science.EnabledWetLabsBB2FL = 1 bool 2023-02-23T19:59:09.239Z,1677182349.239 [MissionManager](INFO): DefineArg Science.EnabledWetLabsSeaOWL_UV_A = 0 bool 2023-02-23T19:59:09.261Z,1677182349.261 [MissionManager](INFO): DefineArg Science.EnabledWetLabsUBAT = 0 bool 2023-02-23T19:59:09.268Z,1677182349.268 [MissionManager](INFO): DefineArg Science.LowPassWindowLength = 20.000000 count 2023-02-23T19:59:09.292Z,1677182349.292 [MissionManager](INFO): DefineArg Science.MedianFilterLen = 5.000000 count 2023-02-23T19:59:09.324Z,1677182349.324 [MissionManager](INFO): DefineArg Science.PeakShallowBound = nan m 2023-02-23T19:59:09.327Z,1677182349.327 [MissionManager](INFO): DefineArg Science.PeakDeepBound = nan m 2023-02-23T19:59:09.358Z,1677182349.358 [MissionManager](INFO): DefineArg Science.DepChangeThreshForAttitudeFlip = 2.000000 m 2023-02-23T19:59:09.366Z,1677182349.366 [MissionManager](INFO): DefineOutput Science.PeakChl = 0.000000 ug/l 2023-02-23T19:59:09.397Z,1677182349.397 [MissionManager](INFO): DefineOutput Science.PeakChlDepth = 0.000000 m 2023-02-23T19:59:09.417Z,1677182349.417 [MissionManager](INFO): DefineOutput Science.PeakChlTemperature = 0.000000 degC 2023-02-23T19:59:09.493Z,1677182349.493 [MissionManager](INFO): DefineOutput Science.PeakChlLatitude = nan arcdeg 2023-02-23T19:59:09.496Z,1677182349.496 [MissionManager](INFO): DefineOutput Science.PeakChlLongitude = nan arcdeg 2023-02-23T19:59:09.516Z,1677182349.516 [MissionManager](INFO): DefineOutput Science.PeakNO3 = 0.000000 umol/l 2023-02-23T19:59:09.539Z,1677182349.539 [MissionManager](INFO): DefineOutput Science.PeakNO3Depth = 0.000000 m 2023-02-23T19:59:09.574Z,1677182349.574 [MissionManager](INFO): DefineOutput Science.PeakNO3Latitude = nan arcdeg 2023-02-23T19:59:09.586Z,1677182349.586 [MissionManager](INFO): DefineOutput Science.PeakNO3Longitude = nan arcdeg 2023-02-23T19:59:09.618Z,1677182349.618 [MissionManager](INFO): DefineOutput Science.PeakOil = 0.000000 kg/m3 2023-02-23T19:59:09.630Z,1677182349.630 [MissionManager](INFO): DefineOutput Science.PeakOilDepth = 0.000000 m 2023-02-23T19:59:09.653Z,1677182349.653 [MissionManager](INFO): DefineOutput Science.PeakOilLatitude = nan arcdeg 2023-02-23T19:59:09.669Z,1677182349.669 [MissionManager](INFO): DefineOutput Science.PeakOilLongitude = nan arcdeg 2023-02-23T19:59:09.693Z,1677182349.693 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Courier0037.lzma.bak 2023-02-23T19:59:09.693Z,1677182349.693 [DataOverHttps](INFO): SBD MOMSN=17488189 2023-02-23T19:59:09.712Z,1677182349.712 [MissionManager](INFO): DefineOutput Science.PeakFDOM = 0.000000 ppb 2023-02-23T19:59:09.734Z,1677182349.734 [MissionManager](INFO): DefineOutput Science.PeakFDOMDepth = 0.000000 m 2023-02-23T19:59:09.750Z,1677182349.750 [MissionManager](INFO): DefineOutput Science.PeakFDOMTemperature = nan degC 2023-02-23T19:59:09.770Z,1677182349.770 [MissionManager](INFO): DefineOutput Science.PeakFDOMLatitude = nan arcdeg 2023-02-23T19:59:09.785Z,1677182349.785 [MissionManager](INFO): DefineOutput Science.PeakFDOMLongitude = nan arcdeg 2023-02-23T19:59:09.801Z,1677182349.801 [MissionManager](INFO): DefineOutput Science.PatchFDOMDistance = nan m 2023-02-23T19:59:09.829Z,1677182349.829 [MissionManager](INFO): DefineOutput Science.PeakSalt = 0.000000 psu 2023-02-23T19:59:09.928Z,1677182349.928 [MissionManager](INFO): DefineOutput Science.PeakSaltDepth = 0.000000 m 2023-02-23T19:59:09.948Z,1677182349.948 [MissionManager](INFO): DefineOutput Science.PeakSaltTemperature = 0.000000 degC 2023-02-23T19:59:09.951Z,1677182349.951 [MissionManager](INFO): DefineOutput Science.PeakSaltLatitude = nan arcdeg 2023-02-23T19:59:09.958Z,1677182349.958 [MissionManager](INFO): DefineOutput Science.PeakSaltLongitude = nan arcdeg 2023-02-23T19:59:09.962Z,1677182349.962 [MissionManager](INFO): DefineOutput Science.PatchChl = 0.000000 ug/l 2023-02-23T19:59:09.974Z,1677182349.974 [MissionManager](INFO): DefineOutput Science.PatchChlDepth = 0.000000 m 2023-02-23T19:59:09.981Z,1677182349.981 [MissionManager](INFO): DefineOutput Science.PatchChlLatitude = nan arcdeg 2023-02-23T19:59:10.001Z,1677182350.001 [MissionManager](INFO): DefineOutput Science.PatchChlLongitude = nan arcdeg 2023-02-23T19:59:10.008Z,1677182350.008 [MissionManager](INFO): DefineOutput Science.PatchChlDistance = nan m 2023-02-23T19:59:10.018Z,1677182350.018 [MissionManager](INFO): DefineOutput Science.PatchSalt = 0.000000 psu 2023-02-23T19:59:10.033Z,1677182350.033 [MissionManager](INFO): DefineOutput Science.PatchSaltDepth = 0.000000 m 2023-02-23T19:59:10.042Z,1677182350.042 [MissionManager](INFO): DefineOutput Science.PatchSaltLatitude = nan arcdeg 2023-02-23T19:59:10.059Z,1677182350.059 [MissionManager](INFO): DefineOutput Science.PatchSaltLongitude = nan arcdeg 2023-02-23T19:59:10.077Z,1677182350.077 [MissionManager](INFO): DefineOutput Science.PatchSaltDistance = nan m 2023-02-23T19:59:10.102Z,1677182350.102 [MissionManager](INFO): DefineOutput Science.PatchOil = 0.000000 psu 2023-02-23T19:59:10.110Z,1677182350.110 [MissionManager](INFO): DefineOutput Science.PatchOilDepth = 0.000000 m 2023-02-23T19:59:10.129Z,1677182350.129 [MissionManager](INFO): DefineOutput Science.PatchOilLatitude = nan arcdeg 2023-02-23T19:59:10.149Z,1677182350.149 [MissionManager](INFO): DefineOutput Science.PatchOilLongitude = nan arcdeg 2023-02-23T19:59:10.168Z,1677182350.168 [MissionManager](INFO): DefineOutput Science.PatchOilDistance = nan m 2023-02-23T19:59:10.326Z,1677182350.326 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2023-02-23T19:59:10.362Z,1677182350.362 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2023-02-23T19:59:10.441Z,1677182350.441 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2023-02-23T19:59:10.477Z,1677182350.477 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2023-02-23T19:59:10.533Z,1677182350.533 [Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2023-02-23T19:59:10.610Z,1677182350.610 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2023-02-23T19:59:10.683Z,1677182350.683 [Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Construct PeakDetectVsDepth. 2023-02-23T19:59:10.773Z,1677182350.773 [Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Construct PeakDetectHorizontal. 2023-02-23T19:59:11.006Z,1677182351.006 [MissionManager](DEBUG): Turns on peak detection of Cholorphyll. If greater than zero, report a peak every window. If NaN or zero, this variable is ignored. NaN Turns on reporting of the highest peak value of chlorophyll on yo-yo profiles in a horizontal sliding window (of length numProfilesSlidingwindow) Turns on reporting of the highest peak value of salinity on yo-yo profiles in a horizontal sliding window (of length numProfilesSlidingwindow) Turns on reporting of the highest peak value of oil on yo-yo profiles in a horizontal sliding window (of length numProfilesSlidingwindow) If tracking a patch Whether to track a trough. If false, track peak; if true, track trough. Default is false. Width of boxcar filter applied to yoyo-wise chl peaks to pick out the highest peak. 3 Length of horizontal sliding window. The highest yoyo-wise chl peak (after low-pass filtering by a filter of length FilterWidthHorizontal) within this window. 100 When filtered horizontal value is this fraction of the peak, consider it outside the patch. 80 Turns on peak detection of Nitrate (and turns on ISUS). Turns on peak detection of Dissolved Oil. Turns on peak detection of concentration_of_colored_dissolved_organic_matter_in_sea_water from FDOM sensor. Turns on peak detection of salinity. Turns on seawater temperature derivative. Automatically set to True if the Aanderaa O2 sensor is installed. Set to false to disable reading Aandera O2. Automatically set to true if the Neil Brown CTD is enabled. Set to false to disable reading from the Neil Brown. Automatically set to true if the CTD is enabled. Set to false to disable reading from the CTD. Automatically set to true if the the WetLabs BB2FL is enabled. Set to false to disable the WetLabs BB2FL. Automatically set to true if the the WetLabs SeaOWL UV-A is enabled. Set to false to disable the WetLabs SeaOWL UV-A. Automatically set to true if the the WetLabs UBAT is enabled. Set to false to disable the WetLabs UBAT. Low-pass window length (based on depth sensor sampling interval 0.4 second) for low-pass filtering. 20 Median filter length (only for chlorophyll fluorescence which tends to have spikes) 5 Shallow depth bound for detecting any peak on each descent or ascent profile. NaN Deep depth bound for detecting any peak on each descent or ascent profile. NaN Depth change threshold for determining vehicle attitude flip. 2.0 0 0 0 NaN NaN 0 0 NaN NaN 0 0 NaN NaN 0 0 NaN NaN NaN NaN 0 0 0 NaN NaN 0 0 NaN NaN NaN 0 0 NaN NaN NaN 0 0 NaN NaN NaN 2023-02-23T19:59:11.010Z,1677182351.010 [CommandExec](IMPORTANT): Running ./Missions/Insert/Science.xml 2023-02-23T19:59:11.353Z,1677182351.353 [Default] Stopped 2023-02-23T19:59:11.353Z,1677182351.353 [Default](DEBUG): Aggregate::uninitialize Default 2023-02-23T19:59:11.353Z,1677182351.353 [Default:B.GoToSurface] Stopped 2023-02-23T19:59:11.353Z,1677182351.353 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-02-23T19:59:11.353Z,1677182351.353 [Default:CheckIn] Stopped 2023-02-23T19:59:11.353Z,1677182351.353 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-23T19:59:11.353Z,1677182351.353 [Default:CheckIn:Read_Iridium] Stopped 2023-02-23T19:59:11.353Z,1677182351.353 [MissionManager](IMPORTANT): Started mission Science 2023-02-23T19:59:11.353Z,1677182351.353 [Science] Running Loop=1 2023-02-23T19:59:11.354Z,1677182351.354 [Science](DEBUG): Aggregate::initialize Science 2023-02-23T19:59:11.354Z,1677182351.354 [Science:A] Running Loop=1 2023-02-23T19:59:11.354Z,1677182351.354 [Science:B] Running Loop=1 2023-02-23T19:59:11.354Z,1677182351.354 [Science:C] Running Loop=1 2023-02-23T19:59:11.354Z,1677182351.354 [Science:D] Running Loop=1 2023-02-23T19:59:11.354Z,1677182351.354 [Science:E] Running Loop=1 2023-02-23T19:59:11.354Z,1677182351.354 [Science:F] Running Loop=1 2023-02-23T19:59:11.354Z,1677182351.354 [Science:Read_Oil] Running Loop=1 2023-02-23T19:59:11.354Z,1677182351.354 [Science:PeakDetectChl] Running Loop=1 2023-02-23T19:59:11.354Z,1677182351.354 [Science:PeakDetectChl](DEBUG): Aggregate::initialize Science:PeakDetectChl 2023-02-23T19:59:11.354Z,1677182351.354 [Science:PeakDetectChl:A.PeakDetectVsDepth] Running Loop=1 2023-02-23T19:59:11.354Z,1677182351.354 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Initialize. 2023-02-23T19:59:11.365Z,1677182351.365 [Science:HighestChlPeakReport] Running Loop=1 2023-02-23T19:59:11.365Z,1677182351.365 [Science:HighestChlPeakReport](DEBUG): Aggregate::initialize Science:HighestChlPeakReport 2023-02-23T19:59:11.365Z,1677182351.365 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Running Loop=1 2023-02-23T19:59:11.365Z,1677182351.365 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2023-02-23T19:59:11.366Z,1677182351.366 [Science:PeakDetectNO3] Running Loop=1 2023-02-23T19:59:11.366Z,1677182351.366 [Science:PeakDetectNO3](DEBUG): Aggregate::initialize Science:PeakDetectNO3 2023-02-23T19:59:11.366Z,1677182351.366 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Running Loop=1 2023-02-23T19:59:11.366Z,1677182351.366 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Initialize. 2023-02-23T19:59:11.388Z,1677182351.388 [Science:PeakDetectOil] Running Loop=1 2023-02-23T19:59:11.388Z,1677182351.388 [Science:PeakDetectOil](DEBUG): Aggregate::initialize Science:PeakDetectOil 2023-02-23T19:59:11.388Z,1677182351.388 [Science:PeakDetectOil:A.PeakDetectVsDepth] Running Loop=1 2023-02-23T19:59:11.389Z,1677182351.389 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Initialize. 2023-02-23T19:59:11.390Z,1677182351.390 [Science:HighestOilPeakReport] Running Loop=1 2023-02-23T19:59:11.390Z,1677182351.390 [Science:HighestOilPeakReport](DEBUG): Aggregate::initialize Science:HighestOilPeakReport 2023-02-23T19:59:11.391Z,1677182351.391 [Science:HighestOilPeakReport:A.PeakDetectHorizontal] Running Loop=1 2023-02-23T19:59:11.391Z,1677182351.391 [Science:HighestOilPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2023-02-23T19:59:11.391Z,1677182351.391 [Science:PeakDetectFDOM] Running Loop=1 2023-02-23T19:59:11.391Z,1677182351.391 [Science:PeakDetectFDOM](DEBUG): Aggregate::initialize Science:PeakDetectFDOM 2023-02-23T19:59:11.404Z,1677182351.404 [Science:PeakDetectFDOM:A.PeakDetectVsDepth] Running Loop=1 2023-02-23T19:59:11.404Z,1677182351.404 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Initialize. 2023-02-23T19:59:11.424Z,1677182351.424 [Science:PeakDetectSalinity] Running Loop=1 2023-02-23T19:59:11.424Z,1677182351.424 [Science:PeakDetectSalinity](DEBUG): Aggregate::initialize Science:PeakDetectSalinity 2023-02-23T19:59:11.424Z,1677182351.424 [Science:PeakDetectSalinity:A.PeakDetectVsDepth] Running Loop=1 2023-02-23T19:59:11.425Z,1677182351.425 [Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Initialize. 2023-02-23T19:59:11.426Z,1677182351.426 [Science:HighestSaltPeakReport] Running Loop=1 2023-02-23T19:59:11.426Z,1677182351.426 [Science:HighestSaltPeakReport](DEBUG): Aggregate::initialize Science:HighestSaltPeakReport 2023-02-23T19:59:11.426Z,1677182351.426 [Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Running Loop=1 2023-02-23T19:59:11.426Z,1677182351.426 [Science:HighestSaltPeakReport:A.PeakDetectHorizontal](INFO): Initialize. 2023-02-23T19:59:11.427Z,1677182351.427 [Science:OceanCurrent] Running Loop=1 2023-02-23T19:59:11.427Z,1677182351.427 [Science:OceanCurrent](DEBUG): Aggregate::initialize Science:OceanCurrent 2023-02-23T19:59:11.427Z,1677182351.427 [Science:OceanCurrent:A.] Running Loop=1 2023-02-23T19:59:11.427Z,1677182351.427 [Science:OceanCurrent:A.](INFO): Initializing CurrentEstimator. 2023-02-23T19:59:11.440Z,1677182351.440 [Science:HighestSaltPeakReport] Stopped 2023-02-23T19:59:11.440Z,1677182351.440 [Science:HighestSaltPeakReport](DEBUG): Aggregate::uninitialize Science:HighestSaltPeakReport 2023-02-23T19:59:11.440Z,1677182351.440 [Science:HighestSaltPeakReport:A.PeakDetectHorizontal] Stopped 2023-02-23T19:59:11.440Z,1677182351.440 [Science:HighestSaltPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2023-02-23T19:59:11.440Z,1677182351.440 [Science:PeakDetectSalinity] Stopped 2023-02-23T19:59:11.440Z,1677182351.440 [Science:PeakDetectSalinity](DEBUG): Aggregate::uninitialize Science:PeakDetectSalinity 2023-02-23T19:59:11.440Z,1677182351.440 [Science:PeakDetectSalinity:A.PeakDetectVsDepth] Stopped 2023-02-23T19:59:11.440Z,1677182351.440 [Science:PeakDetectSalinity:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2023-02-23T19:59:11.440Z,1677182351.440 [Science:PeakDetectFDOM] Stopped 2023-02-23T19:59:11.441Z,1677182351.441 [Science:PeakDetectFDOM](DEBUG): Aggregate::uninitialize Science:PeakDetectFDOM 2023-02-23T19:59:11.441Z,1677182351.441 [Science:PeakDetectFDOM:A.PeakDetectVsDepth] Stopped 2023-02-23T19:59:11.441Z,1677182351.441 [Science:PeakDetectFDOM:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2023-02-23T19:59:11.441Z,1677182351.441 [Science:HighestOilPeakReport] Stopped 2023-02-23T19:59:11.441Z,1677182351.441 [Science:HighestOilPeakReport](DEBUG): Aggregate::uninitialize Science:HighestOilPeakReport 2023-02-23T19:59:11.441Z,1677182351.441 [Science:HighestOilPeakReport:A.PeakDetectHorizontal] Stopped 2023-02-23T19:59:11.441Z,1677182351.441 [Science:HighestOilPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2023-02-23T19:59:11.441Z,1677182351.441 [Science:PeakDetectOil] Stopped 2023-02-23T19:59:11.441Z,1677182351.441 [Science:PeakDetectOil](DEBUG): Aggregate::uninitialize Science:PeakDetectOil 2023-02-23T19:59:11.441Z,1677182351.441 [Science:PeakDetectOil:A.PeakDetectVsDepth] Stopped 2023-02-23T19:59:11.441Z,1677182351.441 [Science:PeakDetectOil:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2023-02-23T19:59:11.441Z,1677182351.441 [Science:PeakDetectNO3] Stopped 2023-02-23T19:59:11.441Z,1677182351.441 [Science:PeakDetectNO3](DEBUG): Aggregate::uninitialize Science:PeakDetectNO3 2023-02-23T19:59:11.442Z,1677182351.442 [Science:PeakDetectNO3:A.PeakDetectVsDepth] Stopped 2023-02-23T19:59:11.442Z,1677182351.442 [Science:PeakDetectNO3:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2023-02-23T19:59:11.442Z,1677182351.442 [Science:HighestChlPeakReport] Stopped 2023-02-23T19:59:11.442Z,1677182351.442 [Science:HighestChlPeakReport](DEBUG): Aggregate::uninitialize Science:HighestChlPeakReport 2023-02-23T19:59:11.442Z,1677182351.442 [Science:HighestChlPeakReport:A.PeakDetectHorizontal] Stopped 2023-02-23T19:59:11.442Z,1677182351.442 [Science:HighestChlPeakReport:A.PeakDetectHorizontal](DEBUG): Uninitialize. 2023-02-23T19:59:11.442Z,1677182351.442 [Science:PeakDetectChl] Stopped 2023-02-23T19:59:11.442Z,1677182351.442 [Science:PeakDetectChl](DEBUG): Aggregate::uninitialize Science:PeakDetectChl 2023-02-23T19:59:11.442Z,1677182351.442 [Science:PeakDetectChl:A.PeakDetectVsDepth] Stopped 2023-02-23T19:59:11.442Z,1677182351.442 [Science:PeakDetectChl:A.PeakDetectVsDepth](DEBUG): Uninitialize. 2023-02-23T19:59:11.442Z,1677182351.442 [Science:OceanCurrent:A.] Running Loop=1 2023-02-23T19:59:11.443Z,1677182351.443 [Science:Read_Oil] Stopped 2023-02-23T19:59:11.443Z,1677182351.443 [Science:F] Stopped 2023-02-23T19:59:11.443Z,1677182351.443 [Science:E] Running Loop=1 2023-02-23T19:59:11.456Z,1677182351.456 [Science:E](DEBUG): Initialize ReadDataComponent to sense mass_concentration_of_chlorophyll_in_sea_water 2023-02-23T19:59:11.456Z,1677182351.456 [Science:D] Stopped 2023-02-23T19:59:11.456Z,1677182351.456 [Science:C] Running Loop=1 2023-02-23T19:59:11.459Z,1677182351.459 [Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_temperature 2023-02-23T19:59:11.500Z,1677182351.500 [Science:C](DEBUG): Initialize ReadDataComponent to sense CTD_Seabird.sea_water_salinity 2023-02-23T19:59:11.500Z,1677182351.500 [Science:B] Running Loop=1 2023-02-23T19:59:11.501Z,1677182351.501 [Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_temperature 2023-02-23T19:59:11.501Z,1677182351.501 [Science:B](DEBUG): Initialize ReadDataComponent to sense sea_water_salinity 2023-02-23T19:59:11.501Z,1677182351.501 [Science:A] Stopped 2023-02-23T19:59:11.774Z,1677182351.774 [WetLabsBB2FL](INFO): Powering up 2023-02-23T19:59:14.769Z,1677182354.769 [CTD_Seabird](ERROR): Failed to parse device response: 2023-02-23T19:59:27.441Z,1677182367.441 [CommandExec](IMPORTANT): got command show variable par 2023-02-23T19:59:27.593Z,1677182367.593 [CommandExec](IMPORTANT): PAR_Licor.loadControl (none) 2023-02-23T19:59:27.593Z,1677182367.593 [CommandExec](IMPORTANT): PAR_Licor.ad (none) 2023-02-23T19:59:27.593Z,1677182367.593 [CommandExec](IMPORTANT): PAR_Licor.adRes (bit) 2023-02-23T19:59:27.594Z,1677182367.594 [CommandExec](IMPORTANT): PAR_Licor.adTimeout (millisecond) 2023-02-23T19:59:27.594Z,1677182367.594 [CommandExec](IMPORTANT): PAR_Licor.adVref (volt) 2023-02-23T19:59:27.667Z,1677182367.667 [CommandExec](IMPORTANT): PAR_Licor.loadAtStartup (bool) 2023-02-23T19:59:27.672Z,1677182367.672 [CommandExec](IMPORTANT): PAR_Licor.simulateHardware (bool) 2023-02-23T19:59:27.672Z,1677182367.672 [CommandExec](IMPORTANT): PAR_Licor.adcCal (microampere_per_count) 2023-02-23T19:59:27.673Z,1677182367.673 [CommandExec](IMPORTANT): PAR_Licor.darkCount (count) 2023-02-23T19:59:27.673Z,1677182367.673 [CommandExec](IMPORTANT): PAR_Licor.maxBound (micromole_per_second_per_square_meter) 2023-02-23T19:59:27.673Z,1677182367.673 [CommandExec](IMPORTANT): PAR_Licor.maxValidPitch (degree) 2023-02-23T19:59:27.674Z,1677182367.674 [CommandExec](IMPORTANT): PAR_Licor.minBound (micromole_per_second_per_square_meter) 2023-02-23T19:59:27.674Z,1677182367.674 [CommandExec](IMPORTANT): PAR_Licor.minValidPitch (degree) 2023-02-23T19:59:27.674Z,1677182367.674 [CommandExec](IMPORTANT): PAR_Licor.multiplier (micromole_per_second_per_square_meter_per_microampere) 2023-02-23T19:59:27.675Z,1677182367.675 [CommandExec](IMPORTANT): PAR_Licor.parCal (none) 2023-02-23T19:59:27.675Z,1677182367.675 [CommandExec](IMPORTANT): PAR_Licor.serial (none) 2023-02-23T19:59:27.760Z,1677182367.760 [CommandExec](IMPORTANT): PAR_Licor.enableBroadcast (bool) 2023-02-23T19:59:27.760Z,1677182367.760 [CommandExec](IMPORTANT): PAR_Licor.component_voltage (volt) 2023-02-23T19:59:27.761Z,1677182367.761 [CommandExec](IMPORTANT): PAR_Licor.component_avgVoltage (volt) 2023-02-23T19:59:27.761Z,1677182367.761 [CommandExec](IMPORTANT): PAR_Licor.component_current (milliampere) 2023-02-23T19:59:27.761Z,1677182367.761 [CommandExec](IMPORTANT): PAR_Licor.component_avgCurrent (milliampere) 2023-02-23T19:59:27.762Z,1677182367.762 [CommandExec](IMPORTANT): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water (micromole_per_second_per_square_meter) 2023-02-23T19:59:27.762Z,1677182367.762 [CommandExec](IMPORTANT): PAR_Licor.adcCount (count) 2023-02-23T19:59:30.300Z,1677182370.300 [CommandExec](IMPORTANT): got command failComponent 2023-02-23T19:59:30.300Z,1677182370.300 [CommandExec](IMPORTANT): Failed components: 2023-02-23T19:59:30.300Z,1677182370.300 [CommandExec](IMPORTANT): No failed Components. 2023-02-23T19:59:35.087Z,1677182375.087 [CommandExec](IMPORTANT): got command show variable chlorop 2023-02-23T19:59:35.095Z,1677182375.095 [CommandExec](IMPORTANT): mass_concentration_of_chlorophyll_in_sea_water (unknown) 2023-02-23T19:59:35.294Z,1677182375.294 [CommandExec](IMPORTANT): WetLabsBB2FL.mass_concentration_of_chlorophyll_in_sea_water (microgram_per_liter) 2023-02-23T19:59:35.294Z,1677182375.294 [CommandExec](IMPORTANT): WetLabsBB2FL.bin_median_mass_concentration_of_chlorophyll_in_sea_water (microgram_per_liter) 2023-02-23T19:59:35.294Z,1677182375.294 [CommandExec](IMPORTANT): WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water (microgram_per_liter) 2023-02-23T19:59:35.295Z,1677182375.295 [CommandExec](IMPORTANT): WetLabsBB2FL.bin_variance_mass_concentration_of_chlorophyll_in_sea_water (microgram_per_liter) 2023-02-23T19:59:38.386Z,1677182378.386 [NAL9602](FAULT): GPS failed to acquire within timeout. 2023-02-23T19:59:38.386Z,1677182378.386 [NAL9602] Data Fault, FailCount= 2 2023-02-23T19:59:38.386Z,1677182378.386 [NAL9602](ERROR): Data Fault 2023-02-23T19:59:38.414Z,1677182378.414 [CBIT](ERROR): Data Fault in component: NAL9602 2023-02-23T19:59:38.794Z,1677182378.794 [NAL9602](INFO): Powering down 2023-02-23T19:59:39.659Z,1677182379.659 [CBIT](INFO): Clearing failed state for component NAL9602 2023-02-23T19:59:39.663Z,1677182379.663 [NAL9602] No Fault, FailCount= 2 2023-02-23T19:59:47.203Z,1677182387.203 [CommandExec](IMPORTANT): got command get mass_concentration_of_chlorophyll_in_sea_water 2023-02-23T19:59:47.203Z,1677182387.203 [CommandExec](FAULT): Element has no value 2023-02-23T19:59:53.176Z,1677182393.176 [CommandExec](IMPORTANT): got command show best mass_concentration_of_chlorophyll_in_sea_water 2023-02-23T19:59:53.177Z,1677182393.177 [CommandExec](IMPORTANT): mass_concentration_of_chlorophyll_in_sea_water best is null 2023-02-23T20:00:09.098Z,1677182409.098 [NAL9602](INFO): Powering up NAL9602 2023-02-23T20:00:16.250Z,1677182416.250 [CommandExec](IMPORTANT): got command get WetLabsBB2FL.mass_concentration_of_chlorophyll_in_sea_water 2023-02-23T20:00:16.251Z,1677182416.251 [CommandExec](IMPORTANT): WetLabsBB2FL.mass_concentration_of_chlorophyll_in_sea_water 0.187200 ug/l 2023-02-23T20:00:18.796Z,1677182418.796 [DataOverHttps](INFO): Sending 641 bytes from file Logs/20230223T174745/Express0038.lzma 2023-02-23T20:00:19.797Z,1677182419.797 [DataOverHttps](INFO): Moved sent file to Logs/20230223T174745/Express0038.lzma.bak 2023-02-23T20:00:19.798Z,1677182419.798 [DataOverHttps](INFO): SBD MOMSN=17488197 2023-02-23T20:00:20.028Z,1677182420.028 [NAL9602](INFO): NAL9602 initialized 2023-02-23T20:00:41.517Z,1677182441.517 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 44 2023-02-23T20:00:41.517Z,1677182441.517 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2023-02-23T20:00:41.585Z,1677182441.585 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2023-02-23T20:00:41.869Z,1677182441.869 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2023-02-23T20:00:41.869Z,1677182441.869 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 44 2023-02-23T20:00:43.266Z,1677182443.266 [CommandExec](IMPORTANT): got command get DAT.loadAtStartup 2023-02-23T20:00:43.266Z,1677182443.266 [CommandExec](IMPORTANT): DAT.loadAtStartup 0 bool 2023-02-23T20:01:54.963Z,1677182514.963 [DVL_micro](ERROR): only read 0 of 1 data item for BIT error 2023-02-23T20:01:54.963Z,1677182514.963 [DVL_micro](ERROR): Failed to parse: :TS,00000000000000,35.0,+220,1489.0,000 2023-02-23T20:02:10.824Z,1677182530.824 [CommandExec](IMPORTANT): got command failComponent 2023-02-23T20:02:10.824Z,1677182530.824 [CommandExec](IMPORTANT): Failed components: 2023-02-23T20:02:10.825Z,1677182530.825 [CommandExec](IMPORTANT): No failed Components. 2023-02-23T20:02:12.281Z,1677182532.281 [CommandExec](IMPORTANT): got command stop 2023-02-23T20:02:12.281Z,1677182532.281 [CommandExec](IMPORTANT): Scheduling is paused 2023-02-23T20:02:12.282Z,1677182532.282 [Supervisor](INFO): Stop Mission called by CommandExec::commandStop 2023-02-23T20:02:12.342Z,1677182532.342 [MissionManager](INFO): MissionManager is completed. 2023-02-23T20:02:12.342Z,1677182532.342 [MissionManager](INFO): Uninitializing Mission Science 2023-02-23T20:02:12.342Z,1677182532.342 [Science] Stopped 2023-02-23T20:02:12.342Z,1677182532.342 [Science](DEBUG): Aggregate::uninitialize Science 2023-02-23T20:02:12.342Z,1677182532.342 [Science:B] Stopped 2023-02-23T20:02:12.342Z,1677182532.342 [Science:C] Stopped 2023-02-23T20:02:12.342Z,1677182532.342 [Science:E] Stopped 2023-02-23T20:02:12.342Z,1677182532.342 [Science:OceanCurrent] Stopped 2023-02-23T20:02:12.342Z,1677182532.342 [Science:OceanCurrent](DEBUG): Aggregate::uninitialize Science:OceanCurrent 2023-02-23T20:02:12.342Z,1677182532.342 [Science:OceanCurrent:A.] Stopped 2023-02-23T20:02:12.872Z,1677182532.872 [WetLabsBB2FL](INFO): Powering down 2023-02-23T20:02:12.907Z,1677182532.907 [MissionManager](IMPORTANT): Started mission Default 2023-02-23T20:02:12.915Z,1677182532.915 [Default] Running Loop=1 2023-02-23T20:02:12.916Z,1677182532.916 [Default](DEBUG): Aggregate::initialize Default 2023-02-23T20:02:12.916Z,1677182532.916 [Default:B.GoToSurface] Running Loop=1 2023-02-23T20:02:12.916Z,1677182532.916 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2023-02-23T20:02:12.916Z,1677182532.916 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2023-02-23T20:02:12.916Z,1677182532.916 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2023-02-23T20:02:12.917Z,1677182532.917 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2023-02-23T20:02:12.917Z,1677182532.917 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2023-02-23T20:02:12.918Z,1677182532.918 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2023-02-23T20:02:12.918Z,1677182532.918 [Default:A.Wait] Running Loop=1 2023-02-23T20:02:12.918Z,1677182532.918 [Default:A.Wait](DEBUG): Initialize Wait Component. 2023-02-23T20:02:26.121Z,1677182546.121 [Default:A.Wait](INFO): Done Waiting. 2023-02-23T20:02:26.121Z,1677182546.121 [Default:A.Wait] Stopped 2023-02-23T20:02:26.121Z,1677182546.121 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2023-02-23T20:02:26.517Z,1677182546.517 [Default:CheckIn] Running Loop=1 2023-02-23T20:02:26.517Z,1677182546.517 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2023-02-23T20:02:26.517Z,1677182546.517 [Default:CheckIn:Read_GPS] Running Loop=1 2023-02-23T20:02:44.748Z,1677182564.748 [CommandExec](IMPORTANT): got command quit 2023-02-23T20:02:45.800Z,1677182565.800 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-23T20:02:45.800Z,1677182565.800 [CommandExec](INFO): Uninitializing the command executive. 2023-02-23T20:02:45.800Z,1677182565.800 [CommandExec](INFO): Uninitializing the command scheduler. 2023-02-23T20:02:45.800Z,1677182565.800 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:45.911Z,1677182565.911 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2023-02-23T20:02:45.912Z,1677182565.912 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2023-02-23T20:02:45.912Z,1677182565.912 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:45.913Z,1677182565.913 [NavChartDb](INFO): Join timeout helper Thread ID is 2288 2023-02-23T20:02:46.168Z,1677182566.168 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-23T20:02:46.168Z,1677182566.168 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:46.184Z,1677182566.184 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2023-02-23T20:02:46.184Z,1677182566.184 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:46.184Z,1677182566.184 [Radio_Surface](INFO): Join timeout helper Thread ID is 2289 2023-02-23T20:02:46.571Z,1677182566.571 [Radio_Surface](INFO): Powering down 2023-02-23T20:02:46.572Z,1677182566.572 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-23T20:02:46.573Z,1677182566.573 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:46.575Z,1677182566.575 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2023-02-23T20:02:46.576Z,1677182566.576 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:46.576Z,1677182566.576 [Onboard](INFO): Join timeout helper Thread ID is 2290 2023-02-23T20:02:49.720Z,1677182569.720 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-23T20:02:49.720Z,1677182569.720 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:49.729Z,1677182569.729 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2023-02-23T20:02:49.729Z,1677182569.729 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:49.729Z,1677182569.729 [DataOverHttps](INFO): Join timeout helper Thread ID is 2291 2023-02-23T20:02:50.403Z,1677182570.403 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-23T20:02:50.407Z,1677182570.407 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:50.407Z,1677182570.407 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2023-02-23T20:02:50.408Z,1677182570.408 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:50.408Z,1677182570.408 [BackseatComponent](INFO): Join timeout helper Thread ID is 2292 2023-02-23T20:02:50.440Z,1677182570.440 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-23T20:02:50.440Z,1677182570.440 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:50.453Z,1677182570.453 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2023-02-23T20:02:50.453Z,1677182570.453 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:50.453Z,1677182570.453 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 2293 2023-02-23T20:02:50.592Z,1677182570.592 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-23T20:02:50.592Z,1677182570.592 [WetLabsBB2FL](INFO): Powering down 2023-02-23T20:02:50.593Z,1677182570.593 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:50.612Z,1677182570.612 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2023-02-23T20:02:50.612Z,1677182570.612 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:50.613Z,1677182570.613 [CTD_Seabird](INFO): Join timeout helper Thread ID is 2294 2023-02-23T20:02:50.644Z,1677182570.644 [CTD_Seabird](INFO): Powering down 2023-02-23T20:02:50.656Z,1677182570.656 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-23T20:02:50.656Z,1677182570.656 [CTD_Seabird](INFO): Powering down 2023-02-23T20:02:50.668Z,1677182570.668 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:50.680Z,1677182570.680 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2023-02-23T20:02:50.681Z,1677182570.681 [logger ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:50.681Z,1677182570.681 [logger](INFO): Join timeout helper Thread ID is 2295 2023-02-23T20:02:50.692Z,1677182570.692 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-23T20:02:50.693Z,1677182570.693 [logger ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:50.712Z,1677182570.712 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2023-02-23T20:02:50.712Z,1677182570.712 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:50.713Z,1677182570.713 [CommandLine](INFO): Join timeout helper Thread ID is 2296 2023-02-23T20:02:50.756Z,1677182570.756 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-23T20:02:50.756Z,1677182570.756 [CommandLine ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:50.764Z,1677182570.764 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2023-02-23T20:02:50.764Z,1677182570.764 [CommandExec ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:50.765Z,1677182570.765 [CommandExec](INFO): Join timeout helper Thread ID is 2297 2023-02-23T20:02:50.766Z,1677182570.766 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2023-02-23T20:02:50.766Z,1677182570.766 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:50.767Z,1677182570.767 [controlThread](INFO): Join timeout helper Thread ID is 2298 2023-02-23T20:02:50.801Z,1677182570.801 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2023-02-23T20:02:50.801Z,1677182570.801 [controlThread](DEBUG): Uninitializing ControlThread 2023-02-23T20:02:50.802Z,1677182570.802 [AHRS_M2](INFO): Powering down 2023-02-23T20:02:50.944Z,1677182570.944 [DVL_micro](INFO): Powering down 2023-02-23T20:02:50.945Z,1677182570.945 [NAL9602](INFO): Powering down 2023-02-23T20:02:50.946Z,1677182570.946 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2023-02-23T20:02:50.947Z,1677182570.947 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2023-02-23T20:02:50.948Z,1677182570.948 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2023-02-23T20:02:50.948Z,1677182570.948 [MissionManager](INFO): Uninitializing Mission Default 2023-02-23T20:02:50.948Z,1677182570.948 [Default] Stopped 2023-02-23T20:02:50.948Z,1677182570.948 [Default](DEBUG): Aggregate::uninitialize Default 2023-02-23T20:02:50.948Z,1677182570.948 [Default:B.GoToSurface] Stopped 2023-02-23T20:02:50.949Z,1677182570.949 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2023-02-23T20:02:50.949Z,1677182570.949 [Default:CheckIn] Stopped 2023-02-23T20:02:50.949Z,1677182570.949 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2023-02-23T20:02:50.949Z,1677182570.949 [Default:CheckIn:Read_GPS] Stopped 2023-02-23T20:02:50.951Z,1677182570.951 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2023-02-23T20:02:50.952Z,1677182570.952 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2023-02-23T20:02:50.952Z,1677182570.952 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2023-02-23T20:02:50.952Z,1677182570.952 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2023-02-23T20:02:50.952Z,1677182570.952 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2023-02-23T20:02:50.953Z,1677182570.953 [BuoyancyServo](INFO): Powering down 2023-02-23T20:02:50.968Z,1677182570.968 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2023-02-23T20:02:50.968Z,1677182570.968 [ElevatorServo](INFO): Powering down 2023-02-23T20:02:50.969Z,1677182570.969 [MassServo](DEBUG): Uninitialize Mass Servo. 2023-02-23T20:02:50.969Z,1677182570.969 [MassServo](INFO): Powering down 2023-02-23T20:02:50.970Z,1677182570.970 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2023-02-23T20:02:50.970Z,1677182570.970 [RudderServo](INFO): Powering down 2023-02-23T20:02:50.970Z,1677182570.970 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 2023-02-23T20:02:50.971Z,1677182570.971 [ThrusterHE](INFO): Powering down 2023-02-23T20:02:50.971Z,1677182570.971 [SBIT](DEBUG): Uninitialize SBIT Component. 2023-02-23T20:02:50.972Z,1677182570.972 [IBIT](DEBUG): Uninitialize IBIT Component. 2023-02-23T20:02:50.972Z,1677182570.972 [CBIT](DEBUG): Uninitialize CBIT Component. 2023-02-23T20:02:50.972Z,1677182570.972 [CBIT](DEBUG): Powering off loads. 2023-02-23T20:02:50.983Z,1677182570.983 [CBIT](DEBUG): Disabling WDT. 2023-02-23T20:02:50.995Z,1677182570.995 [CBIT](DEBUG): Opening all GF detection circuits. 2023-02-23T20:02:50.996Z,1677182570.996 [controlThread ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:51.036Z,1677182571.036 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:51.042Z,1677182571.042 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:51.075Z,1677182571.075 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:51.077Z,1677182571.077 [Onboard ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:51.084Z,1677182571.084 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:51.128Z,1677182571.128 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:51.184Z,1677182571.184 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2023-02-23T20:02:51.248Z,1677182571.248 [logger ThreadHandler](INFO): Thread cancelled.