2021-10-21T21:26:48.034Z,1634851608.034 [Supervisor](DEBUG): Initializing supervisor. 2021-10-21T21:26:48.038Z,1634851608.038 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 2021-10-21T21:26:48.039Z,1634851608.039 [SyncHandler](INFO): Protected caller Thread ID is 834 2021-10-21T21:26:48.039Z,1634851608.039 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 2021-10-21T21:26:48.040Z,1634851608.040 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 2021-10-21T21:26:48.040Z,1634851608.040 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 835 2021-10-21T21:26:48.044Z,1634851608.044 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 2021-10-21T21:26:48.062Z,1634851608.062 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 2021-10-21T21:26:48.063Z,1634851608.063 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 2021-10-21T21:26:48.064Z,1634851608.064 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 836 2021-10-21T21:26:48.068Z,1634851608.068 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 2021-10-21T21:26:48.069Z,1634851608.069 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 2021-10-21T21:26:48.069Z,1634851608.069 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 837 2021-10-21T21:26:48.071Z,1634851608.071 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 2021-10-21T21:26:48.072Z,1634851608.072 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 2021-10-21T21:26:48.073Z,1634851608.073 [logger ThreadHandler](INFO): Protected caller Thread ID is 838 2021-10-21T21:26:48.077Z,1634851608.077 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 2021-10-21T21:26:48.077Z,1634851608.077 [Supervisor](INFO): Looking for Config files in directory: Config/ 2021-10-21T21:26:48.081Z,1634851608.081 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 2021-10-21T21:26:48.499Z,1634851608.499 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 2021-10-21T21:26:48.501Z,1634851608.501 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 2021-10-21T21:26:48.645Z,1634851608.645 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 2021-10-21T21:26:48.646Z,1634851608.646 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 2021-10-21T21:26:48.726Z,1634851608.726 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 2021-10-21T21:26:48.945Z,1634851608.945 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 2021-10-21T21:26:48.945Z,1634851608.945 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 2021-10-21T21:26:49.025Z,1634851609.025 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 2021-10-21T21:26:49.120Z,1634851609.120 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 2021-10-21T21:26:49.122Z,1634851609.122 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 2021-10-21T21:26:49.462Z,1634851609.462 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 2021-10-21T21:26:49.463Z,1634851609.463 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 2021-10-21T21:26:49.586Z,1634851609.586 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 2021-10-21T21:26:49.587Z,1634851609.587 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 2021-10-21T21:26:50.098Z,1634851610.098 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 2021-10-21T21:26:50.099Z,1634851610.099 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 2021-10-21T21:26:50.284Z,1634851610.284 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 2021-10-21T21:26:50.286Z,1634851610.286 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 2021-10-21T21:26:50.651Z,1634851610.651 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 2021-10-21T21:26:50.652Z,1634851610.652 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 2021-10-21T21:26:50.886Z,1634851610.886 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 2021-10-21T21:26:50.888Z,1634851610.888 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 2021-10-21T21:26:50.996Z,1634851610.996 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 2021-10-21T21:26:50.997Z,1634851610.997 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 2021-10-21T21:26:51.652Z,1634851611.652 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 2021-10-21T21:26:52.363Z,1634851612.363 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 2021-10-21T21:26:53.081Z,1634851613.081 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 2021-10-21T21:26:53.083Z,1634851613.083 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 2021-10-21T21:26:53.288Z,1634851613.288 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 2021-10-21T21:26:53.290Z,1634851613.290 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-triton/ 2021-10-21T21:26:53.292Z,1634851613.292 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/vehicle.cfg 2021-10-21T21:26:53.483Z,1634851613.483 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/secure.cfg 2021-10-21T21:26:53.566Z,1634851613.566 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Science.cfg 2021-10-21T21:26:53.699Z,1634851613.699 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Simulator.cfg 2021-10-21T21:26:53.785Z,1634851613.785 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Battery.cfg 2021-10-21T21:26:54.042Z,1634851614.042 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 2021-10-21T21:26:54.043Z,1634851614.043 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/logger.cfg 2021-10-21T21:26:54.147Z,1634851614.147 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Servo.cfg 2021-10-21T21:26:54.258Z,1634851614.258 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Navigation.cfg 2021-10-21T21:26:54.352Z,1634851614.352 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Sensor.cfg 2021-10-21T21:26:54.493Z,1634851614.493 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/Control.cfg 2021-10-21T21:26:54.592Z,1634851614.592 [Supervisor](INFO): Opening Config file at: Config/lrauv-triton/BIT.cfg 2021-10-21T21:26:54.684Z,1634851614.684 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 2021-10-21T21:26:54.703Z,1634851614.703 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 2021-10-21T21:26:54.720Z,1634851614.720 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 2021-10-21T21:26:54.721Z,1634851614.721 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 2021-10-21T21:26:54.840Z,1634851614.840 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 2021-10-21T21:26:54.842Z,1634851614.842 [Module Loader](DEBUG): Loading Module at Modules/Control.so 2021-10-21T21:26:54.911Z,1634851614.911 [VerticalControl](DEBUG): Construct VerticalControl. 2021-10-21T21:26:54.973Z,1634851614.973 [VerticalControl] Loaded 2021-10-21T21:26:54.973Z,1634851614.973 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 2021-10-21T21:26:54.976Z,1634851614.976 [HorizontalControl](DEBUG): Construct HorizontalControl. 2021-10-21T21:26:55.015Z,1634851615.015 [HorizontalControl] Loaded 2021-10-21T21:26:55.015Z,1634851615.015 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 2021-10-21T21:26:55.017Z,1634851615.017 [SpeedControl](DEBUG): Construct SpeedControl. 2021-10-21T21:26:55.020Z,1634851615.020 [SpeedControl] Loaded 2021-10-21T21:26:55.021Z,1634851615.021 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 2021-10-21T21:26:55.023Z,1634851615.023 [LoopControl](DEBUG): Construct LoopControl. 2021-10-21T21:26:55.024Z,1634851615.024 [LoopControl] Loaded 2021-10-21T21:26:55.024Z,1634851615.024 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 2021-10-21T21:26:55.024Z,1634851615.024 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 2021-10-21T21:26:55.026Z,1634851615.026 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 2021-10-21T21:26:55.204Z,1634851615.204 [BuoyancyServo] Loaded 2021-10-21T21:26:55.204Z,1634851615.204 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 2021-10-21T21:26:55.223Z,1634851615.223 [ElevatorServo] Loaded 2021-10-21T21:26:55.224Z,1634851615.224 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 2021-10-21T21:26:55.242Z,1634851615.242 [MassServo] Loaded 2021-10-21T21:26:55.242Z,1634851615.242 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 2021-10-21T21:26:55.260Z,1634851615.260 [RudderServo] Loaded 2021-10-21T21:26:55.260Z,1634851615.260 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 2021-10-21T21:26:55.261Z,1634851615.260 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 2021-10-21T21:26:55.261Z,1634851615.261 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 2021-10-21T21:26:55.322Z,1634851615.322 [DepthRateCalculator] Loaded 2021-10-21T21:26:55.322Z,1634851615.322 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 2021-10-21T21:26:55.327Z,1634851615.327 [PitchRateCalculator] Loaded 2021-10-21T21:26:55.327Z,1634851615.327 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 2021-10-21T21:26:55.337Z,1634851615.337 [SpeedCalculator] Loaded 2021-10-21T21:26:55.337Z,1634851615.337 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 2021-10-21T21:26:55.351Z,1634851615.351 [TempGradientCalculator] Loaded 2021-10-21T21:26:55.351Z,1634851615.351 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread. 2021-10-21T21:26:55.356Z,1634851615.356 [YawRateCalculator] Loaded 2021-10-21T21:26:55.356Z,1634851615.356 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 2021-10-21T21:26:55.373Z,1634851615.373 [ElevatorOffsetCalculator] Loaded 2021-10-21T21:26:55.373Z,1634851615.373 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 2021-10-21T21:26:55.374Z,1634851615.374 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 2021-10-21T21:26:55.374Z,1634851615.374 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 2021-10-21T21:26:55.472Z,1634851615.472 [DeadReckonUsingMultipleVelocitySources] Loaded 2021-10-21T21:26:55.473Z,1634851615.473 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 2021-10-21T21:26:55.486Z,1634851615.486 [NavChart] Loaded 2021-10-21T21:26:55.486Z,1634851615.486 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 2021-10-21T21:26:55.492Z,1634851615.492 [UniversalFixResidualReporter] Loaded 2021-10-21T21:26:55.492Z,1634851615.492 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 2021-10-21T21:26:55.493Z,1634851615.493 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 2021-10-21T21:26:55.493Z,1634851615.493 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 2021-10-21T21:26:56.174Z,1634851616.174 [AHRS_M2] Loaded 2021-10-21T21:26:56.174Z,1634851616.174 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 2021-10-21T21:26:56.419Z,1634851616.419 [BackseatComponent] Loaded 2021-10-21T21:26:56.419Z,1634851616.419 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread. 2021-10-21T21:26:56.420Z,1634851616.420 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 4089D4E0 2021-10-21T21:26:56.420Z,1634851616.420 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 920 2021-10-21T21:26:56.423Z,1634851616.423 [LcmUniversalReporter] Loaded 2021-10-21T21:26:56.423Z,1634851616.423 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread. 2021-10-21T21:26:57.295Z,1634851617.295 [BPC1] Loaded 2021-10-21T21:26:57.322Z,1634851617.322 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 2021-10-21T21:26:57.666Z,1634851617.666 [DataOverHttps] Loaded 2021-10-21T21:26:57.667Z,1634851617.667 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 2021-10-21T21:26:57.668Z,1634851617.668 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408CD4E0 2021-10-21T21:26:57.668Z,1634851617.668 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 921 2021-10-21T21:26:57.688Z,1634851617.688 [Depth_Keller] Loaded 2021-10-21T21:26:57.688Z,1634851617.688 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 2021-10-21T21:26:57.734Z,1634851617.734 [DropWeight] Loaded 2021-10-21T21:26:57.735Z,1634851617.735 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 2021-10-21T21:26:57.861Z,1634851617.861 [NAL9602] Loaded 2021-10-21T21:26:57.862Z,1634851617.862 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 2021-10-21T21:26:57.890Z,1634851617.890 [Onboard] Loaded 2021-10-21T21:26:57.891Z,1634851617.891 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 2021-10-21T21:26:57.892Z,1634851617.892 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408FD4E0 2021-10-21T21:26:57.892Z,1634851617.892 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 922 2021-10-21T21:26:57.905Z,1634851617.905 [Power24vConverter] Loaded 2021-10-21T21:26:57.905Z,1634851617.905 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 2021-10-21T21:26:57.918Z,1634851617.918 [Radio_Surface] Loaded 2021-10-21T21:26:57.918Z,1634851617.918 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 2021-10-21T21:26:57.919Z,1634851617.919 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 4092D4E0 2021-10-21T21:26:57.919Z,1634851617.919 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 923 2021-10-21T21:26:57.921Z,1634851617.921 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 2021-10-21T21:26:57.921Z,1634851617.921 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 2021-10-21T21:26:58.004Z,1634851618.004 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 2021-10-21T21:26:58.004Z,1634851618.004 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 2021-10-21T21:26:58.138Z,1634851618.138 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 2021-10-21T21:26:58.139Z,1634851618.139 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 2021-10-21T21:26:58.181Z,1634851618.181 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 2021-10-21T21:26:58.182Z,1634851618.182 [Module Loader](DEBUG): Loading Module at Modules/Science.so 2021-10-21T21:26:58.402Z,1634851618.402 [CTD_Seabird] Loaded 2021-10-21T21:26:58.402Z,1634851618.402 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 2021-10-21T21:26:58.403Z,1634851618.403 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A4D4E0 2021-10-21T21:26:58.403Z,1634851618.403 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 924 2021-10-21T21:26:58.435Z,1634851618.435 [ESPComponent] Loaded 2021-10-21T21:26:58.436Z,1634851618.436 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 2021-10-21T21:26:58.455Z,1634851618.455 [PAR_Licor] Loaded 2021-10-21T21:26:58.455Z,1634851618.455 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 2021-10-21T21:26:58.486Z,1634851618.486 [WetLabsBB2FL] Loaded 2021-10-21T21:26:58.487Z,1634851618.487 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 2021-10-21T21:26:58.488Z,1634851618.488 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A7D4E0 2021-10-21T21:26:58.488Z,1634851618.488 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 925 2021-10-21T21:26:58.489Z,1634851618.489 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 2021-10-21T21:26:58.490Z,1634851618.490 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 2021-10-21T21:26:58.864Z,1634851618.864 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 2021-10-21T21:26:58.864Z,1634851618.864 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 2021-10-21T21:26:59.038Z,1634851619.038 [SBIT](DEBUG): Construct Startup Built In Test. 2021-10-21T21:26:59.047Z,1634851619.047 [SBIT] Loaded 2021-10-21T21:26:59.048Z,1634851619.048 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 2021-10-21T21:26:59.050Z,1634851619.050 [IBIT](DEBUG): Construct Initiated Built In Test. 2021-10-21T21:26:59.064Z,1634851619.064 [IBIT] Loaded 2021-10-21T21:26:59.064Z,1634851619.064 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 2021-10-21T21:26:59.070Z,1634851619.070 [CBIT](DEBUG): Construct Continuous Built In Test. 2021-10-21T21:26:59.171Z,1634851619.171 [CBIT] Loaded 2021-10-21T21:26:59.172Z,1634851619.172 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 2021-10-21T21:26:59.172Z,1634851619.172 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 2021-10-21T21:26:59.178Z,1634851619.178 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 2021-10-21T21:26:59.181Z,1634851619.181 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 2021-10-21T21:26:59.192Z,1634851619.192 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 2021-10-21T21:26:59.193Z,1634851619.193 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40B644E0 2021-10-21T21:26:59.193Z,1634851619.193 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 926 2021-10-21T21:26:59.198Z,1634851619.198 [Supervisor](INFO): Main Thread ID is 830 2021-10-21T21:26:59.198Z,1634851619.198 [Supervisor](DEBUG): Running supervisor. 2021-10-21T21:26:59.199Z,1634851619.199 [CommandExec ThreadHandler](INFO): Handler Thread ID is 927 2021-10-21T21:26:59.199Z,1634851619.199 [CommandExec](INFO): Initializing the command executive. 2021-10-21T21:26:59.201Z,1634851619.201 [CommandLine ThreadHandler](INFO): Handler Thread ID is 928 2021-10-21T21:26:59.203Z,1634851619.203 [controlThread ThreadHandler](INFO): Handler Thread ID is 929 2021-10-21T21:26:59.203Z,1634851619.203 [controlThread](DEBUG): Initializing ControlThread 2021-10-21T21:26:59.204Z,1634851619.204 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 2021-10-21T21:26:59.206Z,1634851619.206 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 2021-10-21T21:26:59.207Z,1634851619.207 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 2021-10-21T21:26:59.207Z,1634851619.207 [LoopControl](DEBUG): Initialize LoopControlComponent. 2021-10-21T21:26:59.209Z,1634851619.209 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 2021-10-21T21:26:59.209Z,1634851619.209 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 2021-10-21T21:26:59.209Z,1634851619.209 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 2021-10-21T21:26:59.210Z,1634851619.210 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator. 2021-10-21T21:26:59.210Z,1634851619.210 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 2021-10-21T21:26:59.211Z,1634851619.211 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 2021-10-21T21:26:59.212Z,1634851619.212 [NavChart](DEBUG): Initialize NavChart Navigation. 2021-10-21T21:26:59.212Z,1634851619.212 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 2021-10-21T21:26:59.220Z,1634851619.220 [SBIT](INFO): Initialize SBIT Component. 2021-10-21T21:26:59.221Z,1634851619.221 [SBIT](IMPORTANT): git: 2021-10-07-16-ge48442123 2021-10-21T21:26:59.221Z,1634851619.221 [SBIT](INFO): git hash: e484421233d67fc108ee685adc86a9444d7afb00 2021-10-21T21:26:59.221Z,1634851619.221 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 2021-10-21T21:26:59.222Z,1634851619.222 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018 Kernel Reported: #1 PREEMPT Wed Mar 17 08:23:48 PDT 2021 2021-10-21T21:26:59.224Z,1634851619.224 [SBIT](INFO): Beginning SBIT in 57.000000 seconds. 2021-10-21T21:26:59.224Z,1634851619.224 [IBIT](INFO): Initialize IBIT Component. 2021-10-21T21:26:59.225Z,1634851619.225 [CBIT](DEBUG): Initialize CBIT Component. 2021-10-21T21:26:59.226Z,1634851619.226 [logger ThreadHandler](INFO): Handler Thread ID is 930 2021-10-21T21:26:59.236Z,1634851619.236 [CBIT](DEBUG): Initialized mux pins. 2021-10-21T21:26:59.236Z,1634851619.236 [CBIT](DEBUG): Initializing the watchdog timer. 2021-10-21T21:26:59.244Z,1634851619.244 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 931 2021-10-21T21:26:59.256Z,1634851619.256 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 932 2021-10-21T21:26:59.257Z,1634851619.257 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 2021-10-21T21:26:59.260Z,1634851619.260 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 2021-10-21T21:26:59.260Z,1634851619.260 [CBIT](DEBUG): Initializing heartbeat. 2021-10-21T21:26:59.268Z,1634851619.268 [Onboard ThreadHandler](INFO): Handler Thread ID is 933 2021-10-21T21:26:59.286Z,1634851619.286 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 934 2021-10-21T21:26:59.305Z,1634851619.305 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 935 2021-10-21T21:26:59.305Z,1634851619.305 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 2021-10-21T21:26:59.309Z,1634851619.309 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 937 2021-10-21T21:26:59.312Z,1634851619.312 [WetLabsBB2FL](INFO): Powering up 2021-10-21T21:26:59.313Z,1634851619.313 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 939 2021-10-21T21:26:59.322Z,1634851619.322 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000 2021-10-21T21:26:59.322Z,1634851619.322 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000 2021-10-21T21:26:59.323Z,1634851619.323 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000 2021-10-21T21:26:59.323Z,1634851619.323 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000 2021-10-21T21:26:59.323Z,1634851619.323 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000 2021-10-21T21:26:59.323Z,1634851619.323 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000 2021-10-21T21:26:59.323Z,1634851619.323 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000 2021-10-21T21:26:59.324Z,1634851619.324 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000 2021-10-21T21:26:59.324Z,1634851619.324 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000 2021-10-21T21:26:59.324Z,1634851619.324 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000 2021-10-21T21:26:59.324Z,1634851619.324 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000 2021-10-21T21:26:59.325Z,1634851619.325 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000 2021-10-21T21:26:59.325Z,1634851619.325 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000 2021-10-21T21:26:59.325Z,1634851619.325 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000 2021-10-21T21:26:59.325Z,1634851619.325 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000 2021-10-21T21:26:59.325Z,1634851619.325 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000 2021-10-21T21:26:59.332Z,1634851619.332 [CBIT](DEBUG): Deactivating GF circuits. 2021-10-21T21:26:59.332Z,1634851619.332 [CBIT](DEBUG): Deactivating emergency mode. 2021-10-21T21:26:59.368Z,1634851619.368 [CBIT](DEBUG): Backplane powered. 2021-10-21T21:26:59.369Z,1634851619.369 [MissionManager](INFO): Loading Mission: Missions/Startup.xml 2021-10-21T21:26:59.404Z,1634851619.404 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 2021-10-21T21:26:59.435Z,1634851619.435 [MissionManager](DEBUG): 2021-10-21T21:26:59.449Z,1634851619.449 [MissionManager](INFO): Loading Mission: Missions/Default.xml 2021-10-21T21:26:59.537Z,1634851619.537 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 2021-10-21T21:26:59.539Z,1634851619.539 [Default:A.Wait](DEBUG): Construct Wait. 2021-10-21T21:26:59.541Z,1634851619.541 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 2021-10-21T21:26:59.585Z,1634851619.585 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 2021-10-21T21:26:59.616Z,1634851619.616 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 2021-10-21T21:26:59.622Z,1634851619.622 [Default:E.Execute](DEBUG): Construct Execute. 2021-10-21T21:26:59.642Z,1634851619.642 [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 2021-10-21T21:26:59.647Z,1634851619.647 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2021-10-21T21:26:59.670Z,1634851619.670 [AHRS_M2](DEBUG): Initializing AHRS_M2. 2021-10-21T21:26:59.692Z,1634851619.692 [Radio_Surface](INFO): Powering up 2021-10-21T21:26:59.830Z,1634851619.830 [Power24vConverter](INFO): Powering up. 2021-10-21T21:26:59.922Z,1634851619.922 [BuoyancyServo](DEBUG): Initializing EZServoServo. 2021-10-21T21:26:59.929Z,1634851619.929 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 2021-10-21T21:26:59.930Z,1634851619.930 [ElevatorServo](DEBUG): Initializing EZServoServo. 2021-10-21T21:26:59.936Z,1634851619.936 [ElevatorServo](DEBUG): Initializing ElevatorServo. 2021-10-21T21:26:59.937Z,1634851619.937 [MassServo](DEBUG): Initializing EZServoServo. 2021-10-21T21:26:59.944Z,1634851619.944 [MassServo](DEBUG): Initializing MassServo. 2021-10-21T21:26:59.945Z,1634851619.945 [RudderServo](DEBUG): Initializing EZServoServo. 2021-10-21T21:26:59.952Z,1634851619.952 [RudderServo](DEBUG): Initializing RudderServo. 2021-10-21T21:27:00.077Z,1634851620.077 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2021-10-21T21:27:00.077Z,1634851620.077 [DropWeight] Hardware Fault, FailCount= 1 2021-10-21T21:27:00.077Z,1634851620.077 [DropWeight](ERROR): Hardware Fault 2021-10-21T21:27:00.124Z,1634851620.124 [CommandExec](FAULT): Scheduling is paused 2021-10-21T21:27:00.124Z,1634851620.124 [CBIT](INFO): Critical error at 20211021T212700 2021-10-21T21:27:00.124Z,1634851620.124 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 2021-10-21T21:27:00.127Z,1634851620.127 [CBIT](ERROR): Hardware Fault in component: DropWeight 2021-10-21T21:27:00.127Z,1634851620.127 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2021-10-21T21:27:00.808Z,1634851620.808 [RudderServo](ERROR): Rudder initialization uart error serial timeout 2021-10-21T21:27:00.808Z,1634851620.808 [RudderServo](FAULT): Rudder failed to initialize 2021-10-21T21:27:00.808Z,1634851620.808 [RudderServo] Communications Fault, FailCount= 1 2021-10-21T21:27:00.808Z,1634851620.808 [RudderServo](ERROR): Communications Fault 2021-10-21T21:27:00.810Z,1634851620.810 [CBIT](INFO): Critical error at 20211021T212700 2021-10-21T21:27:00.813Z,1634851620.813 [CBIT](ERROR): Communications Fault in component: RudderServo 2021-10-21T21:27:01.009Z,1634851621.009 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2021-10-21T21:27:01.009Z,1634851621.009 [RudderServo](INFO): Powering down 2021-10-21T21:27:01.420Z,1634851621.420 [WetLabsBB2FL](INFO): Powering down 2021-10-21T21:27:01.697Z,1634851621.697 [RudderServo](DEBUG): Initializing EZServoServo. 2021-10-21T21:27:01.817Z,1634851621.817 [RudderServo](DEBUG): Initializing RudderServo. 2021-10-21T21:27:01.821Z,1634851621.821 [CBIT](INFO): Clearing failed state for component RudderServo 2021-10-21T21:27:01.821Z,1634851621.821 [RudderServo] No Fault, FailCount= 1 2021-10-21T21:27:09.445Z,1634851629.445 [CBIT](CRITICAL): Environmental Failure. Press:14.886243 PSI. Humidity:56%. Temp:22 C. ABORTING MISSION 2021-10-21T21:27:09.830Z,1634851629.830 [CBIT](INFO): Critical error at 20211021T212709 2021-10-21T21:27:27.937Z,1634851647.937 [NAL9602](INFO): Powering up NAL9602 2021-10-21T21:27:29.337Z,1634851649.337 [CommandExec](IMPORTANT): got command show variable par 2021-10-21T21:27:29.348Z,1634851649.348 [CommandExec](IMPORTANT): PAR_Licor.loadControl (none) 2021-10-21T21:27:29.348Z,1634851649.348 [CommandExec](IMPORTANT): PAR_Licor.ad (none) 2021-10-21T21:27:29.348Z,1634851649.348 [CommandExec](IMPORTANT): PAR_Licor.adRes (bit) 2021-10-21T21:27:29.349Z,1634851649.349 [CommandExec](IMPORTANT): PAR_Licor.adTimeout (millisecond) 2021-10-21T21:27:29.349Z,1634851649.349 [CommandExec](IMPORTANT): PAR_Licor.adVref (volt) 2021-10-21T21:27:29.394Z,1634851649.394 [CommandExec](IMPORTANT): PAR_Licor.loadAtStartup (bool) 2021-10-21T21:27:29.394Z,1634851649.394 [CommandExec](IMPORTANT): PAR_Licor.simulateHardware (bool) 2021-10-21T21:27:29.394Z,1634851649.394 [CommandExec](IMPORTANT): PAR_Licor.adcCal (microampere_per_count) 2021-10-21T21:27:29.395Z,1634851649.395 [CommandExec](IMPORTANT): PAR_Licor.darkCount (count) 2021-10-21T21:27:29.395Z,1634851649.395 [CommandExec](IMPORTANT): PAR_Licor.maxBound (micromole_per_second_per_square_meter) 2021-10-21T21:27:29.395Z,1634851649.395 [CommandExec](IMPORTANT): PAR_Licor.maxValidPitch (degree) 2021-10-21T21:27:29.396Z,1634851649.396 [CommandExec](IMPORTANT): PAR_Licor.minBound (micromole_per_second_per_square_meter) 2021-10-21T21:27:29.396Z,1634851649.396 [CommandExec](IMPORTANT): PAR_Licor.minValidPitch (degree) 2021-10-21T21:27:29.397Z,1634851649.397 [CommandExec](IMPORTANT): PAR_Licor.multiplier (micromole_per_second_per_square_meter_per_microampere) 2021-10-21T21:27:29.397Z,1634851649.397 [CommandExec](IMPORTANT): PAR_Licor.parCal (none) 2021-10-21T21:27:29.397Z,1634851649.397 [CommandExec](IMPORTANT): PAR_Licor.serial (none) 2021-10-21T21:27:29.644Z,1634851649.644 [CommandExec](IMPORTANT): PAR_Licor.enableBroadcast (bool) 2021-10-21T21:27:29.645Z,1634851649.645 [CommandExec](IMPORTANT): PAR_Licor.component_voltage (volt) 2021-10-21T21:27:29.645Z,1634851649.645 [CommandExec](IMPORTANT): PAR_Licor.component_avgVoltage (volt) 2021-10-21T21:27:29.646Z,1634851649.646 [CommandExec](IMPORTANT): PAR_Licor.component_current (milliampere) 2021-10-21T21:27:29.646Z,1634851649.646 [CommandExec](IMPORTANT): PAR_Licor.component_avgCurrent (milliampere) 2021-10-21T21:27:29.646Z,1634851649.646 [CommandExec](IMPORTANT): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water (micromole_per_second_per_square_meter) 2021-10-21T21:27:29.647Z,1634851649.647 [CommandExec](IMPORTANT): PAR_Licor.adcCount (count) 2021-10-21T21:27:38.845Z,1634851658.845 [NAL9602](INFO): NAL9602 initialized 2021-10-21T21:27:51.478Z,1634851671.478 [CommandExec](IMPORTANT): got command get PAR_Licor.parCal 2021-10-21T21:27:51.478Z,1634851671.478 [CommandExec](IMPORTANT): PAR_Licor.parCal 1.000000 n/a 2021-10-21T21:27:56.639Z,1634851676.639 [SBIT](IMPORTANT): Beginning Startup BIT 2021-10-21T21:27:56.670Z,1634851676.670 [CBIT](IMPORTANT): Beginning ground fault scan 2021-10-21T21:28:07.554Z,1634851687.554 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): 0.005815 CHAN A1 (24V): -0.008179 CHAN A2 (12V): -0.004701 CHAN A3 (5V): -0.002799 CHAN B0 (3.3V): -0.000840 CHAN B1 (3.15aV): -0.001034 CHAN B2 (3.15bV): -0.001350 CHAN B3 (GND): 0.001245 OPEN: 0.004391 Full Scale: +/- 1 mA 2021-10-21T21:28:50.795Z,1634851730.795 [SBIT](IMPORTANT): SBIT PASSED 2021-10-21T21:28:50.795Z,1634851730.795 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg 2021-10-21T21:28:50.828Z,1634851730.828 [SBIT](IMPORTANT): BPC1.batteryMissingStickThreshold=32 count; 2021-10-21T21:28:50.828Z,1634851730.828 [SBIT](IMPORTANT): BPC1.batterySamplingInterval=1 hour; 2021-10-21T21:28:50.828Z,1634851730.828 [SBIT](IMPORTANT): BackseatComponent.loadAtStartup=1 bool; 2021-10-21T21:28:50.829Z,1634851730.829 [SBIT](IMPORTANT): CBIT.gf24Offset=-18.106 microampere; 2021-10-21T21:28:50.829Z,1634851730.829 [SBIT](IMPORTANT): CBIT.stopDepth=295 meter; 2021-10-21T21:28:50.829Z,1634851730.829 [SBIT](IMPORTANT): DAT.loadAtStartup=0 bool; 2021-10-21T21:28:50.829Z,1634851730.829 [SBIT](IMPORTANT): ESPComponent.loadAtStartup=1 bool; 2021-10-21T21:28:50.829Z,1634851730.829 [SBIT](IMPORTANT): ESPComponent.simulateHardware=1 bool; 2021-10-21T21:28:50.829Z,1634851730.829 [SBIT](IMPORTANT): Express none WetLabsBB2FL.bin_mean_mass_concentration_of_chlorophyll_in_sea_water; 2021-10-21T21:28:50.830Z,1634851730.830 [SBIT](IMPORTANT): Express linearApproximation platform_pitch_angle 5.000000 degree; 2021-10-21T21:28:50.830Z,1634851730.830 [SBIT](IMPORTANT): Express none platform_roll_angle; 2021-10-21T21:28:50.830Z,1634851730.830 [SBIT](IMPORTANT): ThrusterHE.loadAtStartup=0 bool; 2021-10-21T21:28:50.830Z,1634851730.830 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=391.537766 cubic_centimeter; 2021-10-21T21:28:50.830Z,1634851730.830 [SBIT](IMPORTANT): VerticalControl.massDefault=9.394078 millimeter; 2021-10-21T21:28:51.198Z,1634851731.198 [MissionManager](IMPORTANT): Started mission Startup 2021-10-21T21:28:51.198Z,1634851731.198 [Startup] Running Loop=1 2021-10-21T21:28:51.198Z,1634851731.198 [Startup](DEBUG): Aggregate::initialize Startup 2021-10-21T21:28:51.198Z,1634851731.198 [Startup:A.GoToSurface] Running Loop=1 2021-10-21T21:28:51.199Z,1634851731.199 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-10-21T21:28:51.199Z,1634851731.199 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2021-10-21T21:28:51.200Z,1634851731.200 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2021-10-21T21:28:51.200Z,1634851731.200 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2021-10-21T21:28:51.201Z,1634851731.201 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-10-21T21:28:51.201Z,1634851731.201 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-10-21T21:28:51.202Z,1634851731.202 [Startup:StartupSatComms] Running Loop=1 2021-10-21T21:28:51.203Z,1634851731.203 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms 2021-10-21T21:28:51.203Z,1634851731.203 [Startup:StartupSatComms:A] Running Loop=1 2021-10-21T21:28:51.581Z,1634851731.581 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix 2021-10-21T21:29:32.146Z,1634851772.146 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004902 2021-10-21T21:29:16.850Z,1634851756.850 [CommandExec](IMPORTANT): got command configSet PAR_Licor.parCal 1.384480 none 2021-10-21T21:29:35.603Z,1634851775.603 [BPC1](ERROR): BPC1A buffer size (F09 bytes) exceeded the max device response limit. 2021-10-21T21:29:35.604Z,1634851775.604 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size. 2021-10-21T21:29:36.020Z,1634851776.020 [BPC1](ERROR): BPC1B buffer size (A2A bytes) exceeded the max device response limit. 2021-10-21T21:29:36.020Z,1634851776.020 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size. 2021-10-21T21:29:37.167Z,1634851777.167 [CommandExec](IMPORTANT): got command report mod PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 2021-10-21T21:29:37.269Z,1634851777.269 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.579548 umol/s/m2 2021-10-21T21:29:37.646Z,1634851777.646 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.581556 umol/s/m2 2021-10-21T21:29:38.060Z,1634851778.060 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.577538 umol/s/m2 2021-10-21T21:29:38.857Z,1634851778.857 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.567484 umol/s/m2 2021-10-21T21:29:39.263Z,1634851779.263 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.583569 umol/s/m2 2021-10-21T21:29:39.671Z,1634851779.671 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.569496 umol/s/m2 2021-10-21T21:29:40.093Z,1634851780.093 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.563463 umol/s/m2 2021-10-21T21:29:40.897Z,1634851780.897 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.531296 umol/s/m2 2021-10-21T21:29:41.298Z,1634851781.298 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.553410 umol/s/m2 2021-10-21T21:29:41.700Z,1634851781.700 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.479025 umol/s/m2 2021-10-21T21:29:42.086Z,1634851782.086 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.440825 umol/s/m2 2021-10-21T21:29:42.497Z,1634851782.497 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 15.364009 umol/s/m2 2021-10-21T21:29:42.909Z,1634851782.909 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.534481 umol/s/m2 2021-10-21T21:29:43.297Z,1634851783.297 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.547341 umol/s/m2 2021-10-21T21:29:43.701Z,1634851783.701 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.968668 umol/s/m2 2021-10-21T21:29:44.108Z,1634851784.108 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 458.272522 umol/s/m2 2021-10-21T21:29:44.521Z,1634851784.521 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 958.813049 umol/s/m2 2021-10-21T21:29:44.929Z,1634851784.929 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1510.150269 umol/s/m2 2021-10-21T21:29:45.362Z,1634851785.362 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1548.602539 umol/s/m2 2021-10-21T21:29:45.741Z,1634851785.741 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1596.286865 umol/s/m2 2021-10-21T21:29:46.138Z,1634851786.138 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1597.627930 umol/s/m2 2021-10-21T21:29:46.554Z,1634851786.554 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1597.277832 umol/s/m2 2021-10-21T21:29:46.933Z,1634851786.933 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1597.690063 umol/s/m2 2021-10-21T21:29:47.342Z,1634851787.342 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1598.409912 umol/s/m2 2021-10-21T21:29:47.748Z,1634851787.748 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1603.011841 umol/s/m2 2021-10-21T21:29:48.161Z,1634851788.161 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1603.154663 umol/s/m2 2021-10-21T21:29:48.549Z,1634851788.549 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1602.899292 umol/s/m2 2021-10-21T21:29:49.089Z,1634851789.089 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1602.802734 umol/s/m2 2021-10-21T21:29:49.354Z,1634851789.354 [BPC1](INFO): Calculating totals. Valid battery stick count: 28. Valid reserve battery stick count: 2. 2021-10-21T21:29:49.358Z,1634851789.358 [BPC1](INFO): Received data from all battery sticks. 2021-10-21T21:29:49.380Z,1634851789.380 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1603.162598 umol/s/m2 2021-10-21T21:29:49.782Z,1634851789.782 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1602.694336 umol/s/m2 2021-10-21T21:29:50.186Z,1634851790.186 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1602.871094 umol/s/m2 2021-10-21T21:29:50.603Z,1634851790.603 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1602.983643 umol/s/m2 2021-10-21T21:29:50.993Z,1634851790.993 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1602.579590 umol/s/m2 2021-10-21T21:29:51.386Z,1634851791.386 [Startup:StartupSatComms:A](INFO): Timed out from 2021-10-21T21:28:51.2Z 2021-10-21T21:29:51.386Z,1634851791.386 [Startup:StartupSatComms:A] Stopped 2021-10-21T21:29:51.386Z,1634851791.386 [Startup:StartupSatComms:B] Running Loop=1 2021-10-21T21:29:51.398Z,1634851791.398 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1603.311279 umol/s/m2 2021-10-21T21:29:51.794Z,1634851791.794 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications 2021-10-21T21:29:51.806Z,1634851791.806 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1603.377686 umol/s/m2 2021-10-21T21:29:52.214Z,1634851792.214 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1603.429932 umol/s/m2 2021-10-21T21:29:52.605Z,1634851792.605 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1603.118530 umol/s/m2 2021-10-21T21:29:53.017Z,1634851793.017 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1603.992920 umol/s/m2 2021-10-21T21:29:53.418Z,1634851793.418 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1603.633057 umol/s/m2 2021-10-21T21:29:53.802Z,1634851793.802 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1604.087402 umol/s/m2 2021-10-21T21:29:54.331Z,1634851794.331 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1603.425903 umol/s/m2 2021-10-21T21:29:54.642Z,1634851794.642 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1604.216187 umol/s/m2 2021-10-21T21:29:55.045Z,1634851795.045 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1604.015015 umol/s/m2 2021-10-21T21:29:55.458Z,1634851795.458 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1604.268433 umol/s/m2 2021-10-21T21:29:55.888Z,1634851795.888 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1604.340698 umol/s/m2 2021-10-21T21:29:56.293Z,1634851796.293 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1604.557861 umol/s/m2 2021-10-21T21:29:56.687Z,1634851796.687 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1604.612183 umol/s/m2 2021-10-21T21:29:57.082Z,1634851797.082 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1604.648315 umol/s/m2 2021-10-21T21:29:57.482Z,1634851797.482 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1604.911743 umol/s/m2 2021-10-21T21:29:57.848Z,1634851797.848 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1604.933716 umol/s/m2 2021-10-21T21:29:58.267Z,1634851798.267 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1604.871582 umol/s/m2 2021-10-21T21:29:58.635Z,1634851798.635 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20211021T212218/Courier0004.lzma 2021-10-21T21:29:58.685Z,1634851798.685 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1604.905762 umol/s/m2 2021-10-21T21:29:59.050Z,1634851799.050 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1604.998169 umol/s/m2 2021-10-21T21:29:59.450Z,1634851799.450 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 1 2021-10-21T21:29:59.450Z,1634851799.450 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-10-21T21:29:59.465Z,1634851799.465 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-10-21T21:29:59.467Z,1634851799.467 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1605.064575 umol/s/m2 2021-10-21T21:29:59.637Z,1634851799.637 [DataOverHttps](INFO): Moved sent file to Logs/20211021T212218/Courier0004.lzma.bak 2021-10-21T21:29:59.638Z,1634851799.638 [DataOverHttps](INFO): SBD MOMSN=16044688 2021-10-21T21:29:59.876Z,1634851799.876 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-10-21T21:29:59.876Z,1634851799.876 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 1 2021-10-21T21:29:59.878Z,1634851799.878 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1605.014160 umol/s/m2 2021-10-21T21:30:00.266Z,1634851800.266 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1604.980103 umol/s/m2 2021-10-21T21:30:00.752Z,1634851800.752 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1605.102783 umol/s/m2 2021-10-21T21:30:01.133Z,1634851801.133 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1605.164917 umol/s/m2 2021-10-21T21:30:01.500Z,1634851801.500 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1605.124878 umol/s/m2 2021-10-21T21:30:01.913Z,1634851801.913 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1605.034546 umol/s/m2 2021-10-21T21:30:02.321Z,1634851802.321 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1605.120850 umol/s/m2 2021-10-21T21:30:02.742Z,1634851802.742 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1605.211304 umol/s/m2 2021-10-21T21:30:03.123Z,1634851803.123 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1605.046509 umol/s/m2 2021-10-21T21:30:03.535Z,1634851803.535 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1604.905762 umol/s/m2 2021-10-21T21:30:03.910Z,1634851803.910 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1604.959961 umol/s/m2 2021-10-21T21:30:04.346Z,1634851804.346 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1604.949951 umol/s/m2 2021-10-21T21:30:04.730Z,1634851804.730 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1603.608887 umol/s/m2 2021-10-21T21:30:05.140Z,1634851805.140 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 30.888855 umol/s/m2 2021-10-21T21:30:05.553Z,1634851805.553 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 18.749641 umol/s/m2 2021-10-21T21:30:05.932Z,1634851805.932 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 18.317389 umol/s/m2 2021-10-21T21:30:06.338Z,1634851806.338 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 18.269138 umol/s/m2 2021-10-21T21:30:06.757Z,1634851806.757 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 18.162582 umol/s/m2 2021-10-21T21:30:07.167Z,1634851807.167 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 18.052008 umol/s/m2 2021-10-21T21:30:07.574Z,1634851807.574 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.993704 umol/s/m2 2021-10-21T21:30:07.946Z,1634851807.946 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.939423 umol/s/m2 2021-10-21T21:30:08.362Z,1634851808.362 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.836885 umol/s/m2 2021-10-21T21:30:08.746Z,1634851808.746 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.800699 umol/s/m2 2021-10-21T21:30:09.157Z,1634851809.157 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 16.771338 umol/s/m2 2021-10-21T21:30:09.566Z,1634851809.566 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.722290 umol/s/m2 2021-10-21T21:30:09.980Z,1634851809.980 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.748426 umol/s/m2 2021-10-21T21:30:10.393Z,1634851810.393 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.497116 umol/s/m2 2021-10-21T21:30:10.768Z,1634851810.768 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 16.341097 umol/s/m2 2021-10-21T21:30:11.222Z,1634851811.222 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 15.995296 umol/s/m2 2021-10-21T21:30:11.643Z,1634851811.643 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 16.258669 umol/s/m2 2021-10-21T21:30:12.023Z,1634851812.023 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.398603 umol/s/m2 2021-10-21T21:30:12.429Z,1634851812.429 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.672028 umol/s/m2 2021-10-21T21:30:12.849Z,1634851812.849 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.657955 umol/s/m2 2021-10-21T21:30:13.218Z,1634851813.218 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.489077 umol/s/m2 2021-10-21T21:30:13.623Z,1634851813.623 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.575527 umol/s/m2 2021-10-21T21:30:14.038Z,1634851814.038 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.491087 umol/s/m2 2021-10-21T21:30:14.405Z,1634851814.405 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.314165 umol/s/m2 2021-10-21T21:30:14.855Z,1634851814.855 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.320196 umol/s/m2 2021-10-21T21:30:15.121Z,1634851815.121 [CommandExec](IMPORTANT): got command report clear 2021-10-21T21:30:15.341Z,1634851815.341 [DataOverHttps](INFO): Sending 361 bytes from file Logs/20211021T212648/Courier0000.lzma 2021-10-21T21:30:16.341Z,1634851816.341 [DataOverHttps](INFO): Moved sent file to Logs/20211021T212648/Courier0000.lzma.bak 2021-10-21T21:30:16.342Z,1634851816.342 [DataOverHttps](INFO): SBD MOMSN=16044690 2021-10-21T21:30:31.020Z,1634851831.020 [CommandExec](IMPORTANT): got command configSet PAR_Licor.parCal 1.000000 none 2021-10-21T21:30:34.525Z,1634851834.525 [DataOverHttps](INFO): Sending 89 bytes from file Logs/20211021T193814/Express0008.lzma 2021-10-21T21:30:35.525Z,1634851835.525 [DataOverHttps](INFO): Moved sent file to Logs/20211021T193814/Express0008.lzma.bak 2021-10-21T21:30:35.526Z,1634851835.526 [DataOverHttps](INFO): SBD MOMSN=16044696 2021-10-21T21:30:40.873Z,1634851840.873 [CommandExec](IMPORTANT): got command report mod PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 2021-10-21T21:30:41.128Z,1634851841.128 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1149.958862 umol/s/m2 2021-10-21T21:30:41.506Z,1634851841.506 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1149.928345 umol/s/m2 2021-10-21T21:30:41.924Z,1634851841.924 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1149.887695 umol/s/m2 2021-10-21T21:30:42.340Z,1634851842.340 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1149.778809 umol/s/m2 2021-10-21T21:30:42.714Z,1634851842.714 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1149.733765 umol/s/m2 2021-10-21T21:30:43.125Z,1634851843.125 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1149.611816 umol/s/m2 2021-10-21T21:30:43.524Z,1634851843.524 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1149.485474 umol/s/m2 2021-10-21T21:30:43.918Z,1634851843.918 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1149.359131 umol/s/m2 2021-10-21T21:30:44.325Z,1634851844.325 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1149.283569 umol/s/m2 2021-10-21T21:30:44.722Z,1634851844.722 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1149.210938 umol/s/m2 2021-10-21T21:30:45.110Z,1634851845.110 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1149.178955 umol/s/m2 2021-10-21T21:30:45.518Z,1634851845.518 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1149.106445 umol/s/m2 2021-10-21T21:30:45.922Z,1634851845.922 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1149.007690 umol/s/m2 2021-10-21T21:30:46.335Z,1634851846.335 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 481.385559 umol/s/m2 2021-10-21T21:30:46.725Z,1634851846.725 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 14.370455 umol/s/m2 2021-10-21T21:30:47.127Z,1634851847.127 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.333622 umol/s/m2 2021-10-21T21:30:47.533Z,1634851847.533 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.156461 umol/s/m2 2021-10-21T21:30:47.948Z,1634851847.948 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 13.059166 umol/s/m2 2021-10-21T21:30:48.420Z,1634851848.420 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.982203 umol/s/m2 2021-10-21T21:30:48.792Z,1634851848.792 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.935734 umol/s/m2 2021-10-21T21:30:49.205Z,1634851849.205 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.867482 umol/s/m2 2021-10-21T21:30:49.600Z,1634851849.600 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.871840 umol/s/m2 2021-10-21T21:30:49.985Z,1634851849.985 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.877648 umol/s/m2 2021-10-21T21:30:50.409Z,1634851850.409 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.860221 umol/s/m2 2021-10-21T21:30:50.775Z,1634851850.775 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.854414 umol/s/m2 2021-10-21T21:30:51.221Z,1634851851.221 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.818110 umol/s/m2 2021-10-21T21:30:51.578Z,1634851851.578 [Startup:StartupSatComms:B](INFO): Timed out from 2021-10-21T21:29:51.4Z 2021-10-21T21:30:51.578Z,1634851851.578 [Startup:StartupSatComms:B] Stopped 2021-10-21T21:30:51.578Z,1634851851.578 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms 2021-10-21T21:30:51.578Z,1634851851.578 [Startup:StartupSatComms] Stopped 2021-10-21T21:30:51.578Z,1634851851.578 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms 2021-10-21T21:30:51.579Z,1634851851.579 [Startup](INFO): Completed Startup 2021-10-21T21:30:51.579Z,1634851851.579 [MissionManager](INFO): Startup is completed. 2021-10-21T21:30:51.579Z,1634851851.579 [MissionManager](INFO): Uninitializing Mission Startup 2021-10-21T21:30:51.579Z,1634851851.579 [Startup] Stopped 2021-10-21T21:30:51.580Z,1634851851.580 [Startup](DEBUG): Aggregate::uninitialize Startup 2021-10-21T21:30:51.580Z,1634851851.580 [Startup:A.GoToSurface] Stopped 2021-10-21T21:30:51.580Z,1634851851.580 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-10-21T21:30:51.592Z,1634851851.592 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.810848 umol/s/m2 2021-10-21T21:30:51.974Z,1634851851.974 [MissionManager](IMPORTANT): Started mission Default 2021-10-21T21:30:51.974Z,1634851851.974 [Default] Running Loop=1 2021-10-21T21:30:51.974Z,1634851851.974 [Default](DEBUG): Aggregate::initialize Default 2021-10-21T21:30:51.974Z,1634851851.974 [Default:B.GoToSurface] Running Loop=1 2021-10-21T21:30:51.974Z,1634851851.974 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2021-10-21T21:30:51.974Z,1634851851.974 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2021-10-21T21:30:51.975Z,1634851851.975 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2021-10-21T21:30:51.975Z,1634851851.975 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2021-10-21T21:30:51.976Z,1634851851.976 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2021-10-21T21:30:51.976Z,1634851851.976 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2021-10-21T21:30:51.976Z,1634851851.976 [Default:A.Wait] Running Loop=1 2021-10-21T21:30:51.976Z,1634851851.976 [Default:A.Wait](DEBUG): Initialize Wait Component. 2021-10-21T21:30:52.032Z,1634851852.032 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.803588 umol/s/m2 2021-10-21T21:30:52.286Z,1634851852.286 [DataOverHttps](INFO): Sending 1060 bytes from file Logs/20211021T210953/Express0001.lzma 2021-10-21T21:30:52.379Z,1634851852.379 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.806493 umol/s/m2 2021-10-21T21:30:53.219Z,1634851853.219 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.791971 umol/s/m2 2021-10-21T21:30:53.287Z,1634851853.287 [DataOverHttps](INFO): Moved sent file to Logs/20211021T210953/Express0001.lzma.bak 2021-10-21T21:30:53.287Z,1634851853.287 [DataOverHttps](INFO): SBD MOMSN=16044700 2021-10-21T21:30:53.642Z,1634851853.642 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.777450 umol/s/m2 2021-10-21T21:30:54.046Z,1634851854.046 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.733884 umol/s/m2 2021-10-21T21:30:54.464Z,1634851854.464 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.730981 umol/s/m2 2021-10-21T21:30:54.839Z,1634851854.839 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.707746 umol/s/m2 2021-10-21T21:30:55.235Z,1634851855.235 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.675798 umol/s/m2 2021-10-21T21:30:55.616Z,1634851855.616 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.694677 umol/s/m2 2021-10-21T21:30:56.017Z,1634851856.017 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.671443 umol/s/m2 2021-10-21T21:30:56.457Z,1634851856.457 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.696130 umol/s/m2 2021-10-21T21:30:56.853Z,1634851856.853 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.709198 umol/s/m2 2021-10-21T21:30:57.272Z,1634851857.272 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.691772 umol/s/m2 2021-10-21T21:30:57.651Z,1634851857.651 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.683060 umol/s/m2 2021-10-21T21:30:58.073Z,1634851858.073 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.665634 umol/s/m2 2021-10-21T21:30:58.475Z,1634851858.475 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.656921 umol/s/m2 2021-10-21T21:30:58.893Z,1634851858.893 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.741145 umol/s/m2 2021-10-21T21:30:59.307Z,1634851859.307 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.733884 umol/s/m2 2021-10-21T21:30:59.672Z,1634851859.672 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.703390 umol/s/m2 2021-10-21T21:31:00.214Z,1634851860.214 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.688869 umol/s/m2 2021-10-21T21:31:00.460Z,1634851860.460 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.678702 umol/s/m2 2021-10-21T21:31:00.877Z,1634851860.877 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.700485 umol/s/m2 2021-10-21T21:31:01.281Z,1634851861.281 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.681608 umol/s/m2 2021-10-21T21:31:01.671Z,1634851861.671 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.700485 umol/s/m2 2021-10-21T21:31:02.077Z,1634851862.077 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.694677 umol/s/m2 2021-10-21T21:31:02.493Z,1634851862.493 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.725171 umol/s/m2 2021-10-21T21:31:02.900Z,1634851862.900 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.681608 umol/s/m2 2021-10-21T21:31:03.290Z,1634851863.290 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.675798 umol/s/m2 2021-10-21T21:31:03.697Z,1634851863.697 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.688869 umol/s/m2 2021-10-21T21:31:04.113Z,1634851864.113 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.696130 umol/s/m2 2021-10-21T21:31:04.528Z,1634851864.528 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.703390 umol/s/m2 2021-10-21T21:31:04.933Z,1634851864.933 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.662729 umol/s/m2 2021-10-21T21:31:05.311Z,1634851865.311 [Default:A.Wait](INFO): Done Waiting. 2021-10-21T21:31:05.312Z,1634851865.312 [Default:A.Wait] Stopped 2021-10-21T21:31:05.312Z,1634851865.312 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2021-10-21T21:31:05.322Z,1634851865.322 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.690321 umol/s/m2 2021-10-21T21:31:05.714Z,1634851865.714 [Default:CheckIn] Running Loop=1 2021-10-21T21:31:05.715Z,1634851865.715 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-10-21T21:31:05.715Z,1634851865.715 [Default:CheckIn:Read_GPS] Running Loop=1 2021-10-21T21:31:05.725Z,1634851865.725 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.675798 umol/s/m2 2021-10-21T21:31:06.122Z,1634851866.122 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix 2021-10-21T21:31:06.133Z,1634851866.133 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.697581 umol/s/m2 2021-10-21T21:31:06.520Z,1634851866.520 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.668538 umol/s/m2 2021-10-21T21:31:06.925Z,1634851866.925 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.685964 umol/s/m2 2021-10-21T21:31:07.341Z,1634851867.341 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.681608 umol/s/m2 2021-10-21T21:31:07.752Z,1634851867.752 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.703390 umol/s/m2 2021-10-21T21:31:08.137Z,1634851868.137 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.720816 umol/s/m2 2021-10-21T21:31:08.445Z,1634851868.445 [CommandExec](IMPORTANT): got command configSet PAR_Licor.parCal 1.382070 none 2021-10-21T21:31:08.558Z,1634851868.558 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.520847 umol/s/m2 2021-10-21T21:31:08.950Z,1634851868.950 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.498770 umol/s/m2 2021-10-21T21:31:09.373Z,1634851869.373 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.514828 umol/s/m2 2021-10-21T21:31:09.780Z,1634851869.780 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.546940 umol/s/m2 2021-10-21T21:31:10.170Z,1634851870.170 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.536903 umol/s/m2 2021-10-21T21:31:10.582Z,1634851870.582 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.510813 umol/s/m2 2021-10-21T21:31:10.976Z,1634851870.976 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.518841 umol/s/m2 2021-10-21T21:31:11.387Z,1634851871.387 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.500778 umol/s/m2 2021-10-21T21:31:11.770Z,1634851871.770 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.508806 umol/s/m2 2021-10-21T21:31:12.184Z,1634851872.184 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.486729 umol/s/m2 2021-10-21T21:31:12.595Z,1634851872.595 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.502787 umol/s/m2 2021-10-21T21:31:12.985Z,1634851872.985 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.512821 umol/s/m2 2021-10-21T21:31:13.394Z,1634851873.394 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.484722 umol/s/m2 2021-10-21T21:31:13.798Z,1634851873.798 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.458632 umol/s/m2 2021-10-21T21:31:14.209Z,1634851874.209 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.336208 umol/s/m2 2021-10-21T21:31:14.632Z,1634851874.632 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 14.847565 umol/s/m2 2021-10-21T21:31:15.036Z,1634851875.036 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 12.985096 umol/s/m2 2021-10-21T21:31:15.461Z,1634851875.461 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.273368 umol/s/m2 2021-10-21T21:31:15.833Z,1634851875.833 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 3.425897 umol/s/m2 2021-10-21T21:31:16.238Z,1634851876.238 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 508.608368 umol/s/m2 2021-10-21T21:31:16.619Z,1634851876.619 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 206.758057 umol/s/m2 2021-10-21T21:31:17.034Z,1634851877.034 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1280.938477 umol/s/m2 2021-10-21T21:31:17.443Z,1634851877.443 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1569.053101 umol/s/m2 2021-10-21T21:31:17.831Z,1634851877.831 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1591.390625 umol/s/m2 2021-10-21T21:31:18.237Z,1634851878.237 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1592.355957 umol/s/m2 2021-10-21T21:31:18.649Z,1634851878.649 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1592.976196 umol/s/m2 2021-10-21T21:31:19.061Z,1634851879.061 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1591.021362 umol/s/m2 2021-10-21T21:31:19.448Z,1634851879.448 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1593.821167 umol/s/m2 2021-10-21T21:31:19.865Z,1634851879.865 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1593.305420 umol/s/m2 2021-10-21T21:31:20.281Z,1634851880.281 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1593.004272 umol/s/m2 2021-10-21T21:31:20.682Z,1634851880.682 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1592.739258 umol/s/m2 2021-10-21T21:31:21.088Z,1634851881.088 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1592.741455 umol/s/m2 2021-10-21T21:31:21.469Z,1634851881.469 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1592.835571 umol/s/m2 2021-10-21T21:31:21.882Z,1634851881.882 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1592.992188 umol/s/m2 2021-10-21T21:31:22.291Z,1634851882.291 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1593.259277 umol/s/m2 2021-10-21T21:31:22.678Z,1634851882.678 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1593.518188 umol/s/m2 2021-10-21T21:31:23.089Z,1634851883.089 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1593.767090 umol/s/m2 2021-10-21T21:31:23.497Z,1634851883.497 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1594.212402 umol/s/m2 2021-10-21T21:31:23.902Z,1634851883.902 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1594.744385 umol/s/m2 2021-10-21T21:31:24.317Z,1634851884.317 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1595.141724 umol/s/m2 2021-10-21T21:31:24.705Z,1634851884.705 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1595.641479 umol/s/m2 2021-10-21T21:31:25.126Z,1634851885.126 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1596.123047 umol/s/m2 2021-10-21T21:31:25.530Z,1634851885.530 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1596.420166 umol/s/m2 2021-10-21T21:31:25.937Z,1634851885.937 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1596.624878 umol/s/m2 2021-10-21T21:31:26.353Z,1634851886.353 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1597.080566 umol/s/m2 2021-10-21T21:31:26.741Z,1634851886.741 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 1596.761353 umol/s/m2 2021-10-21T21:31:27.138Z,1634851887.138 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 815.943665 umol/s/m2 2021-10-21T21:31:27.548Z,1634851887.548 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 19.164557 umol/s/m2 2021-10-21T21:31:27.932Z,1634851887.932 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 18.488207 umol/s/m2 2021-10-21T21:31:28.336Z,1634851888.336 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 18.227303 umol/s/m2 2021-10-21T21:31:28.750Z,1634851888.750 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 18.068750 umol/s/m2 2021-10-21T21:31:29.164Z,1634851889.164 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.970409 umol/s/m2 2021-10-21T21:31:29.548Z,1634851889.548 [Reporter](INFO): PAR_Licor.downwelling_photosynthetic_photon_flux_in_sea_water 17.938297 umol/s/m2 2021-10-21T21:31:29.673Z,1634851889.673 [CommandExec](IMPORTANT): got command report clear 2021-10-21T21:31:47.920Z,1634851907.920 [CommandExec](IMPORTANT): got command configSet PAR_Licor.parCal 1.382070 none persist 2021-10-21T21:32:42.248Z,1634851962.248 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2021-10-21T21:33:00.460Z,1634851980.460 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 2 2021-10-21T21:33:00.460Z,1634851980.460 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-10-21T21:33:00.483Z,1634851980.483 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-10-21T21:33:00.848Z,1634851980.848 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-10-21T21:33:00.848Z,1634851980.848 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 2 2021-10-21T21:36:01.429Z,1634852161.429 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 3 2021-10-21T21:36:01.429Z,1634852161.429 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-10-21T21:36:01.440Z,1634852161.440 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-10-21T21:36:01.849Z,1634852161.849 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-10-21T21:36:01.849Z,1634852161.849 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 3 2021-10-21T21:36:05.887Z,1634852165.887 [Default:CheckIn:Read_GPS](INFO): Timed out from 2021-10-21T21:31:05.7Z 2021-10-21T21:36:05.887Z,1634852165.887 [Default:CheckIn:Read_GPS] Stopped 2021-10-21T21:36:05.887Z,1634852165.887 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-10-21T21:36:06.281Z,1634852166.281 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications 2021-10-21T21:36:13.823Z,1634852173.823 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20211021T212648/Courier0004.lzma 2021-10-21T21:36:15.359Z,1634852175.359 [DataOverHttps](INFO): Moved sent file to Logs/20211021T212648/Courier0004.lzma.bak 2021-10-21T21:36:15.360Z,1634852175.360 [DataOverHttps](INFO): SBD MOMSN=16044729 2021-10-21T21:36:17.945Z,1634852177.945 [CommandExec](IMPORTANT): got command get platform_mass_position 2021-10-21T21:36:17.946Z,1634852177.946 [CommandExec](IMPORTANT): platform_mass_position 0.009394 m 2021-10-21T21:36:31.244Z,1634852191.244 [DataOverHttps](INFO): Sending 624 bytes from file Logs/20211021T210953/Express0005.lzma 2021-10-21T21:36:32.245Z,1634852192.245 [DataOverHttps](INFO): Moved sent file to Logs/20211021T210953/Express0005.lzma.bak 2021-10-21T21:36:32.246Z,1634852192.246 [DataOverHttps](INFO): SBD MOMSN=16044731 2021-10-21T21:36:48.010Z,1634852208.010 [DataOverHttps](INFO): Sending 1061 bytes from file Logs/20211021T211627/Express0001.lzma 2021-10-21T21:36:49.012Z,1634852209.012 [DataOverHttps](INFO): Moved sent file to Logs/20211021T211627/Express0001.lzma.bak 2021-10-21T21:36:49.013Z,1634852209.013 [DataOverHttps](INFO): SBD MOMSN=16044756 2021-10-21T21:36:56.745Z,1634852216.745 [CommandExec](IMPORTANT): got command get VerticalControl.massPositionLimitFwd 2021-10-21T21:36:56.745Z,1634852216.745 [CommandExec](IMPORTANT): VerticalControl.massPositionLimitFwd 30.000000 mm 2021-10-21T21:37:00.814Z,1634852220.814 [Power24vConverter](INFO): Powering down. 2021-10-21T21:37:04.532Z,1634852224.532 [CommandExec](IMPORTANT): got command get VerticalControl.massPositionLimitAft 2021-10-21T21:37:04.533Z,1634852224.533 [CommandExec](IMPORTANT): VerticalControl.massPositionLimitAft -32.000000 mm 2021-10-21T21:37:06.327Z,1634852226.327 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20211021T211627/Express0005.lzma 2021-10-21T21:37:07.329Z,1634852227.329 [DataOverHttps](INFO): Moved sent file to Logs/20211021T211627/Express0005.lzma.bak 2021-10-21T21:37:07.330Z,1634852227.330 [DataOverHttps](INFO): SBD MOMSN=16044783 2021-10-21T21:37:22.781Z,1634852242.781 [DataOverHttps](INFO): Sending 1324 bytes from file Logs/20211021T212218/Express0001.lzma 2021-10-21T21:37:23.781Z,1634852243.781 [DataOverHttps](INFO): Moved sent file to Logs/20211021T212218/Express0001.lzma.bak 2021-10-21T21:37:23.782Z,1634852243.782 [DataOverHttps](INFO): SBD MOMSN=16044785 2021-10-21T21:37:39.767Z,1634852259.767 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20211021T212218/Express0005.lzma 2021-10-21T21:37:40.769Z,1634852260.769 [DataOverHttps](INFO): Moved sent file to Logs/20211021T212218/Express0005.lzma.bak 2021-10-21T21:37:40.770Z,1634852260.770 [DataOverHttps](INFO): SBD MOMSN=16044874 2021-10-21T21:37:42.017Z,1634852262.017 [NAL9602](FAULT): GPS failed to acquire within timeout. 2021-10-21T21:37:42.017Z,1634852262.017 [NAL9602] Data Fault, FailCount= 1 2021-10-21T21:37:42.018Z,1634852262.018 [NAL9602](ERROR): Data Fault 2021-10-21T21:37:42.089Z,1634852262.089 [CBIT](ERROR): Data Fault in component: NAL9602 2021-10-21T21:37:42.421Z,1634852262.421 [NAL9602](INFO): Powering down 2021-10-21T21:37:43.268Z,1634852263.268 [CBIT](INFO): Clearing failed state for component NAL9602 2021-10-21T21:37:43.268Z,1634852263.268 [NAL9602] No Fault, FailCount= 1 2021-10-21T21:37:56.270Z,1634852276.270 [DataOverHttps](INFO): Sending 1466 bytes from file Logs/20211021T212648/Express0001.lzma 2021-10-21T21:37:57.269Z,1634852277.269 [DataOverHttps](INFO): Moved sent file to Logs/20211021T212648/Express0001.lzma.bak 2021-10-21T21:37:57.270Z,1634852277.270 [DataOverHttps](INFO): SBD MOMSN=16044876 2021-10-21T21:38:06.644Z,1634852286.644 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction 20.000000 millimeter 2021-10-21T21:38:06.668Z,1634852286.668 [ComponentRegistry](DEBUG): SyncComponent "Maintain_VerticalControl.massPositionAction" handled in the control thread. 2021-10-21T21:38:06.723Z,1634852286.723 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,Maintain_VerticalControl.massPositionAction,BuoyancyServo,ElevatorServo,MassServo,RudderServo,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter, 2021-10-21T21:38:12.733Z,1634852292.733 [NAL9602](INFO): Powering up NAL9602 2021-10-21T21:38:13.804Z,1634852293.804 [DataOverHttps](INFO): Sending 349 bytes from file Logs/20211021T212648/Express0005.lzma 2021-10-21T21:38:15.396Z,1634852295.396 [DataOverHttps](INFO): Moved sent file to Logs/20211021T212648/Express0005.lzma.bak 2021-10-21T21:38:15.396Z,1634852295.396 [DataOverHttps](INFO): SBD MOMSN=16044931 2021-10-21T21:38:16.770Z,1634852296.770 [Default:CheckIn:Read_Iridium] Stopped 2021-10-21T21:38:16.770Z,1634852296.770 [Default:CheckIn:C.Wait] Running Loop=1 2021-10-21T21:38:16.770Z,1634852296.770 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-10-21T21:38:23.633Z,1634852303.633 [NAL9602](INFO): NAL9602 initialized 2021-10-21T21:38:35.881Z,1634852315.881 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction 25.000000 millimeter 2021-10-21T21:38:58.628Z,1634852338.628 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction 30.000000 millimeter 2021-10-21T21:39:02.423Z,1634852342.423 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 4 2021-10-21T21:39:02.423Z,1634852342.423 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-10-21T21:39:02.489Z,1634852342.489 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-10-21T21:39:02.892Z,1634852342.892 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-10-21T21:39:02.892Z,1634852342.892 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 4 2021-10-21T21:39:28.884Z,1634852368.884 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction -10.000000 millimeter 2021-10-21T21:40:36.511Z,1634852436.511 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction -20.000000 millimeter 2021-10-21T21:41:03.931Z,1634852463.931 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction -27.000000 millimeter 2021-10-21T21:41:28.018Z,1634852488.018 [CommandExec](IMPORTANT): got command maintain control VerticalControl.massPositionAction -32.000000 millimeter 2021-10-21T21:42:00.229Z,1634852520.229 [CBIT](INFO): Clearing failed state for component DropWeight 2021-10-21T21:42:00.229Z,1634852520.229 [DropWeight] No Fault, FailCount= 1 2021-10-21T21:42:03.430Z,1634852523.430 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 5 2021-10-21T21:42:03.430Z,1634852523.430 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-10-21T21:42:03.465Z,1634852523.465 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-10-21T21:42:03.843Z,1634852523.843 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-10-21T21:42:03.843Z,1634852523.843 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 5 2021-10-21T21:43:17.374Z,1634852597.374 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-10-21T21:43:17.374Z,1634852597.374 [Default:CheckIn:C.Wait] Stopped 2021-10-21T21:43:17.375Z,1634852597.375 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-10-21T21:43:17.375Z,1634852597.375 [Default:CheckIn:D] Running Loop=1 2021-10-21T21:43:17.781Z,1634852597.781 [Default:CheckIn:D] Stopped 2021-10-21T21:43:17.781Z,1634852597.781 [Default:CheckIn:E] Running Loop=1 2021-10-21T21:43:18.162Z,1634852598.162 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 12.430115 min 2021-10-21T21:43:18.163Z,1634852598.163 [Default:CheckIn:E] Stopped 2021-10-21T21:43:18.163Z,1634852598.163 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-10-21T21:43:18.163Z,1634852598.163 [Default:CheckIn] Stopped 2021-10-21T21:43:18.163Z,1634852598.163 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-10-21T21:43:18.163Z,1634852598.163 [Default:CheckIn](INFO): Running loop #2 2021-10-21T21:43:18.163Z,1634852598.163 [Default:CheckIn] Running Loop=2 2021-10-21T21:43:18.163Z,1634852598.163 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-10-21T21:43:18.163Z,1634852598.163 [Default:CheckIn:Read_GPS] Running Loop=1 2021-10-21T21:45:04.440Z,1634852704.440 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 6 2021-10-21T21:45:04.440Z,1634852704.440 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-10-21T21:45:04.452Z,1634852704.452 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-10-21T21:45:04.861Z,1634852704.861 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-10-21T21:45:04.862Z,1634852704.862 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 6 2021-10-21T21:48:05.409Z,1634852885.409 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 7 2021-10-21T21:48:05.409Z,1634852885.409 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-10-21T21:48:05.421Z,1634852885.421 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-10-21T21:48:05.832Z,1634852885.832 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-10-21T21:48:05.832Z,1634852885.832 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 7 2021-10-21T21:48:18.339Z,1634852898.339 [Default:CheckIn:Read_GPS](INFO): Timed out from 2021-10-21T21:43:18.2Z 2021-10-21T21:48:18.339Z,1634852898.339 [Default:CheckIn:Read_GPS] Stopped 2021-10-21T21:48:18.339Z,1634852898.339 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-10-21T21:48:23.959Z,1634852903.959 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20211021T212648/Courier0007.lzma 2021-10-21T21:48:24.962Z,1634852904.962 [DataOverHttps](INFO): Moved sent file to Logs/20211021T212648/Courier0007.lzma.bak 2021-10-21T21:48:24.962Z,1634852904.962 [DataOverHttps](INFO): SBD MOMSN=16044941 2021-10-21T21:48:25.194Z,1634852905.194 [NAL9602](FAULT): GPS failed to acquire within timeout. 2021-10-21T21:48:25.194Z,1634852905.194 [NAL9602] Data Fault, FailCount= 2 2021-10-21T21:48:25.194Z,1634852905.194 [NAL9602](ERROR): Data Fault 2021-10-21T21:48:25.211Z,1634852905.211 [CBIT](ERROR): Data Fault in component: NAL9602 2021-10-21T21:48:25.594Z,1634852905.594 [NAL9602](INFO): Powering down 2021-10-21T21:48:26.443Z,1634852906.443 [CBIT](INFO): Clearing failed state for component NAL9602 2021-10-21T21:48:26.443Z,1634852906.443 [NAL9602] No Fault, FailCount= 2 2021-10-21T21:48:40.264Z,1634852920.264 [DataOverHttps](INFO): Sending 406 bytes from file Logs/20211021T212648/Express0008.lzma 2021-10-21T21:48:41.265Z,1634852921.265 [DataOverHttps](INFO): Moved sent file to Logs/20211021T212648/Express0008.lzma.bak 2021-10-21T21:48:41.266Z,1634852921.266 [DataOverHttps](INFO): SBD MOMSN=16044943 2021-10-21T21:48:43.390Z,1634852923.390 [Default:CheckIn:Read_Iridium] Stopped 2021-10-21T21:48:43.390Z,1634852923.390 [Default:CheckIn:C.Wait] Running Loop=1 2021-10-21T21:48:43.390Z,1634852923.390 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-10-21T21:48:55.891Z,1634852935.891 [NAL9602](INFO): Powering up NAL9602 2021-10-21T21:49:06.805Z,1634852946.805 [NAL9602](INFO): NAL9602 initialized 2021-10-21T21:51:06.415Z,1634853066.415 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 8 2021-10-21T21:51:06.415Z,1634853066.415 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-10-21T21:51:06.447Z,1634853066.447 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-10-21T21:51:06.835Z,1634853066.835 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-10-21T21:51:06.835Z,1634853066.835 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 8 2021-10-21T21:53:43.951Z,1634853223.951 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2021-10-21T21:53:43.951Z,1634853223.951 [Default:CheckIn:C.Wait] Stopped 2021-10-21T21:53:43.951Z,1634853223.951 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-10-21T21:53:43.952Z,1634853223.952 [Default:CheckIn:D] Running Loop=1 2021-10-21T21:53:44.365Z,1634853224.365 [Default:CheckIn:D] Stopped 2021-10-21T21:53:44.366Z,1634853224.366 [Default:CheckIn:E] Running Loop=1 2021-10-21T21:53:44.778Z,1634853224.778 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 22.873191 min 2021-10-21T21:53:44.778Z,1634853224.778 [Default:CheckIn:E] Stopped 2021-10-21T21:53:44.778Z,1634853224.778 [Default:CheckIn](INFO): Completed Default:CheckIn 2021-10-21T21:53:44.778Z,1634853224.778 [Default:CheckIn] Stopped 2021-10-21T21:53:44.778Z,1634853224.778 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-10-21T21:53:44.778Z,1634853224.778 [Default:CheckIn](INFO): Running loop #3 2021-10-21T21:53:44.778Z,1634853224.778 [Default:CheckIn] Running Loop=3 2021-10-21T21:53:44.778Z,1634853224.778 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2021-10-21T21:53:44.779Z,1634853224.779 [Default:CheckIn:Read_GPS] Running Loop=1 2021-10-21T21:54:07.409Z,1634853247.409 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 9 2021-10-21T21:54:07.409Z,1634853247.409 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-10-21T21:54:07.420Z,1634853247.420 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-10-21T21:54:07.822Z,1634853247.822 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-10-21T21:54:07.822Z,1634853247.822 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 9 2021-10-21T21:57:08.397Z,1634853428.397 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 10 2021-10-21T21:57:08.397Z,1634853428.397 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-10-21T21:57:08.408Z,1634853428.408 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-10-21T21:57:08.807Z,1634853428.807 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-10-21T21:57:08.807Z,1634853428.807 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 10 2021-10-21T21:58:34.450Z,1634853514.450 [CBIT](FAULT): WATER ALARM STERN. 2021-10-21T21:58:34.451Z,1634853514.451 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 1 2021-10-21T21:58:34.864Z,1634853514.864 [CBIT](FAULT): WATER ALARM STERN. 2021-10-21T21:58:34.865Z,1634853514.865 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 2 2021-10-21T21:58:35.251Z,1634853515.251 [CBIT](FAULT): WATER ALARM STERN. 2021-10-21T21:58:35.252Z,1634853515.252 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 3 2021-10-21T21:58:44.934Z,1634853524.934 [Default:CheckIn:Read_GPS](INFO): Timed out from 2021-10-21T21:53:44.8Z 2021-10-21T21:58:44.934Z,1634853524.934 [Default:CheckIn:Read_GPS] Stopped 2021-10-21T21:58:44.934Z,1634853524.934 [Default:CheckIn:Read_Iridium] Running Loop=1 2021-10-21T21:58:52.011Z,1634853532.011 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20211021T212648/Courier0010.lzma 2021-10-21T21:58:53.013Z,1634853533.013 [DataOverHttps](INFO): Moved sent file to Logs/20211021T212648/Courier0010.lzma.bak 2021-10-21T21:58:53.014Z,1634853533.014 [DataOverHttps](INFO): SBD MOMSN=16044960 2021-10-21T21:59:01.126Z,1634853541.126 [CBIT](FAULT): WATER ALARM BOW. 2021-10-21T21:59:01.128Z,1634853541.128 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 1 2021-10-21T21:59:01.521Z,1634853541.521 [CBIT](FAULT): WATER ALARM BOW. 2021-10-21T21:59:01.522Z,1634853541.522 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 2 2021-10-21T21:59:01.908Z,1634853541.908 [CBIT](FAULT): WATER ALARM BOW. 2021-10-21T21:59:01.909Z,1634853541.909 [CBIT](ERROR): WATER DETECTED IN PRESSURE HULL. Alarm Count: 3 2021-10-21T21:59:02.318Z,1634853542.318 [CBIT](FAULT): WATER ALARM BOW. 2021-10-21T21:59:02.332Z,1634853542.332 [CBIT](CRITICAL): WATER DETECTED IN PRESSURE HULL. BURNWIRE ACTIVATED 2021-10-21T21:59:02.332Z,1634853542.332 [CBIT](IMPORTANT): Powered off ESP with command: ! echo 0 > /dev/loadA6 2021-10-21T21:59:02.349Z,1634853542.349 [CommandExec](IMPORTANT): got command ! echo 0 > /dev/loadA6 2021-10-21T21:59:02.732Z,1634853542.732 [CBIT](INFO): Critical error at 20211021T215902 2021-10-21T21:59:03.513Z,1634853543.513 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2021-10-21T21:59:03.513Z,1634853543.513 [DropWeight] Hardware Fault, FailCount= 1 2021-10-21T21:59:03.513Z,1634853543.513 [DropWeight](ERROR): Hardware Fault 2021-10-21T21:59:03.584Z,1634853543.584 [CBIT](INFO): Critical error at 20211021T215903 2021-10-21T21:59:03.586Z,1634853543.586 [CBIT](ERROR): Hardware Fault in component: DropWeight 2021-10-21T21:59:03.587Z,1634853543.587 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2021-10-21T21:59:03.947Z,1634853543.947 [CBIT](INFO): Critical error at 20211021T215903 2021-10-21T21:59:08.472Z,1634853548.472 [DataOverHttps](INFO): Sending 194 bytes from file Logs/20211021T212648/Express0011.lzma 2021-10-21T21:59:09.163Z,1634853549.163 [NAL9602](FAULT): GPS failed to acquire within timeout. 2021-10-21T21:59:09.163Z,1634853549.163 [NAL9602] Data Fault, FailCount= 3 2021-10-21T21:59:09.163Z,1634853549.163 [NAL9602](ERROR): Data Fault 2021-10-21T21:59:09.210Z,1634853549.210 [CBIT](ERROR): Data Fault in component: NAL9602 2021-10-21T21:59:09.473Z,1634853549.473 [DataOverHttps](INFO): Moved sent file to Logs/20211021T212648/Express0011.lzma.bak 2021-10-21T21:59:09.474Z,1634853549.474 [DataOverHttps](INFO): SBD MOMSN=16044962 2021-10-21T21:59:09.569Z,1634853549.569 [NAL9602](INFO): Powering down 2021-10-21T21:59:10.395Z,1634853550.395 [CBIT](INFO): Clearing failed state for component NAL9602 2021-10-21T21:59:10.395Z,1634853550.395 [NAL9602] No Fault, FailCount= 3 2021-10-21T21:59:11.598Z,1634853551.598 [Default:CheckIn:Read_Iridium] Stopped 2021-10-21T21:59:11.598Z,1634853551.598 [Default:CheckIn:C.Wait] Running Loop=1 2021-10-21T21:59:11.599Z,1634853551.599 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2021-10-21T21:59:39.869Z,1634853579.869 [NAL9602](INFO): Powering up NAL9602 2021-10-21T21:59:50.781Z,1634853590.781 [NAL9602](INFO): NAL9602 initialized 2021-10-21T22:00:09.396Z,1634853609.396 [DeadReckonUsingMultipleVelocitySources] Software Fault, FailCount= 11 2021-10-21T22:00:09.396Z,1634853609.396 [DeadReckonUsingMultipleVelocitySources](ERROR): Software Fault 2021-10-21T22:00:09.408Z,1634853609.408 [CBIT](ERROR): Software Fault in component: DeadReckonUsingMultipleVelocitySources 2021-10-21T22:00:09.806Z,1634853609.806 [CBIT](INFO): Clearing failed state for component DeadReckonUsingMultipleVelocitySources 2021-10-21T22:00:09.806Z,1634853609.806 [DeadReckonUsingMultipleVelocitySources] No Fault, FailCount= 11 2021-10-21T22:00:32.585Z,1634853632.585 [CommandExec](IMPORTANT): got command restart system 2021-10-21T22:00:34.716Z,1634853634.716 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-21T22:00:34.716Z,1634853634.716 [CommandExec](INFO): Uninitializing the command executive. 2021-10-21T22:00:34.716Z,1634853634.716 [CommandExec](INFO): Uninitializing the command scheduler. 2021-10-21T22:00:34.716Z,1634853634.716 [CommandExec ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:34.825Z,1634853634.825 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2021-10-21T22:00:34.825Z,1634853634.825 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2021-10-21T22:00:34.825Z,1634853634.825 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:34.826Z,1634853634.826 [NavChartDb](INFO): Join timeout helper Thread ID is 992 2021-10-21T22:00:34.941Z,1634853634.941 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-21T22:00:34.941Z,1634853634.941 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:34.952Z,1634853634.952 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2021-10-21T22:00:34.952Z,1634853634.952 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:34.953Z,1634853634.953 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 993 2021-10-21T22:00:35.204Z,1634853635.204 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-21T22:00:35.204Z,1634853635.204 [WetLabsBB2FL](INFO): Powering down 2021-10-21T22:00:35.205Z,1634853635.205 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:35.216Z,1634853635.216 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2021-10-21T22:00:35.216Z,1634853635.216 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:35.216Z,1634853635.216 [CTD_Seabird](INFO): Join timeout helper Thread ID is 994 2021-10-21T22:00:35.656Z,1634853635.656 [CTD_Seabird](INFO): Powering down 2021-10-21T22:00:35.669Z,1634853635.669 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-21T22:00:35.669Z,1634853635.669 [CTD_Seabird](INFO): Powering down 2021-10-21T22:00:35.684Z,1634853635.684 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:35.700Z,1634853635.700 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2021-10-21T22:00:35.700Z,1634853635.700 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:35.700Z,1634853635.700 [Radio_Surface](INFO): Join timeout helper Thread ID is 995 2021-10-21T22:00:35.748Z,1634853635.748 [Radio_Surface](INFO): Powering down 2021-10-21T22:00:35.749Z,1634853635.749 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-21T22:00:35.749Z,1634853635.749 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:35.764Z,1634853635.764 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 2021-10-21T22:00:35.764Z,1634853635.764 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:35.764Z,1634853635.764 [Onboard](INFO): Join timeout helper Thread ID is 996 2021-10-21T22:00:36.820Z,1634853636.820 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-21T22:00:36.820Z,1634853636.820 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:36.829Z,1634853636.829 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2021-10-21T22:00:36.829Z,1634853636.829 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:36.829Z,1634853636.829 [DataOverHttps](INFO): Join timeout helper Thread ID is 997 2021-10-21T22:00:36.966Z,1634853636.966 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-21T22:00:36.973Z,1634853636.973 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:36.984Z,1634853636.984 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler 2021-10-21T22:00:36.985Z,1634853636.985 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:36.985Z,1634853636.985 [BackseatComponent](INFO): Join timeout helper Thread ID is 998 2021-10-21T22:00:37.036Z,1634853637.036 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-21T22:00:37.036Z,1634853637.036 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:37.045Z,1634853637.045 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2021-10-21T22:00:37.045Z,1634853637.045 [logger ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:37.045Z,1634853637.045 [logger](INFO): Join timeout helper Thread ID is 999 2021-10-21T22:00:37.058Z,1634853637.058 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-21T22:00:37.058Z,1634853637.058 [logger ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:37.076Z,1634853637.076 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2021-10-21T22:00:37.076Z,1634853637.076 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:37.077Z,1634853637.077 [CommandLine](INFO): Join timeout helper Thread ID is 1000 2021-10-21T22:00:37.152Z,1634853637.152 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-21T22:00:37.152Z,1634853637.152 [CommandLine ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:37.156Z,1634853637.156 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 2021-10-21T22:00:37.156Z,1634853637.156 [CommandExec ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:37.157Z,1634853637.157 [CommandExec](INFO): Join timeout helper Thread ID is 1001 2021-10-21T22:00:37.158Z,1634853637.158 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2021-10-21T22:00:37.158Z,1634853637.158 [controlThread ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:37.158Z,1634853637.158 [controlThread](INFO): Join timeout helper Thread ID is 1002 2021-10-21T22:00:37.244Z,1634853637.244 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2021-10-21T22:00:37.245Z,1634853637.245 [controlThread](DEBUG): Uninitializing ControlThread 2021-10-21T22:00:37.245Z,1634853637.245 [AHRS_M2](INFO): Powering down 2021-10-21T22:00:37.317Z,1634853637.317 [NAL9602](INFO): Powering down 2021-10-21T22:00:37.319Z,1634853637.319 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2021-10-21T22:00:37.321Z,1634853637.321 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2021-10-21T22:00:37.321Z,1634853637.321 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2021-10-21T22:00:37.322Z,1634853637.322 [MissionManager](INFO): Uninitializing Mission Default 2021-10-21T22:00:37.322Z,1634853637.322 [Default] Stopped 2021-10-21T22:00:37.322Z,1634853637.322 [Default](DEBUG): Aggregate::uninitialize Default 2021-10-21T22:00:37.322Z,1634853637.322 [Default:B.GoToSurface] Stopped 2021-10-21T22:00:37.322Z,1634853637.322 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2021-10-21T22:00:37.322Z,1634853637.322 [Default:CheckIn] Stopped 2021-10-21T22:00:37.322Z,1634853637.322 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2021-10-21T22:00:37.323Z,1634853637.323 [Default:CheckIn:C.Wait] Stopped 2021-10-21T22:00:37.323Z,1634853637.323 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2021-10-21T22:00:37.327Z,1634853637.327 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2021-10-21T22:00:37.327Z,1634853637.327 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2021-10-21T22:00:37.327Z,1634853637.327 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2021-10-21T22:00:37.328Z,1634853637.328 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2021-10-21T22:00:37.328Z,1634853637.328 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2021-10-21T22:00:37.328Z,1634853637.328 [BuoyancyServo](INFO): Powering down 2021-10-21T22:00:37.340Z,1634853637.340 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2021-10-21T22:00:37.340Z,1634853637.340 [ElevatorServo](INFO): Powering down 2021-10-21T22:00:37.341Z,1634853637.341 [MassServo](DEBUG): Uninitialize Mass Servo. 2021-10-21T22:00:37.341Z,1634853637.341 [MassServo](INFO): Powering down 2021-10-21T22:00:37.342Z,1634853637.342 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2021-10-21T22:00:37.342Z,1634853637.342 [RudderServo](INFO): Powering down 2021-10-21T22:00:37.343Z,1634853637.343 [SBIT](DEBUG): Uninitialize SBIT Component. 2021-10-21T22:00:37.343Z,1634853637.343 [IBIT](DEBUG): Uninitialize IBIT Component. 2021-10-21T22:00:37.344Z,1634853637.344 [CBIT](DEBUG): Uninitialize CBIT Component. 2021-10-21T22:00:37.344Z,1634853637.344 [CBIT](DEBUG): Powering off loads. 2021-10-21T22:00:37.356Z,1634853637.356 [CBIT](DEBUG): Disabling WDT. 2021-10-21T22:00:37.368Z,1634853637.368 [CBIT](DEBUG): Opening all GF detection circuits. 2021-10-21T22:00:37.369Z,1634853637.369 [controlThread ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:37.416Z,1634853637.416 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:37.419Z,1634853637.419 [Onboard ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:37.426Z,1634853637.426 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:37.474Z,1634853637.474 [BackseatComponent ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:37.508Z,1634853637.508 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:37.514Z,1634853637.514 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:37.549Z,1634853637.549 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2021-10-21T22:00:37.614Z,1634853637.614 [logger ThreadHandler](INFO): Thread cancelled.