2022-04-20T15:16:09.926Z,1650467769.926 [Supervisor](DEBUG): Initializing supervisor.
2022-04-20T15:16:09.931Z,1650467769.931 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2022-04-20T15:16:09.931Z,1650467769.931 [SyncHandler](INFO): Protected caller Thread ID is 9610
2022-04-20T15:16:09.932Z,1650467769.932 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2022-04-20T15:16:09.933Z,1650467769.933 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2022-04-20T15:16:09.933Z,1650467769.933 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 9611
2022-04-20T15:16:09.937Z,1650467769.937 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2022-04-20T15:16:09.955Z,1650467769.955 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread.
2022-04-20T15:16:09.956Z,1650467769.956 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2022-04-20T15:16:09.956Z,1650467769.956 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 9612
2022-04-20T15:16:09.960Z,1650467769.960 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2022-04-20T15:16:09.961Z,1650467769.961 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2022-04-20T15:16:09.962Z,1650467769.962 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 9613
2022-04-20T15:16:09.964Z,1650467769.964 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2022-04-20T15:16:09.965Z,1650467769.965 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0
2022-04-20T15:16:09.965Z,1650467769.965 [logger ThreadHandler](INFO): Protected caller Thread ID is 9614
2022-04-20T15:16:09.969Z,1650467769.969 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2022-04-20T15:16:09.969Z,1650467769.969 [Supervisor](INFO): Looking for Config files in directory: Config/
2022-04-20T15:16:09.975Z,1650467769.975 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2022-04-20T15:16:10.527Z,1650467770.527 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2022-04-20T15:16:10.529Z,1650467770.529 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2022-04-20T15:16:10.611Z,1650467770.611 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2022-04-20T15:16:10.987Z,1650467770.987 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2022-04-20T15:16:10.988Z,1650467770.988 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2022-04-20T15:16:11.351Z,1650467771.351 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2022-04-20T15:16:11.354Z,1650467771.354 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2022-04-20T15:16:11.564Z,1650467771.564 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2022-04-20T15:16:11.565Z,1650467771.565 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2022-04-20T15:16:12.148Z,1650467772.148 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2022-04-20T15:16:12.150Z,1650467772.150 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2022-04-20T15:16:12.434Z,1650467772.434 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2022-04-20T15:16:12.436Z,1650467772.436 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2022-04-20T15:16:12.665Z,1650467772.665 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2022-04-20T15:16:12.667Z,1650467772.667 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2022-04-20T15:16:12.871Z,1650467772.871 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2022-04-20T15:16:12.873Z,1650467772.873 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2022-04-20T15:16:12.972Z,1650467772.972 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2022-04-20T15:16:12.973Z,1650467772.973 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2022-04-20T15:16:13.207Z,1650467773.207 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2022-04-20T15:16:13.209Z,1650467773.209 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2022-04-20T15:16:13.630Z,1650467773.630 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2022-04-20T15:16:13.630Z,1650467773.630 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2022-04-20T15:16:13.714Z,1650467773.714 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2022-04-20T15:16:13.846Z,1650467773.846 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2022-04-20T15:16:13.846Z,1650467773.846 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2022-04-20T15:16:14.593Z,1650467774.593 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2022-04-20T15:16:14.593Z,1650467774.593 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2022-04-20T15:16:14.985Z,1650467774.985 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2022-04-20T15:16:14.987Z,1650467774.987 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-polaris/
2022-04-20T15:16:14.992Z,1650467774.992 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/vehicle.cfg
2022-04-20T15:16:15.206Z,1650467775.206 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Control.cfg
2022-04-20T15:16:15.311Z,1650467775.311 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Estimation.cfg
2022-04-20T15:16:15.415Z,1650467775.415 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/BIT.cfg
2022-04-20T15:16:15.519Z,1650467775.519 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Battery.cfg
2022-04-20T15:16:15.796Z,1650467775.796 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2022-04-20T15:16:15.796Z,1650467775.796 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Simulator.cfg
2022-04-20T15:16:15.911Z,1650467775.911 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Navigation.cfg
2022-04-20T15:16:16.349Z,1650467776.349 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Derivation.cfg
2022-04-20T15:16:16.817Z,1650467776.817 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/logger.cfg
2022-04-20T15:16:16.939Z,1650467776.939 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/secure.cfg
2022-04-20T15:16:17.027Z,1650467777.027 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Dock.cfg
2022-04-20T15:16:17.116Z,1650467777.116 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Servo.cfg
2022-04-20T15:16:17.233Z,1650467777.233 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/workSite.cfg
2022-04-20T15:16:17.336Z,1650467777.336 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Sensor.cfg
2022-04-20T15:16:17.558Z,1650467777.558 [Supervisor](INFO): Opening Config file at: Config/lrauv-polaris/Science.cfg
2022-04-20T15:16:17.729Z,1650467777.729 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2022-04-20T15:16:17.743Z,1650467777.743 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2022-04-20T15:16:18.196Z,1650467778.196 [AHRS_M2] Loaded
2022-04-20T15:16:18.196Z,1650467778.196 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2022-04-20T15:16:18.232Z,1650467778.232 [BackseatComponent] Loaded
2022-04-20T15:16:18.232Z,1650467778.232 [ComponentRegistry](DEBUG): Component "BackseatComponent" handled in its own thread.
2022-04-20T15:16:18.233Z,1650467778.233 [BackseatComponent ThreadHandler](DEBUG): Created PCaller Thread at 407E14E0
2022-04-20T15:16:18.233Z,1650467778.233 [BackseatComponent ThreadHandler](INFO): Protected caller Thread ID is 9708
2022-04-20T15:16:18.236Z,1650467778.236 [LcmUniversalReporter] Loaded
2022-04-20T15:16:18.236Z,1650467778.236 [ComponentRegistry](DEBUG): SyncComponent "LcmUniversalReporter" handled in the control thread.
2022-04-20T15:16:19.050Z,1650467779.050 [BPC1] Loaded
2022-04-20T15:16:19.051Z,1650467779.051 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2022-04-20T15:16:19.124Z,1650467779.124 [DataOverHttps] Loaded
2022-04-20T15:16:19.124Z,1650467779.124 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2022-04-20T15:16:19.126Z,1650467779.126 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408114E0
2022-04-20T15:16:19.126Z,1650467779.126 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 9709
2022-04-20T15:16:19.146Z,1650467779.146 [Depth_Keller] Loaded
2022-04-20T15:16:19.146Z,1650467779.146 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2022-04-20T15:16:19.151Z,1650467779.151 [DropWeight] Loaded
2022-04-20T15:16:19.151Z,1650467779.151 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2022-04-20T15:16:19.211Z,1650467779.211 [NAL9602] Loaded
2022-04-20T15:16:19.212Z,1650467779.212 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2022-04-20T15:16:19.240Z,1650467779.240 [Onboard] Loaded
2022-04-20T15:16:19.241Z,1650467779.241 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2022-04-20T15:16:19.242Z,1650467779.242 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408414E0
2022-04-20T15:16:19.242Z,1650467779.242 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 9710
2022-04-20T15:16:19.249Z,1650467779.249 [PowerOnly](INFO): Adding load control power supply at /dev/loadC1
2022-04-20T15:16:19.259Z,1650467779.259 [PowerOnly] Loaded
2022-04-20T15:16:19.260Z,1650467779.260 [ComponentRegistry](DEBUG): SyncComponent "PowerOnly" handled in the control thread.
2022-04-20T15:16:19.271Z,1650467779.271 [Power24vConverter] Loaded
2022-04-20T15:16:19.271Z,1650467779.271 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread.
2022-04-20T15:16:19.286Z,1650467779.286 [Radio_Surface] Loaded
2022-04-20T15:16:19.286Z,1650467779.286 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2022-04-20T15:16:19.287Z,1650467779.287 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408714E0
2022-04-20T15:16:19.288Z,1650467779.288 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 9711
2022-04-20T15:16:19.331Z,1650467779.331 [RDI_Pathfinder] Loaded
2022-04-20T15:16:19.331Z,1650467779.331 [ComponentRegistry](DEBUG): SyncComponent "RDI_Pathfinder" handled in the control thread.
2022-04-20T15:16:19.359Z,1650467779.359 [RDI_PathfinderUp] Loaded
2022-04-20T15:16:19.359Z,1650467779.359 [ComponentRegistry](DEBUG): SyncComponent "RDI_PathfinderUp" handled in the control thread.
2022-04-20T15:16:19.360Z,1650467779.360 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2022-04-20T15:16:19.360Z,1650467779.360 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2022-04-20T15:16:19.371Z,1650467779.371 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2022-04-20T15:16:19.372Z,1650467779.372 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2022-04-20T15:16:19.489Z,1650467779.489 [DeadReckonUsingMultipleVelocitySources] Loaded
2022-04-20T15:16:19.489Z,1650467779.489 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2022-04-20T15:16:19.519Z,1650467779.519 [LBLNavigation] Loaded
2022-04-20T15:16:19.520Z,1650467779.520 [ComponentRegistry](DEBUG): SyncComponent "LBLNavigation" handled in the control thread.
2022-04-20T15:16:19.533Z,1650467779.533 [NavChart] Loaded
2022-04-20T15:16:19.533Z,1650467779.533 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2022-04-20T15:16:19.539Z,1650467779.539 [UniversalFixResidualReporter] Loaded
2022-04-20T15:16:19.539Z,1650467779.539 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2022-04-20T15:16:19.550Z,1650467779.550 [WorkSite] Loaded
2022-04-20T15:16:19.550Z,1650467779.550 [ComponentRegistry](DEBUG): SyncComponent "WorkSite" handled in the control thread.
2022-04-20T15:16:19.551Z,1650467779.551 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2022-04-20T15:16:19.551Z,1650467779.551 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2022-04-20T15:16:19.656Z,1650467779.656 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2022-04-20T15:16:19.656Z,1650467779.656 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2022-04-20T15:16:19.796Z,1650467779.796 [BuoyancyServo] Loaded
2022-04-20T15:16:19.796Z,1650467779.796 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2022-04-20T15:16:19.818Z,1650467779.818 [ElevatorServo] Loaded
2022-04-20T15:16:19.819Z,1650467779.819 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2022-04-20T15:16:19.840Z,1650467779.840 [MassServo] Loaded
2022-04-20T15:16:19.840Z,1650467779.840 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2022-04-20T15:16:19.860Z,1650467779.860 [RudderServo] Loaded
2022-04-20T15:16:19.861Z,1650467779.861 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2022-04-20T15:16:19.877Z,1650467779.877 [ThrusterHE] Loaded
2022-04-20T15:16:19.878Z,1650467779.878 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread.
2022-04-20T15:16:19.878Z,1650467779.878 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2022-04-20T15:16:19.879Z,1650467779.879 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2022-04-20T15:16:20.063Z,1650467780.063 [CTD_Seabird] Loaded
2022-04-20T15:16:20.063Z,1650467780.063 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2022-04-20T15:16:20.064Z,1650467780.064 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 409AF4E0
2022-04-20T15:16:20.065Z,1650467780.065 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 9712
2022-04-20T15:16:20.085Z,1650467780.085 [PAR_Licor] Loaded
2022-04-20T15:16:20.086Z,1650467780.086 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2022-04-20T15:16:20.118Z,1650467780.118 [WetLabsSeaOWL_UV_A] Loaded
2022-04-20T15:16:20.119Z,1650467780.119 [ComponentRegistry](DEBUG): Component "WetLabsSeaOWL_UV_A" handled in its own thread.
2022-04-20T15:16:20.120Z,1650467780.120 [WetLabsSeaOWL_UV_A ThreadHandler](DEBUG): Created PCaller Thread at 409DF4E0
2022-04-20T15:16:20.120Z,1650467780.120 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Protected caller Thread ID is 9713
2022-04-20T15:16:20.121Z,1650467780.121 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2022-04-20T15:16:20.121Z,1650467780.121 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2022-04-20T15:16:20.470Z,1650467780.470 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2022-04-20T15:16:20.470Z,1650467780.470 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2022-04-20T15:16:20.526Z,1650467780.526 [DepthRateCalculator] Loaded
2022-04-20T15:16:20.526Z,1650467780.526 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2022-04-20T15:16:20.531Z,1650467780.531 [PitchRateCalculator] Loaded
2022-04-20T15:16:20.532Z,1650467780.532 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2022-04-20T15:16:20.541Z,1650467780.541 [SpeedCalculator] Loaded
2022-04-20T15:16:20.541Z,1650467780.541 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2022-04-20T15:16:20.555Z,1650467780.555 [TempGradientCalculator] Loaded
2022-04-20T15:16:20.555Z,1650467780.555 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2022-04-20T15:16:20.571Z,1650467780.571 [VerticalHomogeneityIndexCalculator] Loaded
2022-04-20T15:16:20.571Z,1650467780.571 [ComponentRegistry](DEBUG): SyncComponent "VerticalHomogeneityIndexCalculator" handled in the control thread.
2022-04-20T15:16:20.576Z,1650467780.576 [YawRateCalculator] Loaded
2022-04-20T15:16:20.576Z,1650467780.576 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2022-04-20T15:16:20.599Z,1650467780.599 [ElevatorOffsetCalculator] Loaded
2022-04-20T15:16:20.599Z,1650467780.599 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2022-04-20T15:16:20.600Z,1650467780.600 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2022-04-20T15:16:20.600Z,1650467780.600 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2022-04-20T15:16:20.764Z,1650467780.764 [SBIT](DEBUG): Construct Startup Built In Test.
2022-04-20T15:16:20.776Z,1650467780.776 [SBIT] Loaded
2022-04-20T15:16:20.776Z,1650467780.776 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2022-04-20T15:16:20.779Z,1650467780.779 [IBIT](DEBUG): Construct Initiated Built In Test.
2022-04-20T15:16:20.793Z,1650467780.793 [IBIT] Loaded
2022-04-20T15:16:20.793Z,1650467780.793 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2022-04-20T15:16:20.799Z,1650467780.799 [CBIT](DEBUG): Construct Continuous Built In Test.
2022-04-20T15:16:20.907Z,1650467780.907 [CBIT] Loaded
2022-04-20T15:16:20.907Z,1650467780.907 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2022-04-20T15:16:20.907Z,1650467780.907 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2022-04-20T15:16:20.908Z,1650467780.908 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2022-04-20T15:16:20.975Z,1650467780.975 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2022-04-20T15:16:20.976Z,1650467780.976 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2022-04-20T15:16:21.110Z,1650467781.110 [InternalEnvSim] Loaded
2022-04-20T15:16:21.110Z,1650467781.110 [ComponentRegistry](DEBUG): SyncComponent "InternalEnvSim" handled in the control thread.
2022-04-20T15:16:21.111Z,1650467781.111 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2022-04-20T15:16:21.111Z,1650467781.111 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2022-04-20T15:16:21.199Z,1650467781.199 [VerticalControl](DEBUG): Construct VerticalControl.
2022-04-20T15:16:21.261Z,1650467781.261 [VerticalControl] Loaded
2022-04-20T15:16:21.262Z,1650467781.262 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2022-04-20T15:16:21.309Z,1650467781.309 [HorizontalControl](DEBUG): Construct HorizontalControl.
2022-04-20T15:16:21.441Z,1650467781.441 [HorizontalControl] Loaded
2022-04-20T15:16:21.442Z,1650467781.442 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2022-04-20T15:16:21.444Z,1650467781.444 [SpeedControl](DEBUG): Construct SpeedControl.
2022-04-20T15:16:21.446Z,1650467781.446 [SpeedControl] Loaded
2022-04-20T15:16:21.446Z,1650467781.446 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2022-04-20T15:16:21.449Z,1650467781.449 [LoopControl](DEBUG): Construct LoopControl.
2022-04-20T15:16:21.450Z,1650467781.450 [LoopControl] Loaded
2022-04-20T15:16:21.450Z,1650467781.450 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2022-04-20T15:16:21.461Z,1650467781.461 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2022-04-20T15:16:21.462Z,1650467781.462 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2022-04-20T15:16:21.532Z,1650467781.532 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2022-04-20T15:16:21.561Z,1650467781.561 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2022-04-20T15:16:21.564Z,1650467781.564 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2022-04-20T15:16:21.577Z,1650467781.577 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2022-04-20T15:16:21.578Z,1650467781.578 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BA64E0
2022-04-20T15:16:21.578Z,1650467781.578 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 9714
2022-04-20T15:16:21.784Z,1650467781.784 [Supervisor](INFO): Main Thread ID is 829
2022-04-20T15:16:21.785Z,1650467781.785 [Supervisor](DEBUG): Running supervisor.
2022-04-20T15:16:21.785Z,1650467781.785 [CommandExec ThreadHandler](INFO): Handler Thread ID is 9715
2022-04-20T15:16:21.786Z,1650467781.786 [CommandExec](INFO): Initializing the command executive.
2022-04-20T15:16:21.787Z,1650467781.787 [CommandLine ThreadHandler](INFO): Handler Thread ID is 9716
2022-04-20T15:16:21.790Z,1650467781.790 [controlThread ThreadHandler](INFO): Handler Thread ID is 9717
2022-04-20T15:16:21.790Z,1650467781.790 [controlThread](DEBUG): Initializing ControlThread
2022-04-20T15:16:21.796Z,1650467781.796 [NavChart](DEBUG): Initialize NavChart Navigation.
2022-04-20T15:16:21.796Z,1650467781.796 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2022-04-20T15:16:21.796Z,1650467781.796 [WorkSite](DEBUG): Initializing WorkSite component.
2022-04-20T15:16:21.801Z,1650467781.801 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2022-04-20T15:16:21.801Z,1650467781.801 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2022-04-20T15:16:21.802Z,1650467781.802 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2022-04-20T15:16:21.802Z,1650467781.802 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2022-04-20T15:16:21.803Z,1650467781.803 [VerticalHomogeneityIndexCalculator](DEBUG): (re)initializing
2022-04-20T15:16:21.803Z,1650467781.803 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2022-04-20T15:16:21.804Z,1650467781.804 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2022-04-20T15:16:21.805Z,1650467781.805 [SBIT](INFO): Initialize SBIT Component.
2022-04-20T15:16:21.805Z,1650467781.805 [SBIT](IMPORTANT): git: 2022-04-13
2022-04-20T15:16:21.805Z,1650467781.805 [SBIT](INFO): git hash: d1e60664077c229c1f2059d1d9396c3c0e4e8f0d
2022-04-20T15:16:21.806Z,1650467781.806 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2022-04-20T15:16:21.807Z,1650467781.807 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Thu Aug 6 12:04:53 PDT 2020
2022-04-20T15:16:21.808Z,1650467781.808 [SBIT](INFO): Beginning SBIT in 28.000000 seconds.
2022-04-20T15:16:21.808Z,1650467781.808 [IBIT](INFO): Initialize IBIT Component.
2022-04-20T15:16:21.809Z,1650467781.809 [CBIT](DEBUG): Initialize CBIT Component.
2022-04-20T15:16:21.810Z,1650467781.810 [logger ThreadHandler](INFO): Handler Thread ID is 9718
2022-04-20T15:16:21.821Z,1650467781.821 [CBIT](DEBUG): Initialized mux pins.
2022-04-20T15:16:21.821Z,1650467781.821 [CBIT](DEBUG): Initializing the watchdog timer.
2022-04-20T15:16:21.829Z,1650467781.829 [BackseatComponent ThreadHandler](INFO): Handler Thread ID is 9719
2022-04-20T15:16:21.841Z,1650467781.841 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 9720
2022-04-20T15:16:21.842Z,1650467781.842 [DataOverHttps](DEBUG): dashIP=128.128.181.226 starts with a digit so assuming it is a numeric IP
2022-04-20T15:16:21.845Z,1650467781.845 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2022-04-20T15:16:21.845Z,1650467781.845 [CBIT](DEBUG): Initializing heartbeat.
2022-04-20T15:16:21.853Z,1650467781.853 [Onboard ThreadHandler](INFO): Handler Thread ID is 9721
2022-04-20T15:16:21.871Z,1650467781.871 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 9722
2022-04-20T15:16:21.890Z,1650467781.890 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 9723
2022-04-20T15:16:21.890Z,1650467781.890 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2022-04-20T15:16:21.894Z,1650467781.894 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Handler Thread ID is 9725
2022-04-20T15:16:21.901Z,1650467781.901 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 9726
2022-04-20T15:16:21.910Z,1650467781.910 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2022-04-20T15:16:21.910Z,1650467781.910 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2022-04-20T15:16:21.910Z,1650467781.910 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2022-04-20T15:16:21.911Z,1650467781.911 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2022-04-20T15:16:21.911Z,1650467781.911 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2022-04-20T15:16:21.911Z,1650467781.911 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2022-04-20T15:16:21.911Z,1650467781.911 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2022-04-20T15:16:21.911Z,1650467781.911 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2022-04-20T15:16:21.911Z,1650467781.911 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2022-04-20T15:16:21.912Z,1650467781.912 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2022-04-20T15:16:21.912Z,1650467781.912 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2022-04-20T15:16:21.912Z,1650467781.912 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2022-04-20T15:16:21.912Z,1650467781.912 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2022-04-20T15:16:21.912Z,1650467781.912 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2022-04-20T15:16:21.913Z,1650467781.913 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2022-04-20T15:16:21.913Z,1650467781.913 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2022-04-20T15:16:21.917Z,1650467781.917 [CBIT](DEBUG): Deactivating GF circuits.
2022-04-20T15:16:21.917Z,1650467781.917 [CBIT](DEBUG): Deactivating emergency mode.
2022-04-20T15:16:21.953Z,1650467781.953 [CBIT](DEBUG): Backplane powered.
2022-04-20T15:16:21.953Z,1650467781.953 [InternalEnvSim](DEBUG):  InternaEnvlSim initializing...
2022-04-20T15:16:22.098Z,1650467782.098 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2022-04-20T15:16:22.100Z,1650467782.100 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2022-04-20T15:16:22.120Z,1650467782.120 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2022-04-20T15:16:22.121Z,1650467782.121 [LoopControl](DEBUG): Initialize LoopControlComponent.
2022-04-20T15:16:22.122Z,1650467782.122 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml
2022-04-20T15:16:22.152Z,1650467782.152 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2022-04-20T15:16:22.199Z,1650467782.199 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns="Tethys"
       xmlns:Control="Tethys/Control"
       xmlns:Guidance="Tethys/Guidance" 
       xmlns:Units="Tethys/Units"
       xmlns:Universal="Tethys/Universal"
       xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
       xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                           Tethys/Control http://okeanids.mbari.org/tethys/Xml/Control.xsd
                           Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                           Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                           Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
       Id="Startup">

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="StartupSatComms">

        <Sequence/>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:latitude_fix/>
        </ReadDatum>

        <ReadDatum>
            <Timeout Duration="P1M" />
            <Universal:platform_communications/>
        </ReadDatum>

    </Aggregate>

</Mission>


2022-04-20T15:16:22.200Z,1650467782.200 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml
2022-04-20T15:16:22.260Z,1650467782.260 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2022-04-20T15:16:22.273Z,1650467782.273 [Default:A.Wait](DEBUG): Construct Wait.
2022-04-20T15:16:22.276Z,1650467782.276 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2022-04-20T15:16:22.277Z,1650467782.277 [Radio_Surface](INFO): Powering up
2022-04-20T15:16:22.326Z,1650467782.326 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2022-04-20T15:16:22.328Z,1650467782.328 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2022-04-20T15:16:22.354Z,1650467782.354 [Default:E.Execute](DEBUG): Construct Execute.
2022-04-20T15:16:22.358Z,1650467782.358 [MissionManager](DEBUG): 
<?xml version="1.0" encoding="UTF-8"?>
<Mission xmlns:xsi="http://www.w3.org/2001/XMLSchema-instance"
         xmlns="Tethys"
         xmlns:Units="Tethys/Units"
         xmlns:Guidance="Tethys/Guidance"
         xmlns:Universal="Tethys/Universal"
         xsi:schemaLocation="Tethys http://okeanids.mbari.org/tethys/Xml/Tethys.xsd
                             Tethys/Units http://okeanids.mbari.org/tethys/Xml/Units.xsd
                             Tethys/Guidance http://okeanids.mbari.org/tethys/Xml/Guidance.xsd
                             Tethys/Universal http://okeanids.mbari.org/tethys/Xml/Universal.xsd"
         Id="Default">

    <DefineArg Name="ElapsedSinceDefaultStarted"><Units:minute/><Value>0</Value></DefineArg>

    <Guidance:Wait>
        <Description>
            Wait a moment to see if the scheduler starts a new mission before
            starting to actually run Default.
        </Description>
        <Sequence/>
        <Setting><Guidance:Wait.duration/><Units:second/><Value>13</Value></Setting>
    </Guidance:Wait>

    <Guidance:GoToSurface>
        <Progression/>
    </Guidance:GoToSurface>

    <Aggregate Id="CheckIn">

        <Sequence Repeat="288"/>

        <ReadDatum Id="Read_GPS">
            <Timeout Duration="P5M"/>
            <Universal:time_fix/>
        </ReadDatum>

        <ReadDatum Id="Read_Iridium">
            <Timeout Duration="P2H">
                <Guidance:Execute>
                    <Sequence/>
                    <Setting><Guidance:Execute.command/><String>Burn on</String></Setting>
                </Guidance:Execute>
                <Syslog Severity="Critical">Dropped weight due to communications timeout.</Syslog>
            </Timeout>
            <Universal:platform_communications/>
        </ReadDatum>

        <Guidance:Wait>
            <Sequence/>
            <Setting><Guidance:Wait.duration/><Units:minute/><Value>5</Value></Setting>
        </Guidance:Wait>

        <Assign><Sequence/><Arg Name="ElapsedSinceDefaultStarted"/><Elapsed><Universal:mission_started/></Elapsed></Assign>

        <Syslog Severity="Important">Default mission has been running for <Arg Name="ElapsedSinceDefaultStarted"/><Units:minute/></Syslog>

    </Aggregate>

    <Syslog Severity="Important">Restarting logs and Default mission.</Syslog>

    <Guidance:Execute>
        <Sequence/>
        <Setting><Guidance:Execute.command/><String>restart logs</String></Setting>
    </Guidance:Execute>

</Mission>


2022-04-20T15:16:22.363Z,1650467782.363 [controlThread](DEBUG): Component order: CycleStarter,InternalEnvSim,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,PowerOnly,Power24vConverter,RDI_Pathfinder,RDI_PathfinderUp,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,VerticalHomogeneityIndexCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,WorkSite,LBLNavigation,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,LcmUniversalReporter,Reporter,LogSplitter,
2022-04-20T15:16:22.381Z,1650467782.381 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2022-04-20T15:16:22.555Z,1650467782.555 [Power24vConverter](INFO): Powering up.
2022-04-20T15:16:22.606Z,1650467782.606 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2022-04-20T15:16:22.613Z,1650467782.613 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2022-04-20T15:16:22.614Z,1650467782.614 [ElevatorServo](DEBUG): Initializing EZServoServo.
2022-04-20T15:16:22.625Z,1650467782.625 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2022-04-20T15:16:22.626Z,1650467782.626 [MassServo](DEBUG): Initializing EZServoServo.
2022-04-20T15:16:22.633Z,1650467782.633 [MassServo](DEBUG): Initializing MassServo.
2022-04-20T15:16:22.634Z,1650467782.634 [RudderServo](DEBUG): Initializing EZServoServo.
2022-04-20T15:16:22.641Z,1650467782.641 [RudderServo](DEBUG): Initializing RudderServo.
2022-04-20T15:16:22.642Z,1650467782.642 [ThrusterHE](DEBUG): Initializing EZServoServo.
2022-04-20T15:16:22.649Z,1650467782.649 [ThrusterHE](DEBUG): Initializing ThrusterHE.
2022-04-20T15:16:22.798Z,1650467782.798 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2022-04-20T15:16:22.798Z,1650467782.798 [DropWeight] Hardware Fault, FailCount= 1
2022-04-20T15:16:22.798Z,1650467782.798 [DropWeight](ERROR): Hardware Fault
2022-04-20T15:16:22.871Z,1650467782.871 [CommandExec](FAULT): Scheduling is paused
2022-04-20T15:16:22.872Z,1650467782.872 [CBIT](INFO): Critical error at 20220420T151622
2022-04-20T15:16:22.872Z,1650467782.872 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2022-04-20T15:16:22.882Z,1650467782.882 [CBIT](ERROR): Hardware Fault in component: DropWeight
2022-04-20T15:16:22.883Z,1650467782.883 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2022-04-20T15:16:23.509Z,1650467783.509 [RudderServo](ERROR): Rudder initialization uart error serial timeout
2022-04-20T15:16:23.509Z,1650467783.509 [RudderServo](FAULT): Rudder failed to initialize
2022-04-20T15:16:23.509Z,1650467783.509 [RudderServo] Communications Fault, FailCount= 1
2022-04-20T15:16:23.509Z,1650467783.509 [RudderServo](ERROR): Communications Fault
2022-04-20T15:16:23.511Z,1650467783.511 [CBIT](INFO): Critical error at 20220420T151622
2022-04-20T15:16:23.513Z,1650467783.513 [CBIT](ERROR): Communications Fault in component: RudderServo
2022-04-20T15:16:23.750Z,1650467783.750 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2022-04-20T15:16:23.750Z,1650467783.750 [RudderServo](INFO): Powering down
2022-04-20T15:16:24.409Z,1650467784.409 [RudderServo](DEBUG): Initializing EZServoServo.
2022-04-20T15:16:24.530Z,1650467784.530 [RudderServo](DEBUG): Initializing RudderServo.
2022-04-20T15:16:24.534Z,1650467784.534 [CBIT](INFO): Clearing failed state for component RudderServo
2022-04-20T15:16:24.534Z,1650467784.534 [RudderServo] No Fault, FailCount= 1
2022-04-20T15:16:28.389Z,1650467788.389 [ThrusterHE](ERROR): Zero Speed Commanded.
2022-04-20T15:16:28.921Z,1650467788.921 [CTD_Seabird](ERROR): Device message queue exceeded the allowed limit.
2022-04-20T15:16:36.971Z,1650467796.971 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2022-04-20T15:16:49.470Z,1650467809.470 [NAL9602](INFO): Powering up NAL9602
2022-04-20T15:16:50.349Z,1650467810.349 [SBIT](IMPORTANT): Beginning Startup BIT
2022-04-20T15:16:50.358Z,1650467810.358 [CBIT](IMPORTANT): Beginning ground fault scan
2022-04-20T15:16:51.958Z,1650467811.958 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2022-04-20T15:17:00.378Z,1650467820.378 [NAL9602](INFO): NAL9602 initialized
2022-04-20T15:17:01.384Z,1650467821.384 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): 0.012122
CHAN A1 (24V): 0.019638
CHAN A2 (12V): 0.008105
CHAN A3 (5V): 0.001569
CHAN B0 (3.3V): 0.002332
CHAN B1 (3.15aV): 0.002012
CHAN B2 (3.15bV): 0.001523
CHAN B3 (GND): -0.001695
OPEN: 0.005185
Full Scale: +/- 1 mA
2022-04-20T15:17:11.699Z,1650467831.699 [NAL9602](INFO): SBD MO Status=0, MOMSN=37642, MT Status=0, MTMSN=0
2022-04-20T15:17:11.700Z,1650467831.700 [NAL9602](INFO): No messages in MT queue
2022-04-20T15:17:44.449Z,1650467864.449 [SBIT](IMPORTANT): SBIT PASSED
2022-04-20T15:17:44.450Z,1650467864.450 [SBIT](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2022-04-20T15:17:44.450Z,1650467864.450 [SBIT](IMPORTANT): CBIT.gfScanTimeout=2 hour;

2022-04-20T15:17:44.450Z,1650467864.450 [SBIT](IMPORTANT): CTD_Seabird.loadAtStartup=1 bool;

2022-04-20T15:17:44.451Z,1650467864.451 [SBIT](IMPORTANT): Express linearApproximation CTD_Seabird.bin_median_sea_water_salinity 0.050000 practical_salinity_unit;

2022-04-20T15:17:44.451Z,1650467864.451 [SBIT](IMPORTANT): Express none CTD_Seabird.sea_water_salinity;

2022-04-20T15:17:44.451Z,1650467864.451 [SBIT](IMPORTANT): Express none WetLabsSeaOWL_UV_A.concentration_of_colored_dissolved_organic_matter_in_sea_water;

2022-04-20T15:17:44.451Z,1650467864.451 [SBIT](IMPORTANT): Express linearApproximation WetLabsSeaOWL_UV_A.mass_concentration_of_petroleum_hydrocarbons_in_sea_water 0.000500 kilogram_per_cubic_meter;

2022-04-20T15:17:44.451Z,1650467864.451 [SBIT](IMPORTANT): Express none mass_concentration_of_chlorophyll_in_sea_water;

2022-04-20T15:17:44.451Z,1650467864.451 [SBIT](IMPORTANT): InternalEnvSim.loadAtStartup=1 bool;

2022-04-20T15:17:44.451Z,1650467864.451 [SBIT](IMPORTANT): InternalEnvSim.timeAdjust=1.5 day;

2022-04-20T15:17:44.451Z,1650467864.451 [SBIT](IMPORTANT): Micromodem.loadAtStartup=0 bool;

2022-04-20T15:17:44.452Z,1650467864.452 [SBIT](IMPORTANT): VerticalControl.buoyancyNeutral=190.658274 cubic_centimeter;

2022-04-20T15:17:44.452Z,1650467864.452 [SBIT](IMPORTANT): VerticalControl.massDefault=2.122748 millimeter;

2022-04-20T15:17:44.870Z,1650467864.870 [WorkSite](IMPORTANT): Reading workSite position from Data/workSite.cfg
2022-04-20T15:17:44.873Z,1650467864.873 [WorkSite](IMPORTANT): WorkSite fix at 20220420T151537: (41.512588, -70.793890)
2022-04-20T15:17:44.875Z,1650467864.875 [MissionManager](IMPORTANT): Started mission Startup
2022-04-20T15:17:44.875Z,1650467864.875 [Startup] Running Loop=1
2022-04-20T15:17:44.875Z,1650467864.875 [Startup](DEBUG): Aggregate::initialize Startup
2022-04-20T15:17:44.876Z,1650467864.876 [Startup:A.GoToSurface] Running Loop=1
2022-04-20T15:17:44.876Z,1650467864.876 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-04-20T15:17:44.877Z,1650467864.877 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-04-20T15:17:44.878Z,1650467864.878 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-04-20T15:17:44.879Z,1650467864.879 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-04-20T15:17:44.880Z,1650467864.880 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-04-20T15:17:44.881Z,1650467864.881 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-04-20T15:17:44.885Z,1650467864.885 [Startup:StartupSatComms] Running Loop=1
2022-04-20T15:17:44.885Z,1650467864.885 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2022-04-20T15:17:44.886Z,1650467864.886 [Startup:StartupSatComms:A] Running Loop=1
2022-04-20T15:17:45.259Z,1650467865.259 [LBLNavigation](INFO): Reset ping filters
2022-04-20T15:17:45.259Z,1650467865.259 [LBLNavigation](INFO): Reset fix filter
2022-04-20T15:17:45.277Z,1650467865.277 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2022-04-20T15:18:45.080Z,1650467925.080 [Startup:StartupSatComms:A](INFO): Timed out from 2022-04-20T15:17:44.9Z
2022-04-20T15:18:45.080Z,1650467925.080 [Startup:StartupSatComms:A] Stopped
2022-04-20T15:18:45.085Z,1650467925.085 [Startup:StartupSatComms:B] Running Loop=1
2022-04-20T15:18:45.444Z,1650467925.444 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2022-04-20T15:19:05.368Z,1650467945.368 [NAL9602](INFO): SBD MO Status=1, MOMSN=37643, MT Status=0, MTMSN=0
2022-04-20T15:19:05.417Z,1650467945.417 [NAL9602](INFO): Sent 52 bytes from file Logs/20220420T044011/Courier0048.lzma
2022-04-20T15:19:05.417Z,1650467945.417 [NAL9602](INFO): Packets left to send: 0
2022-04-20T15:19:13.995Z,1650467953.995 [NAL9602](INFO): SBD MO Status=1, MOMSN=37644, MT Status=0, MTMSN=0
2022-04-20T15:19:14.045Z,1650467954.045 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T151609/Courier0000.lzma
2022-04-20T15:19:14.045Z,1650467954.045 [NAL9602](INFO): Packets left to send: 1
2022-04-20T15:19:22.559Z,1650467962.559 [NAL9602](INFO): SBD MO Status=1, MOMSN=37645, MT Status=0, MTMSN=0
2022-04-20T15:19:22.621Z,1650467962.621 [NAL9602](INFO): Sent 170 bytes from file Logs/20220420T151609/Courier0000.lzma
2022-04-20T15:19:22.621Z,1650467962.621 [NAL9602](INFO): Packets left to send: 0
2022-04-20T15:19:33.540Z,1650467973.540 [NAL9602](INFO): SBD MO Status=1, MOMSN=37646, MT Status=0, MTMSN=0
2022-04-20T15:19:33.593Z,1650467973.593 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:19:33.593Z,1650467973.593 [NAL9602](INFO): Packets left to send: 427
2022-04-20T15:19:40.926Z,1650467980.926 [NAL9602](INFO): SBD MO Status=1, MOMSN=37647, MT Status=0, MTMSN=0
2022-04-20T15:19:40.983Z,1650467980.983 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:19:40.984Z,1650467980.984 [NAL9602](INFO): Packets left to send: 426
2022-04-20T15:19:45.151Z,1650467985.151 [Startup:StartupSatComms:B](INFO): Timed out from 2022-04-20T15:18:45.1Z
2022-04-20T15:19:45.151Z,1650467985.151 [Startup:StartupSatComms:B] Stopped
2022-04-20T15:19:45.151Z,1650467985.151 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2022-04-20T15:19:45.151Z,1650467985.151 [Startup:StartupSatComms] Stopped
2022-04-20T15:19:45.151Z,1650467985.151 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2022-04-20T15:19:45.152Z,1650467985.152 [Startup](INFO): Completed Startup
2022-04-20T15:19:45.156Z,1650467985.156 [MissionManager](INFO): Startup is completed.
2022-04-20T15:19:45.157Z,1650467985.157 [MissionManager](INFO): Uninitializing Mission Startup
2022-04-20T15:19:45.157Z,1650467985.157 [Startup] Stopped
2022-04-20T15:19:45.157Z,1650467985.157 [Startup](DEBUG): Aggregate::uninitialize Startup
2022-04-20T15:19:45.157Z,1650467985.157 [Startup:A.GoToSurface] Stopped
2022-04-20T15:19:45.157Z,1650467985.157 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-04-20T15:19:45.474Z,1650467985.474 [MissionManager](IMPORTANT): Started mission Default
2022-04-20T15:19:45.474Z,1650467985.474 [Default] Running Loop=1
2022-04-20T15:19:45.474Z,1650467985.474 [Default](DEBUG): Aggregate::initialize Default
2022-04-20T15:19:45.474Z,1650467985.474 [Default:B.GoToSurface] Running Loop=1
2022-04-20T15:19:45.474Z,1650467985.474 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2022-04-20T15:19:45.475Z,1650467985.475 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2022-04-20T15:19:45.475Z,1650467985.475 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2022-04-20T15:19:45.475Z,1650467985.475 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2022-04-20T15:19:45.475Z,1650467985.475 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2022-04-20T15:19:45.476Z,1650467985.476 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2022-04-20T15:19:45.476Z,1650467985.476 [Default:A.Wait] Running Loop=1
2022-04-20T15:19:45.476Z,1650467985.476 [Default:A.Wait](DEBUG): Initialize Wait Component.
2022-04-20T15:19:48.292Z,1650467988.292 [NAL9602](INFO): SBD MO Status=1, MOMSN=37648, MT Status=0, MTMSN=0
2022-04-20T15:19:48.341Z,1650467988.341 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:19:48.341Z,1650467988.341 [NAL9602](INFO): Packets left to send: 425
2022-04-20T15:19:58.830Z,1650467998.830 [Default:A.Wait](INFO): Done Waiting.
2022-04-20T15:19:58.830Z,1650467998.830 [Default:A.Wait] Stopped
2022-04-20T15:19:58.830Z,1650467998.830 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2022-04-20T15:19:59.235Z,1650467999.235 [Default:CheckIn] Running Loop=1
2022-04-20T15:19:59.236Z,1650467999.236 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-04-20T15:19:59.236Z,1650467999.236 [Default:CheckIn:Read_GPS] Running Loop=1
2022-04-20T15:19:59.622Z,1650467999.622 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2022-04-20T15:23:45.056Z,1650468225.056 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6.
2022-04-20T15:23:45.063Z,1650468225.063 [BPC1](INFO): Received data from all battery sticks.
2022-04-20T15:23:52.323Z,1650468232.323 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,152354.00,A,4130.75509,N,07047.54529,W,0.700,65.91,200422,,,A*41
2022-04-20T15:23:52.327Z,1650468232.327 [NAL9602](INFO): GPS fix at 20220420T152354: (41.512585, -70.792422)
2022-04-20T15:23:52.340Z,1650468232.340 [Default:CheckIn:Read_GPS] Stopped
2022-04-20T15:23:52.340Z,1650468232.340 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-04-20T15:23:52.789Z,1650468232.789 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2022-04-20T15:24:05.731Z,1650468245.731 [NAL9602](INFO): SBD MO Status=1, MOMSN=37649, MT Status=0, MTMSN=0
2022-04-20T15:24:05.789Z,1650468245.789 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T151609/Courier0004.lzma
2022-04-20T15:24:05.789Z,1650468245.789 [NAL9602](INFO): Packets left to send: 1
2022-04-20T15:24:15.115Z,1650468255.115 [NAL9602](INFO): SBD MO Status=1, MOMSN=37650, MT Status=0, MTMSN=0
2022-04-20T15:24:15.165Z,1650468255.165 [NAL9602](INFO): Sent 17 bytes from file Logs/20220420T151609/Courier0004.lzma
2022-04-20T15:24:15.165Z,1650468255.165 [NAL9602](INFO): Packets left to send: 0
2022-04-20T15:24:28.147Z,1650468268.147 [NAL9602](INFO): SBD MO Status=1, MOMSN=37651, MT Status=0, MTMSN=0
2022-04-20T15:24:28.197Z,1650468268.197 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:24:28.197Z,1650468268.197 [NAL9602](INFO): Packets left to send: 424
2022-04-20T15:24:33.927Z,1650468273.927 [NAL9602](INFO): SBD MO Status=1, MOMSN=37652, MT Status=0, MTMSN=0
2022-04-20T15:24:33.981Z,1650468273.981 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:24:33.981Z,1650468273.981 [NAL9602](INFO): Packets left to send: 423
2022-04-20T15:24:42.519Z,1650468282.519 [NAL9602](INFO): SBD MO Status=1, MOMSN=37653, MT Status=0, MTMSN=0
2022-04-20T15:24:42.569Z,1650468282.569 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:24:42.569Z,1650468282.569 [NAL9602](INFO): Packets left to send: 422
2022-04-20T15:24:51.924Z,1650468291.924 [NAL9602](INFO): SBD MO Status=1, MOMSN=37654, MT Status=0, MTMSN=0
2022-04-20T15:24:51.977Z,1650468291.977 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:24:51.977Z,1650468291.977 [NAL9602](INFO): Packets left to send: 421
2022-04-20T15:24:58.495Z,1650468298.495 [NAL9602](INFO): SBD MO Status=1, MOMSN=37655, MT Status=0, MTMSN=0
2022-04-20T15:24:58.549Z,1650468298.549 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:24:58.549Z,1650468298.549 [NAL9602](INFO): Packets left to send: 420
2022-04-20T15:25:06.289Z,1650468306.289 [NAL9602](INFO): SBD MO Status=1, MOMSN=37656, MT Status=0, MTMSN=0
2022-04-20T15:25:06.339Z,1650468306.339 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:25:06.339Z,1650468306.339 [NAL9602](INFO): Packets left to send: 419
2022-04-20T15:25:17.344Z,1650468317.344 [NAL9602](INFO): SBD MO Status=1, MOMSN=37657, MT Status=0, MTMSN=0
2022-04-20T15:25:17.405Z,1650468317.405 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:25:17.405Z,1650468317.405 [NAL9602](INFO): Packets left to send: 418
2022-04-20T15:25:35.147Z,1650468335.147 [NAL9602](INFO): SBD MO Status=1, MOMSN=37658, MT Status=0, MTMSN=0
2022-04-20T15:25:35.205Z,1650468335.205 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:25:35.205Z,1650468335.205 [NAL9602](INFO): Packets left to send: 417
2022-04-20T15:25:43.735Z,1650468343.735 [NAL9602](INFO): SBD MO Status=1, MOMSN=37659, MT Status=0, MTMSN=0
2022-04-20T15:25:43.785Z,1650468343.785 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:25:43.785Z,1650468343.785 [NAL9602](INFO): Packets left to send: 416
2022-04-20T15:25:51.935Z,1650468351.935 [NAL9602](INFO): SBD MO Status=1, MOMSN=37660, MT Status=0, MTMSN=0
2022-04-20T15:25:51.985Z,1650468351.985 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:25:51.985Z,1650468351.985 [NAL9602](INFO): Packets left to send: 415
2022-04-20T15:25:59.727Z,1650468359.727 [NAL9602](INFO): SBD MO Status=1, MOMSN=37661, MT Status=0, MTMSN=0
2022-04-20T15:25:59.777Z,1650468359.777 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:25:59.777Z,1650468359.777 [NAL9602](INFO): Packets left to send: 414
2022-04-20T15:26:08.335Z,1650468368.335 [NAL9602](INFO): SBD MO Status=1, MOMSN=37662, MT Status=0, MTMSN=0
2022-04-20T15:26:08.389Z,1650468368.389 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:26:08.389Z,1650468368.389 [NAL9602](INFO): Packets left to send: 413
2022-04-20T15:26:18.535Z,1650468378.535 [NAL9602](INFO): SBD MO Status=1, MOMSN=37663, MT Status=0, MTMSN=0
2022-04-20T15:26:18.593Z,1650468378.593 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:26:18.594Z,1650468378.594 [NAL9602](INFO): Packets left to send: 412
2022-04-20T15:26:25.920Z,1650468385.920 [NAL9602](INFO): SBD MO Status=1, MOMSN=37664, MT Status=0, MTMSN=0
2022-04-20T15:26:25.978Z,1650468385.978 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:26:25.978Z,1650468385.978 [NAL9602](INFO): Packets left to send: 411
2022-04-20T15:26:34.123Z,1650468394.123 [NAL9602](INFO): SBD MO Status=1, MOMSN=37665, MT Status=0, MTMSN=0
2022-04-20T15:26:34.173Z,1650468394.173 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:26:34.173Z,1650468394.173 [NAL9602](INFO): Packets left to send: 410
2022-04-20T15:26:43.508Z,1650468403.508 [NAL9602](INFO): SBD MO Status=1, MOMSN=37666, MT Status=0, MTMSN=0
2022-04-20T15:26:43.569Z,1650468403.569 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:26:43.569Z,1650468403.569 [NAL9602](INFO): Packets left to send: 409
2022-04-20T15:26:51.737Z,1650468411.737 [NAL9602](INFO): SBD MO Status=1, MOMSN=37667, MT Status=0, MTMSN=0
2022-04-20T15:26:51.786Z,1650468411.786 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:26:51.787Z,1650468411.787 [NAL9602](INFO): Packets left to send: 408
2022-04-20T15:27:03.535Z,1650468423.535 [NAL9602](INFO): SBD MO Status=1, MOMSN=37668, MT Status=0, MTMSN=0
2022-04-20T15:27:03.597Z,1650468423.597 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:27:03.597Z,1650468423.597 [NAL9602](INFO): Packets left to send: 407
2022-04-20T15:27:09.695Z,1650468429.695 [NAL9602](INFO): SBD MO Status=1, MOMSN=37669, MT Status=0, MTMSN=0
2022-04-20T15:27:09.749Z,1650468429.749 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:27:09.749Z,1650468429.749 [NAL9602](INFO): Packets left to send: 406
2022-04-20T15:27:18.271Z,1650468438.271 [NAL9602](INFO): SBD MO Status=1, MOMSN=37670, MT Status=0, MTMSN=0
2022-04-20T15:27:18.321Z,1650468438.321 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:27:18.321Z,1650468438.321 [NAL9602](INFO): Packets left to send: 405
2022-04-20T15:27:22.440Z,1650468442.440 [RDI_PathfinderUp](ERROR): only read 3 of 4 data items
2022-04-20T15:27:27.239Z,1650468447.239 [NAL9602](INFO): SBD MO Status=1, MOMSN=37671, MT Status=0, MTMSN=0
2022-04-20T15:27:27.289Z,1650468447.289 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:27:27.289Z,1650468447.289 [NAL9602](INFO): Packets left to send: 404
2022-04-20T15:27:37.863Z,1650468457.863 [NAL9602](INFO): SBD MO Status=1, MOMSN=37672, MT Status=0, MTMSN=0
2022-04-20T15:27:37.925Z,1650468457.925 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:27:37.925Z,1650468457.925 [NAL9602](INFO): Packets left to send: 403
2022-04-20T15:27:43.275Z,1650468463.275 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2022-04-20T15:27:49.816Z,1650468469.816 [NAL9602](INFO): SBD MO Status=1, MOMSN=37673, MT Status=0, MTMSN=0
2022-04-20T15:27:49.877Z,1650468469.877 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:27:49.877Z,1650468469.877 [NAL9602](INFO): Packets left to send: 402
2022-04-20T15:28:07.623Z,1650468487.623 [NAL9602](INFO): SBD MO Status=1, MOMSN=37674, MT Status=0, MTMSN=0
2022-04-20T15:28:07.673Z,1650468487.673 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:28:07.673Z,1650468487.673 [NAL9602](INFO): Packets left to send: 401
2022-04-20T15:28:08.773Z,1650468488.773 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.008309
2022-04-20T15:28:17.828Z,1650468497.828 [NAL9602](INFO): SBD MO Status=1, MOMSN=37675, MT Status=0, MTMSN=0
2022-04-20T15:28:17.885Z,1650468497.885 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:28:17.885Z,1650468497.885 [NAL9602](INFO): Packets left to send: 400
2022-04-20T15:28:17.972Z,1650468497.972 [Default:CheckIn:Read_Iridium] Stopped
2022-04-20T15:28:17.977Z,1650468497.977 [Default:CheckIn:C.Wait] Running Loop=1
2022-04-20T15:28:17.977Z,1650468497.977 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-04-20T15:28:39.886Z,1650468519.886 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:28:48.529Z,1650468528.529 [NAL9602](INFO): Not Powering down - fast GPS
2022-04-20T15:29:09.001Z,1650468549.001 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.237194
2022-04-20T15:29:46.149Z,1650468586.149 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:29:56.193Z,1650468596.193 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002696
2022-04-20T15:30:56.437Z,1650468656.437 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:30:56.438Z,1650468656.438 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.248207
2022-04-20T15:31:22.916Z,1650468682.916 [CBIT](INFO): Clearing failed state for component DropWeight
2022-04-20T15:31:22.916Z,1650468682.916 [DropWeight] No Fault, FailCount= 1
2022-04-20T15:32:06.734Z,1650468726.734 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:32:41.886Z,1650468761.886 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:33:17.025Z,1650468797.025 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:33:18.429Z,1650468798.429 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-04-20T15:33:18.429Z,1650468798.429 [Default:CheckIn:C.Wait] Stopped
2022-04-20T15:33:18.429Z,1650468798.429 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-04-20T15:33:18.430Z,1650468798.430 [Default:CheckIn:D] Running Loop=1
2022-04-20T15:33:18.871Z,1650468798.871 [Default:CheckIn:D] Stopped
2022-04-20T15:33:18.871Z,1650468798.871 [Default:CheckIn:E] Running Loop=1
2022-04-20T15:33:19.249Z,1650468799.249 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 13.556607 min 
2022-04-20T15:33:19.250Z,1650468799.250 [Default:CheckIn:E] Stopped
2022-04-20T15:33:19.251Z,1650468799.251 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-04-20T15:33:19.251Z,1650468799.251 [Default:CheckIn] Stopped
2022-04-20T15:33:19.251Z,1650468799.251 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-04-20T15:33:19.251Z,1650468799.251 [Default:CheckIn](INFO): Running loop #2
2022-04-20T15:33:19.251Z,1650468799.251 [Default:CheckIn] Running Loop=2
2022-04-20T15:33:19.251Z,1650468799.251 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-04-20T15:33:19.251Z,1650468799.251 [Default:CheckIn:Read_GPS] Running Loop=1
2022-04-20T15:33:21.236Z,1650468801.236 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,153323.00,A,4130.74460,N,07047.47558,W,1.225,79.10,200422,,,A*4C
2022-04-20T15:33:21.247Z,1650468801.247 [NAL9602](INFO): GPS fix at 20220420T153323: (41.512410, -70.791260)
2022-04-20T15:33:21.270Z,1650468801.270 [Default:CheckIn:Read_GPS] Stopped
2022-04-20T15:33:21.270Z,1650468801.270 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-04-20T15:33:36.683Z,1650468816.683 [NAL9602](INFO): SBD MO Status=1, MOMSN=37676, MT Status=0, MTMSN=0
2022-04-20T15:33:36.738Z,1650468816.738 [NAL9602](INFO): Sent 73 bytes from file Logs/20220420T151609/Courier0007.lzma
2022-04-20T15:33:36.738Z,1650468816.738 [NAL9602](INFO): Packets left to send: 0
2022-04-20T15:33:47.749Z,1650468827.749 [NAL9602](INFO): SBD MO Status=1, MOMSN=37677, MT Status=0, MTMSN=0
2022-04-20T15:33:47.817Z,1650468827.817 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:33:47.817Z,1650468827.817 [NAL9602](INFO): Packets left to send: 399
2022-04-20T15:33:52.181Z,1650468832.181 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:33:55.904Z,1650468835.904 [NAL9602](INFO): SBD MO Status=1, MOMSN=37678, MT Status=0, MTMSN=0
2022-04-20T15:33:55.953Z,1650468835.953 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:33:55.953Z,1650468835.953 [NAL9602](INFO): Packets left to send: 398
2022-04-20T15:34:03.719Z,1650468843.719 [NAL9602](INFO): SBD MO Status=1, MOMSN=37679, MT Status=0, MTMSN=0
2022-04-20T15:34:03.777Z,1650468843.777 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:34:03.777Z,1650468843.777 [NAL9602](INFO): Packets left to send: 397
2022-04-20T15:34:10.691Z,1650468850.691 [NAL9602](INFO): SBD MO Status=1, MOMSN=37680, MT Status=0, MTMSN=0
2022-04-20T15:34:10.747Z,1650468850.747 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:34:10.748Z,1650468850.748 [NAL9602](INFO): Packets left to send: 396
2022-04-20T15:34:27.333Z,1650468867.333 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:34:32.191Z,1650468872.191 [NAL9602](INFO): SBD MO Status=1, MOMSN=37681, MT Status=0, MTMSN=0
2022-04-20T15:34:32.241Z,1650468872.241 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:34:32.241Z,1650468872.241 [NAL9602](INFO): Packets left to send: 395
2022-04-20T15:34:40.383Z,1650468880.383 [NAL9602](INFO): SBD MO Status=1, MOMSN=37682, MT Status=0, MTMSN=0
2022-04-20T15:34:40.433Z,1650468880.433 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:34:40.433Z,1650468880.433 [NAL9602](INFO): Packets left to send: 394
2022-04-20T15:34:51.001Z,1650468891.001 [NAL9602](INFO): SBD MO Status=1, MOMSN=37683, MT Status=0, MTMSN=0
2022-04-20T15:34:51.054Z,1650468891.054 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:34:51.054Z,1650468891.054 [NAL9602](INFO): Packets left to send: 393
2022-04-20T15:34:57.567Z,1650468897.567 [NAL9602](INFO): SBD MO Status=1, MOMSN=37684, MT Status=0, MTMSN=0
2022-04-20T15:34:57.629Z,1650468897.629 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:34:57.629Z,1650468897.629 [NAL9602](INFO): Packets left to send: 392
2022-04-20T15:35:02.493Z,1650468902.493 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:35:04.123Z,1650468904.123 [NAL9602](INFO): SBD MO Status=1, MOMSN=37685, MT Status=0, MTMSN=0
2022-04-20T15:35:04.193Z,1650468904.193 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:35:04.193Z,1650468904.193 [NAL9602](INFO): Packets left to send: 391
2022-04-20T15:35:12.308Z,1650468912.308 [NAL9602](INFO): SBD MO Status=1, MOMSN=37686, MT Status=0, MTMSN=0
2022-04-20T15:35:12.361Z,1650468912.361 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:35:12.361Z,1650468912.361 [NAL9602](INFO): Packets left to send: 390
2022-04-20T15:35:22.082Z,1650468922.082 [NAL9602](INFO): SBD MO Status=1, MOMSN=37687, MT Status=0, MTMSN=0
2022-04-20T15:35:22.134Z,1650468922.134 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:35:22.134Z,1650468922.134 [NAL9602](INFO): Packets left to send: 389
2022-04-20T15:35:31.063Z,1650468931.063 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=37688, MT Status=1, MTMSN=1452
2022-04-20T15:35:31.117Z,1650468931.117 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:35:31.117Z,1650468931.117 [NAL9602](INFO): Packets left to send: 388
2022-04-20T15:35:31.617Z,1650468931.617 [NAL9602](INFO): Received command: configSet VerticalControl.buoyancyNeutral 145 cubic_centimeter persist
2022-04-20T15:35:32.001Z,1650468932.001 [CommandExec](IMPORTANT): got command configSet VerticalControl.buoyancyNeutral 145 cubic_centimeter persist
2022-04-20T15:35:37.661Z,1650468937.661 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:35:48.976Z,1650468948.976 [NAL9602](INFO): SBD MO Status=1, MOMSN=37689, MT Status=0, MTMSN=0
2022-04-20T15:35:49.029Z,1650468949.029 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:35:49.029Z,1650468949.029 [NAL9602](INFO): Packets left to send: 387
2022-04-20T15:35:59.235Z,1650468959.235 [NAL9602](INFO): SBD MO Status=1, MOMSN=37690, MT Status=0, MTMSN=0
2022-04-20T15:35:59.285Z,1650468959.285 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:35:59.285Z,1650468959.285 [NAL9602](INFO): Packets left to send: 386
2022-04-20T15:36:05.428Z,1650468965.428 [NAL9602](INFO): SBD MO Status=1, MOMSN=37691, MT Status=0, MTMSN=0
2022-04-20T15:36:05.477Z,1650468965.477 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:36:05.477Z,1650468965.477 [NAL9602](INFO): Packets left to send: 385
2022-04-20T15:36:12.801Z,1650468972.801 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:36:13.252Z,1650468973.252 [NAL9602](INFO): SBD MO Status=1, MOMSN=37692, MT Status=0, MTMSN=0
2022-04-20T15:36:13.305Z,1650468973.305 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:36:13.305Z,1650468973.305 [NAL9602](INFO): Packets left to send: 384
2022-04-20T15:36:21.855Z,1650468981.855 [NAL9602](INFO): SBD MO Status=1, MOMSN=37693, MT Status=0, MTMSN=0
2022-04-20T15:36:21.905Z,1650468981.905 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:36:21.905Z,1650468981.905 [NAL9602](INFO): Packets left to send: 383
2022-04-20T15:36:29.662Z,1650468989.662 [NAL9602](INFO): SBD MO Status=1, MOMSN=37694, MT Status=0, MTMSN=0
2022-04-20T15:36:29.709Z,1650468989.709 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:36:29.709Z,1650468989.709 [NAL9602](INFO): Packets left to send: 382
2022-04-20T15:36:41.055Z,1650469001.055 [NAL9602](INFO): SBD MO Status=1, MOMSN=37695, MT Status=0, MTMSN=0
2022-04-20T15:36:41.109Z,1650469001.109 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:36:41.109Z,1650469001.109 [NAL9602](INFO): Packets left to send: 381
2022-04-20T15:36:47.945Z,1650469007.945 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:36:51.657Z,1650469011.657 [NAL9602](INFO): SBD MO Status=1, MOMSN=37696, MT Status=0, MTMSN=0
2022-04-20T15:36:51.710Z,1650469011.710 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:36:51.711Z,1650469011.711 [NAL9602](INFO): Packets left to send: 380
2022-04-20T15:36:58.211Z,1650469018.211 [RDI_PathfinderUp](ERROR): only read 0 of 1 data item for BIT error
2022-04-20T15:37:03.072Z,1650469023.072 [NAL9602](INFO): SBD MO Status=1, MOMSN=37697, MT Status=0, MTMSN=0
2022-04-20T15:37:03.121Z,1650469023.121 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:37:03.121Z,1650469023.121 [NAL9602](INFO): Packets left to send: 379
2022-04-20T15:37:14.069Z,1650469034.069 [NAL9602](INFO): SBD MO Status=1, MOMSN=37698, MT Status=0, MTMSN=0
2022-04-20T15:37:14.121Z,1650469034.121 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:37:14.121Z,1650469034.121 [NAL9602](INFO): Packets left to send: 378
2022-04-20T15:37:20.262Z,1650469040.262 [NAL9602](INFO): SBD MO Status=1, MOMSN=37699, MT Status=0, MTMSN=0
2022-04-20T15:37:20.314Z,1650469040.314 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:37:20.314Z,1650469040.314 [NAL9602](INFO): Packets left to send: 377
2022-04-20T15:37:23.089Z,1650469043.089 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:37:31.261Z,1650469051.261 [NAL9602](INFO): SBD MO Status=1, MOMSN=37700, MT Status=0, MTMSN=0
2022-04-20T15:37:31.321Z,1650469051.321 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:37:31.321Z,1650469051.321 [NAL9602](INFO): Packets left to send: 376
2022-04-20T15:37:41.049Z,1650469061.049 [NAL9602](INFO): SBD MO Status=1, MOMSN=37701, MT Status=0, MTMSN=0
2022-04-20T15:37:41.098Z,1650469061.098 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:37:41.098Z,1650469061.098 [NAL9602](INFO): Packets left to send: 375
2022-04-20T15:37:49.652Z,1650469069.652 [NAL9602](INFO): SBD MO Status=1, MOMSN=37702, MT Status=0, MTMSN=0
2022-04-20T15:37:49.705Z,1650469069.705 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:37:49.705Z,1650469069.705 [NAL9602](INFO): Packets left to send: 374
2022-04-20T15:37:56.995Z,1650469076.995 [NAL9602](INFO): SBD MO Status=1, MOMSN=37703, MT Status=0, MTMSN=0
2022-04-20T15:37:57.049Z,1650469077.049 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:37:57.049Z,1650469077.049 [NAL9602](INFO): Packets left to send: 373
2022-04-20T15:37:58.236Z,1650469078.236 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:38:04.379Z,1650469084.379 [NAL9602](INFO): SBD MO Status=1, MOMSN=37704, MT Status=0, MTMSN=0
2022-04-20T15:38:04.433Z,1650469084.433 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:38:04.433Z,1650469084.433 [NAL9602](INFO): Packets left to send: 372
2022-04-20T15:38:14.161Z,1650469094.161 [NAL9602](INFO): SBD MO Status=1, MOMSN=37705, MT Status=0, MTMSN=0
2022-04-20T15:38:14.211Z,1650469094.211 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:38:14.211Z,1650469094.211 [NAL9602](INFO): Packets left to send: 371
2022-04-20T15:38:24.370Z,1650469104.370 [NAL9602](INFO): SBD MO Status=1, MOMSN=37706, MT Status=0, MTMSN=0
2022-04-20T15:38:24.421Z,1650469104.421 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:38:24.421Z,1650469104.421 [NAL9602](INFO): Packets left to send: 370
2022-04-20T15:38:31.711Z,1650469111.711 [NAL9602](INFO): SBD MO Status=1, MOMSN=37707, MT Status=0, MTMSN=0
2022-04-20T15:38:31.761Z,1650469111.761 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:38:31.761Z,1650469111.761 [NAL9602](INFO): Packets left to send: 369
2022-04-20T15:38:33.373Z,1650469113.373 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:38:39.063Z,1650469119.063 [NAL9602](INFO): SBD MO Status=1, MOMSN=37708, MT Status=0, MTMSN=0
2022-04-20T15:38:39.113Z,1650469119.113 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:38:39.113Z,1650469119.113 [NAL9602](INFO): Packets left to send: 368
2022-04-20T15:38:50.519Z,1650469130.519 [NAL9602](INFO): SBD MO Status=1, MOMSN=37709, MT Status=0, MTMSN=0
2022-04-20T15:38:50.569Z,1650469130.569 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:38:50.569Z,1650469130.569 [NAL9602](INFO): Packets left to send: 367
2022-04-20T15:38:57.859Z,1650469137.859 [NAL9602](INFO): SBD MO Status=1, MOMSN=37710, MT Status=0, MTMSN=0
2022-04-20T15:38:57.910Z,1650469137.910 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:38:57.910Z,1650469137.910 [NAL9602](INFO): Packets left to send: 366
2022-04-20T15:39:05.671Z,1650469145.671 [NAL9602](INFO): SBD MO Status=1, MOMSN=37711, MT Status=0, MTMSN=0
2022-04-20T15:39:05.733Z,1650469145.733 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:39:05.733Z,1650469145.733 [NAL9602](INFO): Packets left to send: 365
2022-04-20T15:39:08.525Z,1650469148.525 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:39:17.491Z,1650469157.491 [NAL9602](INFO): SBD MO Status=1, MOMSN=37712, MT Status=0, MTMSN=0
2022-04-20T15:39:17.545Z,1650469157.545 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:39:17.545Z,1650469157.545 [NAL9602](INFO): Packets left to send: 364
2022-04-20T15:39:30.646Z,1650469170.646 [NAL9602](INFO): SBD MO Status=1, MOMSN=37713, MT Status=0, MTMSN=0
2022-04-20T15:39:30.695Z,1650469170.695 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:39:30.695Z,1650469170.695 [NAL9602](INFO): Packets left to send: 363
2022-04-20T15:39:42.464Z,1650469182.464 [NAL9602](INFO): SBD MO Status=1, MOMSN=37714, MT Status=0, MTMSN=0
2022-04-20T15:39:42.518Z,1650469182.518 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:39:42.518Z,1650469182.518 [NAL9602](INFO): Packets left to send: 362
2022-04-20T15:39:43.685Z,1650469183.685 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:39:49.866Z,1650469189.866 [NAL9602](INFO): SBD MO Status=1, MOMSN=37715, MT Status=0, MTMSN=0
2022-04-20T15:39:49.921Z,1650469189.921 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:39:49.921Z,1650469189.921 [NAL9602](INFO): Packets left to send: 361
2022-04-20T15:40:00.507Z,1650469200.507 [NAL9602](INFO): SBD MO Status=1, MOMSN=37716, MT Status=0, MTMSN=0
2022-04-20T15:40:00.561Z,1650469200.561 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:40:00.561Z,1650469200.561 [NAL9602](INFO): Packets left to send: 360
2022-04-20T15:40:11.919Z,1650469211.919 [NAL9602](INFO): SBD MO Status=2, MOMSN=37717, MT Status=2, MTMSN=0
2022-04-20T15:40:11.919Z,1650469211.919 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2022-04-20T15:40:14.787Z,1650469214.787 [RDI_Pathfinder](ERROR): only read -1 of 4 data items
2022-04-20T15:40:18.825Z,1650469218.825 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:40:39.888Z,1650469239.888 [NAL9602](INFO): SBD MO Status=2, MOMSN=37717, MT Status=2, MTMSN=0
2022-04-20T15:40:39.888Z,1650469239.888 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2022-04-20T15:40:53.981Z,1650469253.981 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:40:59.775Z,1650469259.775 [NAL9602](INFO): SBD MO Status=1, MOMSN=37717, MT Status=0, MTMSN=0
2022-04-20T15:40:59.825Z,1650469259.825 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:40:59.825Z,1650469259.825 [NAL9602](INFO): Packets left to send: 359
2022-04-20T15:41:07.131Z,1650469267.131 [NAL9602](INFO): SBD MO Status=1, MOMSN=37718, MT Status=0, MTMSN=0
2022-04-20T15:41:07.181Z,1650469267.181 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:41:07.182Z,1650469267.182 [NAL9602](INFO): Packets left to send: 358
2022-04-20T15:41:17.815Z,1650469277.815 [NAL9602](INFO): SBD MO Status=1, MOMSN=37719, MT Status=0, MTMSN=0
2022-04-20T15:41:17.865Z,1650469277.865 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:41:17.865Z,1650469277.865 [NAL9602](INFO): Packets left to send: 357
2022-04-20T15:41:29.129Z,1650469289.129 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:41:33.683Z,1650469293.683 [NAL9602](INFO): SBD MO Status=2, MOMSN=37720, MT Status=2, MTMSN=0
2022-04-20T15:41:33.684Z,1650469293.684 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2022-04-20T15:41:51.595Z,1650469311.595 [NAL9602](INFO): SBD MO Status=1, MOMSN=37720, MT Status=0, MTMSN=0
2022-04-20T15:41:51.645Z,1650469311.645 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:41:51.645Z,1650469311.645 [NAL9602](INFO): Packets left to send: 356
2022-04-20T15:42:04.281Z,1650469324.281 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:42:04.604Z,1650469324.604 [NAL9602](INFO): SBD MO Status=1, MOMSN=37721, MT Status=0, MTMSN=0
2022-04-20T15:42:04.653Z,1650469324.653 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:42:04.653Z,1650469324.653 [NAL9602](INFO): Packets left to send: 355
2022-04-20T15:42:16.420Z,1650469336.420 [NAL9602](INFO): SBD MO Status=1, MOMSN=37722, MT Status=0, MTMSN=0
2022-04-20T15:42:16.473Z,1650469336.473 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:42:16.473Z,1650469336.473 [NAL9602](INFO): Packets left to send: 354
2022-04-20T15:42:26.193Z,1650469346.193 [NAL9602](INFO): SBD MO Status=1, MOMSN=37723, MT Status=0, MTMSN=0
2022-04-20T15:42:26.245Z,1650469346.245 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:42:26.245Z,1650469346.245 [NAL9602](INFO): Packets left to send: 353
2022-04-20T15:42:39.421Z,1650469359.421 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:42:45.269Z,1650469365.269 [NAL9602](INFO): SBD MO Status=1, MOMSN=37724, MT Status=0, MTMSN=0
2022-04-20T15:42:45.329Z,1650469365.329 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:42:45.329Z,1650469365.329 [NAL9602](INFO): Packets left to send: 352
2022-04-20T15:42:52.263Z,1650469372.263 [NAL9602](INFO): SBD MO Status=1, MOMSN=37725, MT Status=0, MTMSN=0
2022-04-20T15:42:52.313Z,1650469372.313 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:42:52.313Z,1650469372.313 [NAL9602](INFO): Packets left to send: 351
2022-04-20T15:43:00.423Z,1650469380.423 [NAL9602](INFO): SBD MO Status=1, MOMSN=37726, MT Status=0, MTMSN=0
2022-04-20T15:43:00.477Z,1650469380.477 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:43:00.478Z,1650469380.478 [NAL9602](INFO): Packets left to send: 350
2022-04-20T15:43:09.800Z,1650469389.800 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=37727, MT Status=1, MTMSN=1453
2022-04-20T15:43:09.853Z,1650469389.853 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:43:09.853Z,1650469389.853 [NAL9602](INFO): Packets left to send: 349
2022-04-20T15:43:10.341Z,1650469390.341 [NAL9602](INFO): Received command: configSet VerticalControl.massDefault -20 millimeter persist
2022-04-20T15:43:10.749Z,1650469390.749 [CommandExec](IMPORTANT): got command configSet VerticalControl.massDefault -20 millimeter persist
2022-04-20T15:43:14.561Z,1650469394.561 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:43:20.845Z,1650469400.845 [NAL9602](INFO): SBD MO Status=1, MOMSN=37728, MT Status=0, MTMSN=0
2022-04-20T15:43:20.895Z,1650469400.895 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:43:20.895Z,1650469400.895 [NAL9602](INFO): Packets left to send: 348
2022-04-20T15:43:33.083Z,1650469413.083 [NAL9602](INFO): SBD MO Status=1, MOMSN=37729, MT Status=0, MTMSN=0
2022-04-20T15:43:33.133Z,1650469413.133 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:43:33.133Z,1650469413.133 [NAL9602](INFO): Packets left to send: 347
2022-04-20T15:43:43.739Z,1650469423.739 [NAL9602](INFO): SBD MO Status=1, MOMSN=37730, MT Status=0, MTMSN=0
2022-04-20T15:43:43.793Z,1650469423.793 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:43:43.793Z,1650469423.793 [NAL9602](INFO): Packets left to send: 346
2022-04-20T15:43:49.709Z,1650469429.709 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:43:51.954Z,1650469431.954 [NAL9602](INFO): SBD MO Status=1, MOMSN=37731, MT Status=0, MTMSN=0
2022-04-20T15:43:52.001Z,1650469432.001 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:43:52.001Z,1650469432.001 [NAL9602](INFO): Packets left to send: 345
2022-04-20T15:44:01.391Z,1650469441.391 [NAL9602](INFO): SBD MO Status=1, MOMSN=37732, MT Status=0, MTMSN=0
2022-04-20T15:44:01.453Z,1650469441.453 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:44:01.453Z,1650469441.453 [NAL9602](INFO): Packets left to send: 344
2022-04-20T15:44:07.945Z,1650469447.945 [NAL9602](INFO): SBD MO Status=1, MOMSN=37733, MT Status=0, MTMSN=0
2022-04-20T15:44:07.998Z,1650469447.998 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:44:07.998Z,1650469447.998 [NAL9602](INFO): Packets left to send: 343
2022-04-20T15:44:16.970Z,1650469456.970 [NAL9602](INFO): SBD MO Status=1, MOMSN=37734, MT Status=0, MTMSN=0
2022-04-20T15:44:17.021Z,1650469457.021 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:44:17.021Z,1650469457.021 [NAL9602](INFO): Packets left to send: 342
2022-04-20T15:44:24.853Z,1650469464.853 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:44:27.156Z,1650469467.156 [NAL9602](INFO): SBD MO Status=1, MOMSN=37735, MT Status=0, MTMSN=0
2022-04-20T15:44:27.209Z,1650469467.209 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:44:27.209Z,1650469467.209 [NAL9602](INFO): Packets left to send: 341
2022-04-20T15:44:36.163Z,1650469476.163 [NAL9602](INFO): SBD MO Status=1, MOMSN=37736, MT Status=0, MTMSN=0
2022-04-20T15:44:36.213Z,1650469476.213 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:44:36.214Z,1650469476.214 [NAL9602](INFO): Packets left to send: 340
2022-04-20T15:44:51.640Z,1650469491.640 [NAL9602](INFO): SBD MO Status=1, MOMSN=37737, MT Status=0, MTMSN=0
2022-04-20T15:44:51.689Z,1650469491.689 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:44:51.689Z,1650469491.689 [NAL9602](INFO): Packets left to send: 339
2022-04-20T15:45:00.001Z,1650469500.001 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:45:01.019Z,1650469501.019 [NAL9602](INFO): SBD MO Status=1, MOMSN=37738, MT Status=0, MTMSN=0
2022-04-20T15:45:01.077Z,1650469501.077 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:45:01.077Z,1650469501.077 [NAL9602](INFO): Packets left to send: 338
2022-04-20T15:45:09.615Z,1650469509.615 [NAL9602](INFO): SBD MO Status=1, MOMSN=37739, MT Status=0, MTMSN=0
2022-04-20T15:45:09.666Z,1650469509.666 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:45:09.666Z,1650469509.666 [NAL9602](INFO): Packets left to send: 337
2022-04-20T15:45:19.019Z,1650469519.019 [NAL9602](INFO): SBD MO Status=1, MOMSN=37740, MT Status=0, MTMSN=0
2022-04-20T15:45:19.081Z,1650469519.081 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:45:19.081Z,1650469519.081 [NAL9602](INFO): Packets left to send: 336
2022-04-20T15:45:27.991Z,1650469527.991 [NAL9602](INFO): SBD MO Status=1, MOMSN=37741, MT Status=0, MTMSN=0
2022-04-20T15:45:28.049Z,1650469528.049 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:45:28.049Z,1650469528.049 [NAL9602](INFO): Packets left to send: 335
2022-04-20T15:45:34.976Z,1650469534.976 [NAL9602](INFO): SBD MO Status=1, MOMSN=37742, MT Status=0, MTMSN=0
2022-04-20T15:45:35.033Z,1650469535.033 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:45:35.033Z,1650469535.033 [NAL9602](INFO): Packets left to send: 334
2022-04-20T15:45:43.644Z,1650469543.644 [NAL9602](INFO): SBD MO Status=1, MOMSN=37743, MT Status=0, MTMSN=0
2022-04-20T15:45:43.697Z,1650469543.697 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:45:43.697Z,1650469543.697 [NAL9602](INFO): Packets left to send: 333
2022-04-20T15:45:53.052Z,1650469553.052 [NAL9602](INFO): SBD MO Status=1, MOMSN=37744, MT Status=0, MTMSN=0
2022-04-20T15:45:53.103Z,1650469553.103 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:45:53.103Z,1650469553.103 [NAL9602](INFO): Packets left to send: 332
2022-04-20T15:46:03.643Z,1650469563.643 [NAL9602](INFO): SBD MO Status=1, MOMSN=37745, MT Status=0, MTMSN=0
2022-04-20T15:46:03.705Z,1650469563.705 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:46:03.705Z,1650469563.705 [NAL9602](INFO): Packets left to send: 331
2022-04-20T15:46:10.293Z,1650469570.293 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:46:11.799Z,1650469571.799 [NAL9602](INFO): SBD MO Status=1, MOMSN=37746, MT Status=0, MTMSN=0
2022-04-20T15:46:11.849Z,1650469571.849 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:46:11.850Z,1650469571.850 [NAL9602](INFO): Packets left to send: 330
2022-04-20T15:46:24.267Z,1650469584.267 [NAL9602](INFO): SBD MO Status=1, MOMSN=37747, MT Status=0, MTMSN=0
2022-04-20T15:46:24.317Z,1650469584.317 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:46:24.317Z,1650469584.317 [NAL9602](INFO): Packets left to send: 329
2022-04-20T15:46:34.922Z,1650469594.922 [NAL9602](INFO): SBD MO Status=1, MOMSN=37748, MT Status=0, MTMSN=0
2022-04-20T15:46:34.973Z,1650469594.973 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:46:34.973Z,1650469594.973 [NAL9602](INFO): Packets left to send: 328
2022-04-20T15:46:45.433Z,1650469605.433 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:46:47.500Z,1650469607.500 [NAL9602](INFO): SBD MO Status=1, MOMSN=37749, MT Status=0, MTMSN=0
2022-04-20T15:46:47.553Z,1650469607.553 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:46:47.553Z,1650469607.553 [NAL9602](INFO): Packets left to send: 327
2022-04-20T15:46:58.899Z,1650469618.899 [NAL9602](INFO): SBD MO Status=1, MOMSN=37750, MT Status=0, MTMSN=0
2022-04-20T15:46:58.948Z,1650469618.948 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:46:58.948Z,1650469618.948 [NAL9602](INFO): Packets left to send: 326
2022-04-20T15:47:07.875Z,1650469627.875 [NAL9602](INFO): SBD MO Status=1, MOMSN=37751, MT Status=0, MTMSN=0
2022-04-20T15:47:07.929Z,1650469627.929 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:47:07.929Z,1650469627.929 [NAL9602](INFO): Packets left to send: 325
2022-04-20T15:47:17.291Z,1650469637.291 [NAL9602](INFO): SBD MO Status=1, MOMSN=37752, MT Status=0, MTMSN=0
2022-04-20T15:47:17.353Z,1650469637.353 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:47:17.353Z,1650469637.353 [NAL9602](INFO): Packets left to send: 324
2022-04-20T15:47:20.573Z,1650469640.573 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:47:28.712Z,1650469648.712 [NAL9602](INFO): SBD MO Status=1, MOMSN=37753, MT Status=0, MTMSN=0
2022-04-20T15:47:28.781Z,1650469648.781 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:47:28.781Z,1650469648.781 [NAL9602](INFO): Packets left to send: 323
2022-04-20T15:47:37.653Z,1650469657.653 [NAL9602](INFO): SBD MO Status=1, MOMSN=37754, MT Status=0, MTMSN=0
2022-04-20T15:47:37.705Z,1650469657.705 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:47:37.705Z,1650469657.705 [NAL9602](INFO): Packets left to send: 322
2022-04-20T15:47:55.713Z,1650469675.713 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:47:59.956Z,1650469679.956 [NAL9602](INFO): SBD MO Status=1, MOMSN=37755, MT Status=0, MTMSN=0
2022-04-20T15:48:00.007Z,1650469680.007 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:48:00.007Z,1650469680.007 [NAL9602](INFO): Packets left to send: 321
2022-04-20T15:48:10.143Z,1650469690.143 [NAL9602](INFO): SBD MO Status=1, MOMSN=37756, MT Status=0, MTMSN=0
2022-04-20T15:48:10.205Z,1650469690.205 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:48:10.205Z,1650469690.205 [NAL9602](INFO): Packets left to send: 320
2022-04-20T15:48:20.802Z,1650469700.802 [NAL9602](INFO): SBD MO Status=1, MOMSN=37757, MT Status=0, MTMSN=0
2022-04-20T15:48:20.861Z,1650469700.861 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:48:20.861Z,1650469700.861 [NAL9602](INFO): Packets left to send: 319
2022-04-20T15:48:30.865Z,1650469710.865 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:48:37.859Z,1650469717.859 [NAL9602](INFO): SBD MO Status=1, MOMSN=37758, MT Status=0, MTMSN=0
2022-04-20T15:48:37.909Z,1650469717.909 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:48:37.909Z,1650469717.909 [NAL9602](INFO): Packets left to send: 318
2022-04-20T15:48:46.873Z,1650469726.873 [NAL9602](INFO): SBD MO Status=1, MOMSN=37759, MT Status=0, MTMSN=0
2022-04-20T15:48:46.925Z,1650469726.925 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:48:46.925Z,1650469726.925 [NAL9602](INFO): Packets left to send: 317
2022-04-20T15:48:55.431Z,1650469735.431 [NAL9602](INFO): SBD MO Status=1, MOMSN=37760, MT Status=0, MTMSN=0
2022-04-20T15:48:55.485Z,1650469735.485 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:48:55.485Z,1650469735.485 [NAL9602](INFO): Packets left to send: 316
2022-04-20T15:49:05.235Z,1650469745.235 [NAL9602](INFO): SBD MO Status=1, MOMSN=37761, MT Status=0, MTMSN=0
2022-04-20T15:49:05.289Z,1650469745.289 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:49:05.289Z,1650469745.289 [NAL9602](INFO): Packets left to send: 315
2022-04-20T15:49:06.009Z,1650469746.009 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:49:17.877Z,1650469757.877 [NAL9602](INFO): SBD MO Status=1, MOMSN=37762, MT Status=0, MTMSN=0
2022-04-20T15:49:17.929Z,1650469757.929 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:49:17.929Z,1650469757.929 [NAL9602](INFO): Packets left to send: 314
2022-04-20T15:49:27.289Z,1650469767.289 [NAL9602](INFO): SBD MO Status=1, MOMSN=37763, MT Status=0, MTMSN=0
2022-04-20T15:49:27.339Z,1650469767.339 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:49:27.339Z,1650469767.339 [NAL9602](INFO): Packets left to send: 313
2022-04-20T15:49:38.283Z,1650469778.283 [NAL9602](INFO): SBD MO Status=1, MOMSN=37764, MT Status=0, MTMSN=0
2022-04-20T15:49:38.335Z,1650469778.335 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:49:38.335Z,1650469778.335 [NAL9602](INFO): Packets left to send: 312
2022-04-20T15:49:41.169Z,1650469781.169 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:49:48.070Z,1650469788.070 [NAL9602](INFO): SBD MO Status=1, MOMSN=37765, MT Status=0, MTMSN=0
2022-04-20T15:49:48.123Z,1650469788.123 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:49:48.123Z,1650469788.123 [NAL9602](INFO): Packets left to send: 311
2022-04-20T15:50:00.330Z,1650469800.330 [NAL9602](INFO): SBD MO Status=1, MOMSN=37766, MT Status=0, MTMSN=0
2022-04-20T15:50:00.378Z,1650469800.378 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:50:00.378Z,1650469800.378 [NAL9602](INFO): Packets left to send: 310
2022-04-20T15:50:16.309Z,1650469816.309 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:50:23.054Z,1650469823.054 [NAL9602](INFO): SBD MO Status=1, MOMSN=37767, MT Status=0, MTMSN=0
2022-04-20T15:50:23.101Z,1650469823.101 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:50:23.101Z,1650469823.101 [NAL9602](INFO): Packets left to send: 309
2022-04-20T15:50:38.503Z,1650469838.503 [NAL9602](INFO): SBD MO Status=1, MOMSN=37768, MT Status=0, MTMSN=0
2022-04-20T15:50:38.557Z,1650469838.557 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:50:38.558Z,1650469838.558 [NAL9602](INFO): Packets left to send: 308
2022-04-20T15:50:51.449Z,1650469851.449 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:50:59.596Z,1650469859.596 [NAL9602](INFO): SBD MO Status=1, MOMSN=37769, MT Status=0, MTMSN=0
2022-04-20T15:50:59.649Z,1650469859.649 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:50:59.649Z,1650469859.649 [NAL9602](INFO): Packets left to send: 307
2022-04-20T15:51:21.103Z,1650469881.103 [NAL9602](INFO): SBD MO Status=1, MOMSN=37770, MT Status=0, MTMSN=0
2022-04-20T15:51:21.153Z,1650469881.153 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:51:21.153Z,1650469881.153 [NAL9602](INFO): Packets left to send: 306
2022-04-20T15:51:26.589Z,1650469886.589 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:51:30.095Z,1650469890.095 [NAL9602](INFO): SBD MO Status=1, MOMSN=37771, MT Status=0, MTMSN=0
2022-04-20T15:51:30.145Z,1650469890.145 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:51:30.145Z,1650469890.145 [NAL9602](INFO): Packets left to send: 305
2022-04-20T15:51:46.803Z,1650469906.803 [NAL9602](INFO): SBD MO Status=1, MOMSN=37772, MT Status=0, MTMSN=0
2022-04-20T15:51:46.866Z,1650469906.866 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:51:46.866Z,1650469906.866 [NAL9602](INFO): Packets left to send: 304
2022-04-20T15:51:58.227Z,1650469918.227 [NAL9602](INFO): SBD MO Status=1, MOMSN=37773, MT Status=0, MTMSN=0
2022-04-20T15:51:58.277Z,1650469918.277 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:51:58.277Z,1650469918.277 [NAL9602](INFO): Packets left to send: 303
2022-04-20T15:52:01.733Z,1650469921.733 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:52:12.031Z,1650469932.031 [NAL9602](INFO): SBD MO Status=1, MOMSN=37774, MT Status=0, MTMSN=0
2022-04-20T15:52:12.085Z,1650469932.085 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:52:12.085Z,1650469932.085 [NAL9602](INFO): Packets left to send: 302
2022-04-20T15:52:22.607Z,1650469942.607 [NAL9602](INFO): SBD MO Status=1, MOMSN=37775, MT Status=0, MTMSN=0
2022-04-20T15:52:22.658Z,1650469942.658 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:52:22.658Z,1650469942.658 [NAL9602](INFO): Packets left to send: 301
2022-04-20T15:52:31.196Z,1650469951.196 [NAL9602](INFO): SBD MO Status=1, MOMSN=37776, MT Status=0, MTMSN=0
2022-04-20T15:52:31.246Z,1650469951.246 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:52:31.246Z,1650469951.246 [NAL9602](INFO): Packets left to send: 300
2022-04-20T15:52:36.885Z,1650469956.885 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:52:40.175Z,1650469960.175 [NAL9602](INFO): SBD MO Status=1, MOMSN=37777, MT Status=0, MTMSN=0
2022-04-20T15:52:40.225Z,1650469960.225 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:52:40.225Z,1650469960.225 [NAL9602](INFO): Packets left to send: 299
2022-04-20T15:52:49.140Z,1650469969.140 [NAL9602](INFO): SBD MO Status=1, MOMSN=37778, MT Status=0, MTMSN=0
2022-04-20T15:52:49.197Z,1650469969.197 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:52:49.197Z,1650469969.197 [NAL9602](INFO): Packets left to send: 298
2022-04-20T15:52:57.314Z,1650469977.314 [NAL9602](INFO): SBD MO Status=1, MOMSN=37779, MT Status=0, MTMSN=0
2022-04-20T15:52:57.365Z,1650469977.365 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:52:57.365Z,1650469977.365 [NAL9602](INFO): Packets left to send: 297
2022-04-20T15:53:06.279Z,1650469986.279 [NAL9602](INFO): SBD MO Status=1, MOMSN=37780, MT Status=0, MTMSN=0
2022-04-20T15:53:06.341Z,1650469986.341 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:53:06.341Z,1650469986.341 [NAL9602](INFO): Packets left to send: 296
2022-04-20T15:53:12.033Z,1650469992.033 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:53:14.851Z,1650469994.851 [NAL9602](INFO): SBD MO Status=1, MOMSN=37781, MT Status=0, MTMSN=0
2022-04-20T15:53:14.917Z,1650469994.917 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:53:14.917Z,1650469994.917 [NAL9602](INFO): Packets left to send: 295
2022-04-20T15:53:24.235Z,1650470004.235 [NAL9602](INFO): SBD MO Status=1, MOMSN=37782, MT Status=0, MTMSN=0
2022-04-20T15:53:24.293Z,1650470004.293 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:53:24.293Z,1650470004.293 [NAL9602](INFO): Packets left to send: 294
2022-04-20T15:53:37.665Z,1650470017.665 [NAL9602](INFO): SBD MO Status=1, MOMSN=37783, MT Status=0, MTMSN=0
2022-04-20T15:53:37.715Z,1650470017.715 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:53:37.715Z,1650470017.715 [NAL9602](INFO): Packets left to send: 293
2022-04-20T15:53:47.173Z,1650470027.173 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:53:49.456Z,1650470029.456 [NAL9602](INFO): SBD MO Status=1, MOMSN=37784, MT Status=0, MTMSN=0
2022-04-20T15:53:49.517Z,1650470029.517 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:53:49.517Z,1650470029.517 [NAL9602](INFO): Packets left to send: 292
2022-04-20T15:53:58.877Z,1650470038.877 [RDI_Pathfinder](ERROR): only read 2 of 4 data items
2022-04-20T15:54:02.102Z,1650470042.102 [NAL9602](INFO): SBD MO Status=1, MOMSN=37785, MT Status=0, MTMSN=0
2022-04-20T15:54:02.151Z,1650470042.151 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:54:02.151Z,1650470042.151 [NAL9602](INFO): Packets left to send: 291
2022-04-20T15:54:15.149Z,1650470055.149 [NAL9602](INFO): SBD MO Status=1, MOMSN=37786, MT Status=0, MTMSN=0
2022-04-20T15:54:15.203Z,1650470055.203 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:54:15.203Z,1650470055.203 [NAL9602](INFO): Packets left to send: 290
2022-04-20T15:54:22.321Z,1650470062.321 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:54:24.528Z,1650470064.528 [NAL9602](INFO): SBD MO Status=1, MOMSN=37787, MT Status=0, MTMSN=0
2022-04-20T15:54:24.579Z,1650470064.579 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:54:24.579Z,1650470064.579 [NAL9602](INFO): Packets left to send: 289
2022-04-20T15:54:34.296Z,1650470074.296 [NAL9602](INFO): SBD MO Status=1, MOMSN=37788, MT Status=0, MTMSN=0
2022-04-20T15:54:34.349Z,1650470074.349 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:54:34.349Z,1650470074.349 [NAL9602](INFO): Packets left to send: 288
2022-04-20T15:54:40.872Z,1650470080.872 [NAL9602](INFO): SBD MO Status=1, MOMSN=37789, MT Status=0, MTMSN=0
2022-04-20T15:54:40.929Z,1650470080.929 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:54:40.929Z,1650470080.929 [NAL9602](INFO): Packets left to send: 287
2022-04-20T15:54:49.419Z,1650470089.419 [NAL9602](INFO): SBD MO Status=1, MOMSN=37790, MT Status=0, MTMSN=0
2022-04-20T15:54:49.481Z,1650470089.481 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:54:49.481Z,1650470089.481 [NAL9602](INFO): Packets left to send: 286
2022-04-20T15:54:57.461Z,1650470097.461 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:54:58.891Z,1650470098.891 [NAL9602](INFO): SBD MO Status=1, MOMSN=37791, MT Status=0, MTMSN=0
2022-04-20T15:54:58.953Z,1650470098.953 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:54:58.953Z,1650470098.953 [NAL9602](INFO): Packets left to send: 285
2022-04-20T15:55:07.027Z,1650470107.027 [NAL9602](INFO): SBD MO Status=1, MOMSN=37792, MT Status=0, MTMSN=0
2022-04-20T15:55:07.078Z,1650470107.078 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:55:07.079Z,1650470107.079 [NAL9602](INFO): Packets left to send: 284
2022-04-20T15:55:17.621Z,1650470117.621 [NAL9602](INFO): SBD MO Status=1, MOMSN=37793, MT Status=0, MTMSN=0
2022-04-20T15:55:17.674Z,1650470117.674 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:55:17.674Z,1650470117.674 [NAL9602](INFO): Packets left to send: 283
2022-04-20T15:55:29.820Z,1650470129.820 [NAL9602](INFO): SBD MO Status=1, MOMSN=37794, MT Status=0, MTMSN=0
2022-04-20T15:55:29.869Z,1650470129.869 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:55:29.869Z,1650470129.869 [NAL9602](INFO): Packets left to send: 282
2022-04-20T15:55:32.601Z,1650470132.601 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:55:37.652Z,1650470137.652 [NAL9602](INFO): SBD MO Status=1, MOMSN=37795, MT Status=0, MTMSN=0
2022-04-20T15:55:37.703Z,1650470137.703 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:55:37.703Z,1650470137.703 [NAL9602](INFO): Packets left to send: 281
2022-04-20T15:55:46.228Z,1650470146.228 [NAL9602](INFO): SBD MO Status=1, MOMSN=37796, MT Status=0, MTMSN=0
2022-04-20T15:55:46.277Z,1650470146.277 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:55:46.277Z,1650470146.277 [NAL9602](INFO): Packets left to send: 280
2022-04-20T15:55:54.407Z,1650470154.407 [NAL9602](INFO): SBD MO Status=1, MOMSN=37797, MT Status=0, MTMSN=0
2022-04-20T15:55:54.469Z,1650470154.469 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:55:54.469Z,1650470154.469 [NAL9602](INFO): Packets left to send: 279
2022-04-20T15:56:04.979Z,1650470164.979 [NAL9602](INFO): SBD MO Status=1, MOMSN=37798, MT Status=0, MTMSN=0
2022-04-20T15:56:05.033Z,1650470165.033 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:56:05.033Z,1650470165.033 [NAL9602](INFO): Packets left to send: 278
2022-04-20T15:56:07.745Z,1650470167.745 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:56:16.838Z,1650470176.838 [NAL9602](INFO): SBD MO Status=1, MOMSN=37799, MT Status=0, MTMSN=0
2022-04-20T15:56:16.901Z,1650470176.901 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:56:16.901Z,1650470176.901 [NAL9602](INFO): Packets left to send: 277
2022-04-20T15:56:27.475Z,1650470187.475 [NAL9602](INFO): SBD MO Status=1, MOMSN=37800, MT Status=0, MTMSN=0
2022-04-20T15:56:27.525Z,1650470187.525 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:56:27.525Z,1650470187.525 [NAL9602](INFO): Packets left to send: 276
2022-04-20T15:56:41.347Z,1650470201.347 [NAL9602](INFO): SBD MO Status=1, MOMSN=37801, MT Status=0, MTMSN=0
2022-04-20T15:56:41.402Z,1650470201.402 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:56:41.402Z,1650470201.402 [NAL9602](INFO): Packets left to send: 275
2022-04-20T15:56:42.894Z,1650470202.894 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:56:51.147Z,1650470211.147 [NAL9602](INFO): SBD MO Status=1, MOMSN=37802, MT Status=0, MTMSN=0
2022-04-20T15:56:51.205Z,1650470211.205 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:56:51.205Z,1650470211.205 [NAL9602](INFO): Packets left to send: 274
2022-04-20T15:57:00.136Z,1650470220.136 [NAL9602](INFO): SBD MO Status=1, MOMSN=37803, MT Status=0, MTMSN=0
2022-04-20T15:57:00.193Z,1650470220.193 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:57:00.193Z,1650470220.193 [NAL9602](INFO): Packets left to send: 273
2022-04-20T15:57:08.748Z,1650470228.748 [NAL9602](INFO): SBD MO Status=1, MOMSN=37804, MT Status=0, MTMSN=0
2022-04-20T15:57:08.805Z,1650470228.805 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:57:08.805Z,1650470228.805 [NAL9602](INFO): Packets left to send: 272
2022-04-20T15:57:17.317Z,1650470237.317 [NAL9602](INFO): SBD MO Status=1, MOMSN=37805, MT Status=0, MTMSN=0
2022-04-20T15:57:17.378Z,1650470237.378 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:57:17.378Z,1650470237.378 [NAL9602](INFO): Packets left to send: 271
2022-04-20T15:57:18.033Z,1650470238.033 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:57:27.541Z,1650470247.541 [NAL9602](INFO): SBD MO Status=1, MOMSN=37806, MT Status=0, MTMSN=0
2022-04-20T15:57:27.593Z,1650470247.593 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:57:27.593Z,1650470247.593 [NAL9602](INFO): Packets left to send: 270
2022-04-20T15:57:38.519Z,1650470258.519 [NAL9602](INFO): SBD MO Status=1, MOMSN=37807, MT Status=0, MTMSN=0
2022-04-20T15:57:38.569Z,1650470258.569 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:57:38.569Z,1650470258.569 [NAL9602](INFO): Packets left to send: 269
2022-04-20T15:57:49.937Z,1650470269.937 [NAL9602](INFO): SBD MO Status=1, MOMSN=37808, MT Status=0, MTMSN=0
2022-04-20T15:57:49.997Z,1650470269.997 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:57:49.997Z,1650470269.997 [NAL9602](INFO): Packets left to send: 268
2022-04-20T15:57:53.173Z,1650470273.173 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:58:00.567Z,1650470280.567 [NAL9602](INFO): SBD MO Status=1, MOMSN=37809, MT Status=0, MTMSN=0
2022-04-20T15:58:00.617Z,1650470280.617 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:58:00.617Z,1650470280.617 [NAL9602](INFO): Packets left to send: 267
2022-04-20T15:58:11.549Z,1650470291.549 [NAL9602](INFO): SBD MO Status=1, MOMSN=37810, MT Status=0, MTMSN=0
2022-04-20T15:58:11.603Z,1650470291.603 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:58:11.603Z,1650470291.603 [NAL9602](INFO): Packets left to send: 266
2022-04-20T15:58:25.777Z,1650470305.777 [NAL9602](INFO): SBD MO Status=2, MOMSN=37811, MT Status=2, MTMSN=0
2022-04-20T15:58:25.777Z,1650470305.777 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2022-04-20T15:58:28.313Z,1650470308.313 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:58:50.163Z,1650470330.163 [NAL9602](INFO): SBD MO Status=2, MOMSN=37811, MT Status=2, MTMSN=0
2022-04-20T15:58:50.163Z,1650470330.163 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2022-04-20T15:59:03.453Z,1650470343.453 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:59:20.553Z,1650470360.553 [NAL9602](INFO): SBD MO Status=1, MOMSN=37811, MT Status=0, MTMSN=0
2022-04-20T15:59:20.607Z,1650470360.607 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:59:20.607Z,1650470360.607 [NAL9602](INFO): Packets left to send: 265
2022-04-20T15:59:34.367Z,1650470374.367 [NAL9602](INFO): SBD MO Status=1, MOMSN=37812, MT Status=0, MTMSN=0
2022-04-20T15:59:34.421Z,1650470374.421 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:59:34.421Z,1650470374.421 [NAL9602](INFO): Packets left to send: 264
2022-04-20T15:59:38.597Z,1650470378.597 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T15:59:49.059Z,1650470389.059 [NAL9602](INFO): SBD MO Status=1, MOMSN=37813, MT Status=0, MTMSN=0
2022-04-20T15:59:49.109Z,1650470389.109 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T15:59:49.109Z,1650470389.109 [NAL9602](INFO): Packets left to send: 263
2022-04-20T16:00:10.526Z,1650470410.526 [NAL9602](INFO): SBD MO Status=1, MOMSN=37814, MT Status=0, MTMSN=0
2022-04-20T16:00:10.578Z,1650470410.578 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:00:10.579Z,1650470410.579 [NAL9602](INFO): Packets left to send: 262
2022-04-20T16:00:13.741Z,1650470413.741 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:00:22.781Z,1650470422.781 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002674
2022-04-20T16:00:29.000Z,1650470430.000 [NAL9602](INFO): SBD MO Status=1, MOMSN=37815, MT Status=0, MTMSN=0
2022-04-20T16:00:30.049Z,1650470430.049 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:00:30.049Z,1650470430.049 [NAL9602](INFO): Packets left to send: 261
2022-04-20T16:01:01.110Z,1650470461.110 [NAL9602](INFO): Not Powering down - fast GPS
2022-04-20T16:01:23.018Z,1650470483.018 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.239628
2022-04-20T16:01:24.134Z,1650470484.134 [DropWeight](CRITICAL): DROP WEIGHT MISSING.

2022-04-20T16:01:24.134Z,1650470484.134 [DropWeight] Hardware Fault, FailCount= 1
2022-04-20T16:01:24.134Z,1650470484.134 [DropWeight](ERROR): Hardware Fault
2022-04-20T16:01:24.202Z,1650470484.202 [CBIT](INFO): Critical error at 20220420T160124
2022-04-20T16:01:24.204Z,1650470484.204 [CBIT](ERROR): Hardware Fault in component: DropWeight
2022-04-20T16:01:24.217Z,1650470484.217 [CBIT](CRITICAL): Hardware Fault in component: DropWeight
2022-04-20T16:01:24.564Z,1650470484.564 [CBIT](INFO): Critical error at 20220420T160124
2022-04-20T16:01:40.089Z,1650470500.089 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002832
2022-04-20T16:01:46.151Z,1650470506.151 [NAL9602](INFO): SBD MO Status=1, MOMSN=37816, MT Status=0, MTMSN=0
2022-04-20T16:01:46.209Z,1650470506.209 [NAL9602](INFO): Sent 52 bytes from file Logs/20220420T151609/Courier0010.lzma
2022-04-20T16:01:46.209Z,1650470506.209 [NAL9602](INFO): Packets left to send: 0
2022-04-20T16:01:46.258Z,1650470506.258 [Default:CheckIn:Read_Iridium] Stopped
2022-04-20T16:01:46.258Z,1650470506.258 [Default:CheckIn:C.Wait] Running Loop=1
2022-04-20T16:01:46.258Z,1650470506.258 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component.
2022-04-20T16:02:11.217Z,1650470531.217 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:02:16.862Z,1650470536.862 [NAL9602](INFO): Not Powering down - fast GPS
2022-04-20T16:02:40.335Z,1650470560.335 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.248543
2022-04-20T16:03:17.481Z,1650470597.481 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:03:52.621Z,1650470632.621 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:04:27.761Z,1650470667.761 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:04:57.897Z,1650470697.897 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.002708
2022-04-20T16:05:38.054Z,1650470738.054 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:05:58.133Z,1650470758.133 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.239449
2022-04-20T16:06:46.770Z,1650470806.770 [Default:CheckIn:C.Wait](INFO): Done Waiting.
2022-04-20T16:06:46.770Z,1650470806.770 [Default:CheckIn:C.Wait] Stopped
2022-04-20T16:06:46.770Z,1650470806.770 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component.
2022-04-20T16:06:46.770Z,1650470806.770 [Default:CheckIn:D] Running Loop=1
2022-04-20T16:06:47.167Z,1650470807.167 [Default:CheckIn:D] Stopped
2022-04-20T16:06:47.167Z,1650470807.167 [Default:CheckIn:E] Running Loop=1
2022-04-20T16:06:47.549Z,1650470807.549 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 47.028206 min 
2022-04-20T16:06:47.549Z,1650470807.549 [Default:CheckIn:E] Stopped
2022-04-20T16:06:47.549Z,1650470807.549 [Default:CheckIn](INFO): Completed Default:CheckIn
2022-04-20T16:06:47.550Z,1650470807.550 [Default:CheckIn] Stopped
2022-04-20T16:06:47.550Z,1650470807.550 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-04-20T16:06:47.550Z,1650470807.550 [Default:CheckIn](INFO): Running loop #3
2022-04-20T16:06:47.550Z,1650470807.550 [Default:CheckIn] Running Loop=3
2022-04-20T16:06:47.550Z,1650470807.550 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2022-04-20T16:06:47.550Z,1650470807.550 [Default:CheckIn:Read_GPS] Running Loop=1
2022-04-20T16:06:48.333Z,1650470808.333 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:06:49.552Z,1650470809.552 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,160652.00,A,4130.68680,N,07047.26271,W,0.428,103.31,200422,,,A*70
2022-04-20T16:06:49.555Z,1650470809.555 [NAL9602](INFO): GPS fix at 20220420T160652: (41.511447, -70.787712)
2022-04-20T16:06:49.569Z,1650470809.569 [UniversalFixResidualReporter](INFO): Fix residual: 10.0 %DT, over the last 665.4 m. Residual distance 66.6 m at bearing -45.7 degrees. Fix at (41.5114, -70.7877) with 314.2 m made good.
2022-04-20T16:06:49.571Z,1650470809.571 [Default:CheckIn:Read_GPS] Stopped
2022-04-20T16:06:49.571Z,1650470809.571 [Default:CheckIn:Read_Iridium] Running Loop=1
2022-04-20T16:07:21.551Z,1650470841.551 [NAL9602](INFO): SBD MO Status=1, MOMSN=37817, MT Status=0, MTMSN=0
2022-04-20T16:07:21.606Z,1650470841.606 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T151609/Courier0013.lzma
2022-04-20T16:07:21.606Z,1650470841.606 [NAL9602](INFO): Packets left to send: 1
2022-04-20T16:07:23.481Z,1650470843.481 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:07:33.784Z,1650470853.784 [NAL9602](INFO): SBD MO Status=1, MOMSN=37818, MT Status=0, MTMSN=0
2022-04-20T16:07:33.841Z,1650470853.841 [NAL9602](INFO): Sent 86 bytes from file Logs/20220420T151609/Courier0013.lzma
2022-04-20T16:07:33.841Z,1650470853.841 [NAL9602](INFO): Packets left to send: 0
2022-04-20T16:07:53.273Z,1650470873.273 [NAL9602](INFO): SBD MO Status=1, MOMSN=37819, MT Status=0, MTMSN=0
2022-04-20T16:07:53.333Z,1650470873.333 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:07:53.333Z,1650470873.333 [NAL9602](INFO): Packets left to send: 260
2022-04-20T16:07:58.621Z,1650470878.621 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:08:04.713Z,1650470884.713 [NAL9602](INFO): SBD MO Status=1, MOMSN=37820, MT Status=0, MTMSN=0
2022-04-20T16:08:04.773Z,1650470884.773 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:08:04.773Z,1650470884.773 [NAL9602](INFO): Packets left to send: 259
2022-04-20T16:08:16.079Z,1650470896.079 [NAL9602](INFO): SBD MO Status=2, MOMSN=37821, MT Status=2, MTMSN=0
2022-04-20T16:08:16.079Z,1650470896.079 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2022-04-20T16:08:33.793Z,1650470913.793 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:08:38.796Z,1650470918.796 [NAL9602](INFO): SBD MO Status=1, MOMSN=37821, MT Status=0, MTMSN=0
2022-04-20T16:08:38.845Z,1650470918.845 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:08:38.845Z,1650470918.845 [NAL9602](INFO): Packets left to send: 258
2022-04-20T16:08:52.231Z,1650470932.231 [NAL9602](INFO): SBD MO Status=1, MOMSN=37822, MT Status=0, MTMSN=0
2022-04-20T16:08:52.281Z,1650470932.281 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:08:52.281Z,1650470932.281 [NAL9602](INFO): Packets left to send: 257
2022-04-20T16:09:08.941Z,1650470948.941 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:09:16.143Z,1650470956.143 [NAL9602](INFO): SBD MO Status=1, MOMSN=37823, MT Status=0, MTMSN=0
2022-04-20T16:09:16.197Z,1650470956.197 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:09:16.197Z,1650470956.197 [NAL9602](INFO): Packets left to send: 256
2022-04-20T16:09:29.161Z,1650470969.161 [NAL9602](INFO): SBD MO Status=1, MOMSN=37824, MT Status=0, MTMSN=0
2022-04-20T16:09:29.214Z,1650470969.214 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:09:29.214Z,1650470969.214 [NAL9602](INFO): Packets left to send: 255
2022-04-20T16:09:40.210Z,1650470980.210 [NAL9602](INFO): SBD MO Status=1, MOMSN=37825, MT Status=0, MTMSN=0
2022-04-20T16:09:40.269Z,1650470980.269 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:09:40.269Z,1650470980.269 [NAL9602](INFO): Packets left to send: 254
2022-04-20T16:09:44.081Z,1650470984.081 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:09:54.889Z,1650470994.889 [NAL9602](INFO): SBD MO Status=1, MOMSN=37826, MT Status=0, MTMSN=0
2022-04-20T16:09:54.945Z,1650470994.945 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:09:54.945Z,1650470994.945 [NAL9602](INFO): Packets left to send: 253
2022-04-20T16:10:03.457Z,1650471003.457 [NAL9602](INFO): SBD MO Status=1, MOMSN=37827, MT Status=0, MTMSN=0
2022-04-20T16:10:03.510Z,1650471003.510 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:10:03.510Z,1650471003.510 [NAL9602](INFO): Packets left to send: 252
2022-04-20T16:10:14.103Z,1650471014.103 [NAL9602](INFO): SBD MO Status=1, MOMSN=37828, MT Status=0, MTMSN=0
2022-04-20T16:10:14.165Z,1650471014.165 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:10:14.165Z,1650471014.165 [NAL9602](INFO): Packets left to send: 251
2022-04-20T16:10:19.221Z,1650471019.221 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:10:31.747Z,1650471031.747 [NAL9602](INFO): SBD MO Status=1, MOMSN=37829, MT Status=0, MTMSN=0
2022-04-20T16:10:31.809Z,1650471031.809 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:10:31.809Z,1650471031.809 [NAL9602](INFO): Packets left to send: 250
2022-04-20T16:10:41.967Z,1650471041.967 [NAL9602](INFO): SBD MO Status=1, MOMSN=37830, MT Status=0, MTMSN=0
2022-04-20T16:10:42.025Z,1650471042.025 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:10:42.025Z,1650471042.025 [NAL9602](INFO): Packets left to send: 249
2022-04-20T16:10:54.362Z,1650471054.362 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:10:57.017Z,1650471057.017 [NAL9602](INFO): SBD MO Status=1, MOMSN=37831, MT Status=0, MTMSN=0
2022-04-20T16:10:57.069Z,1650471057.069 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:10:57.069Z,1650471057.069 [NAL9602](INFO): Packets left to send: 248
2022-04-20T16:11:07.243Z,1650471067.243 [NAL9602](INFO): SBD MO Status=1, MOMSN=37832, MT Status=0, MTMSN=0
2022-04-20T16:11:07.305Z,1650471067.305 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:11:07.305Z,1650471067.305 [NAL9602](INFO): Packets left to send: 247
2022-04-20T16:11:17.887Z,1650471077.887 [NAL9602](INFO): SBD MO Status=1, MOMSN=37833, MT Status=0, MTMSN=0
2022-04-20T16:11:17.941Z,1650471077.941 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:11:17.941Z,1650471077.941 [NAL9602](INFO): Packets left to send: 246
2022-04-20T16:11:27.711Z,1650471087.711 [NAL9602](INFO): SBD MO Status=1, MOMSN=37834, MT Status=0, MTMSN=0
2022-04-20T16:11:27.761Z,1650471087.761 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:11:27.761Z,1650471087.761 [NAL9602](INFO): Packets left to send: 245
2022-04-20T16:11:29.509Z,1650471089.509 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:11:49.202Z,1650471109.202 [NAL9602](INFO): SBD MO Status=1, MOMSN=37835, MT Status=0, MTMSN=0
2022-04-20T16:11:49.255Z,1650471109.255 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:11:49.255Z,1650471109.255 [NAL9602](INFO): Packets left to send: 244
2022-04-20T16:11:56.155Z,1650471116.155 [NAL9602](INFO): SBD MO Status=1, MOMSN=37836, MT Status=0, MTMSN=0
2022-04-20T16:11:56.209Z,1650471116.209 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:11:56.209Z,1650471116.209 [NAL9602](INFO): Packets left to send: 243
2022-04-20T16:12:04.650Z,1650471124.650 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:12:07.191Z,1650471127.191 [NAL9602](INFO): SBD MO Status=1, MOMSN=37837, MT Status=0, MTMSN=0
2022-04-20T16:12:07.249Z,1650471127.249 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:12:07.249Z,1650471127.249 [NAL9602](INFO): Packets left to send: 242
2022-04-20T16:12:19.431Z,1650471139.431 [NAL9602](INFO): SBD MO Status=1, MOMSN=37838, MT Status=0, MTMSN=0
2022-04-20T16:12:19.481Z,1650471139.481 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:12:19.481Z,1650471139.481 [NAL9602](INFO): Packets left to send: 241
2022-04-20T16:12:36.077Z,1650471156.077 [NAL9602](INFO): SBD MO Status=1, MOMSN=37839, MT Status=0, MTMSN=0
2022-04-20T16:12:36.137Z,1650471156.137 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:12:36.137Z,1650471156.137 [NAL9602](INFO): Packets left to send: 240
2022-04-20T16:12:39.789Z,1650471159.789 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:13:00.431Z,1650471180.431 [NAL9602](INFO): SBD MO Status=1, MOMSN=37840, MT Status=0, MTMSN=0
2022-04-20T16:13:00.493Z,1650471180.493 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:13:00.493Z,1650471180.493 [NAL9602](INFO): Packets left to send: 239
2022-04-20T16:13:13.037Z,1650471193.037 [NAL9602](INFO): SBD MO Status=1, MOMSN=37841, MT Status=0, MTMSN=0
2022-04-20T16:13:13.081Z,1650471193.081 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:13:13.081Z,1650471193.081 [NAL9602](INFO): Packets left to send: 238
2022-04-20T16:13:14.929Z,1650471194.929 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:13:24.455Z,1650471204.455 [NAL9602](INFO): SBD MO Status=1, MOMSN=37842, MT Status=0, MTMSN=0
2022-04-20T16:13:24.509Z,1650471204.509 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:13:24.509Z,1650471204.509 [NAL9602](INFO): Packets left to send: 237
2022-04-20T16:13:34.243Z,1650471214.243 [NAL9602](INFO): SBD MO Status=1, MOMSN=37843, MT Status=0, MTMSN=0
2022-04-20T16:13:34.305Z,1650471214.305 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:13:34.305Z,1650471214.305 [NAL9602](INFO): Packets left to send: 236
2022-04-20T16:13:41.209Z,1650471221.209 [NAL9602](INFO): SBD MO Status=1, MOMSN=37844, MT Status=0, MTMSN=0
2022-04-20T16:13:41.257Z,1650471221.257 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:13:41.257Z,1650471221.257 [NAL9602](INFO): Packets left to send: 235
2022-04-20T16:13:47.375Z,1650471227.375 [NAL9602](INFO): SBD MO Status=1, MOMSN=37845, MT Status=0, MTMSN=0
2022-04-20T16:13:47.433Z,1650471227.433 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:13:47.433Z,1650471227.433 [NAL9602](INFO): Packets left to send: 234
2022-04-20T16:13:50.070Z,1650471230.070 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:13:58.871Z,1650471238.871 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=37846, MT Status=1, MTMSN=1454
2022-04-20T16:13:58.925Z,1650471238.925 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:13:58.925Z,1650471238.925 [NAL9602](INFO): Packets left to send: 233
2022-04-20T16:13:59.417Z,1650471239.417 [NAL9602](INFO): Received command: configSet DropWeight.loadAtStartup 0 bool persist
2022-04-20T16:13:59.779Z,1650471239.779 [CommandExec](IMPORTANT): got command configSet DropWeight.loadAtStartup 0 bool persist
2022-04-20T16:13:59.780Z,1650471239.780 [CommandExec](IMPORTANT): configSet DropWeight.loadAtStartup requires a restart to take effect.
2022-04-20T16:14:16.747Z,1650471256.747 [NAL9602](INFO): SBD MO Status=1, MOMSN=37847, MT Status=0, MTMSN=0
2022-04-20T16:14:16.793Z,1650471256.793 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:14:16.793Z,1650471256.793 [NAL9602](INFO): Packets left to send: 232
2022-04-20T16:14:24.519Z,1650471264.519 [NAL9602](INFO): SBD MO Status=1, MOMSN=37848, MT Status=0, MTMSN=0
2022-04-20T16:14:24.577Z,1650471264.577 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:14:24.577Z,1650471264.577 [NAL9602](INFO): Packets left to send: 231
2022-04-20T16:14:25.221Z,1650471265.221 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:14:35.143Z,1650471275.143 [NAL9602](INFO): SBD MO Status=1, MOMSN=37849, MT Status=0, MTMSN=0
2022-04-20T16:14:35.197Z,1650471275.197 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:14:35.197Z,1650471275.197 [NAL9602](INFO): Packets left to send: 230
2022-04-20T16:14:47.369Z,1650471287.369 [NAL9602](INFO): SBD MO Status=1, MOMSN=37850, MT Status=0, MTMSN=0
2022-04-20T16:14:47.419Z,1650471287.419 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:14:47.419Z,1650471287.419 [NAL9602](INFO): Packets left to send: 229
2022-04-20T16:14:55.595Z,1650471295.595 [NAL9602](INFO): SBD MO Status=1, MOMSN=37851, MT Status=0, MTMSN=0
2022-04-20T16:14:55.645Z,1650471295.645 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:14:55.645Z,1650471295.645 [NAL9602](INFO): Packets left to send: 228
2022-04-20T16:15:12.251Z,1650471312.251 [NAL9602](INFO): SBD MO Status=1, MOMSN=37852, MT Status=0, MTMSN=0
2022-04-20T16:15:12.309Z,1650471312.309 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:15:12.309Z,1650471312.309 [NAL9602](INFO): Packets left to send: 227
2022-04-20T16:15:23.276Z,1650471323.276 [NAL9602](INFO): SBD MO Status=1, MOMSN=37853, MT Status=0, MTMSN=0
2022-04-20T16:15:23.325Z,1650471323.325 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:15:23.325Z,1650471323.325 [NAL9602](INFO): Packets left to send: 226
2022-04-20T16:15:34.284Z,1650471334.284 [NAL9602](INFO): SBD MO Status=1, MOMSN=37854, MT Status=0, MTMSN=0
2022-04-20T16:15:34.341Z,1650471334.341 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:15:34.341Z,1650471334.341 [NAL9602](INFO): Packets left to send: 225
2022-04-20T16:15:35.525Z,1650471335.525 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting.
2022-04-20T16:15:48.913Z,1650471348.913 [NAL9602](INFO): SBD MO Status=1, MOMSN=37855, MT Status=0, MTMSN=0
2022-04-20T16:15:48.966Z,1650471348.966 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:15:48.966Z,1650471348.966 [NAL9602](INFO): Packets left to send: 224
2022-04-20T16:15:59.899Z,1650471359.899 [NAL9602](IMPORTANT): SBD MO Status=1, MOMSN=37856, MT Status=1, MTMSN=1455
2022-04-20T16:15:59.953Z,1650471359.953 [NAL9602](INFO): Sent 184 bytes from file Logs/20220420T044011/Express0037.lzma
2022-04-20T16:15:59.953Z,1650471359.953 [NAL9602](INFO): Packets left to send: 223
2022-04-20T16:16:00.389Z,1650471360.389 [NAL9602](INFO): Received command: restart app
2022-04-20T16:16:00.454Z,1650471360.454 [CommandExec](IMPORTANT): got command restart application
2022-04-20T16:16:01.457Z,1650471361.457 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread.
2022-04-20T16:16:01.457Z,1650471361.457 [CommandExec](INFO): Uninitializing the command executive.
2022-04-20T16:16:01.457Z,1650471361.457 [CommandExec](INFO): Uninitializing the command scheduler.
2022-04-20T16:16:01.457Z,1650471361.457 [CommandExec ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:01.633Z,1650471361.633 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2022-04-20T16:16:01.633Z,1650471361.633 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2022-04-20T16:16:01.633Z,1650471361.633 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:01.634Z,1650471361.634 [NavChartDb](INFO): Join timeout helper Thread ID is 9753
2022-04-20T16:16:01.945Z,1650471361.945 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2022-04-20T16:16:01.945Z,1650471361.945 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:01.957Z,1650471361.957 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler
2022-04-20T16:16:01.957Z,1650471361.957 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:01.957Z,1650471361.957 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 9754
2022-04-20T16:16:02.009Z,1650471362.009 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread.
2022-04-20T16:16:02.009Z,1650471362.009 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:02.025Z,1650471362.025 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2022-04-20T16:16:02.025Z,1650471362.025 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:02.025Z,1650471362.025 [CTD_Seabird](INFO): Join timeout helper Thread ID is 9755
2022-04-20T16:16:02.725Z,1650471362.725 [CTD_Seabird](INFO): Powering down
2022-04-20T16:16:02.737Z,1650471362.737 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2022-04-20T16:16:02.737Z,1650471362.737 [CTD_Seabird](INFO): Powering down
2022-04-20T16:16:02.749Z,1650471362.749 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:02.761Z,1650471362.761 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2022-04-20T16:16:02.761Z,1650471362.761 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:02.761Z,1650471362.761 [Radio_Surface](INFO): Join timeout helper Thread ID is 9756
2022-04-20T16:16:02.977Z,1650471362.977 [Radio_Surface](INFO): Powering down
2022-04-20T16:16:02.978Z,1650471362.978 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2022-04-20T16:16:02.978Z,1650471362.978 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:02.985Z,1650471362.985 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2022-04-20T16:16:02.985Z,1650471362.985 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:02.985Z,1650471362.985 [Onboard](INFO): Join timeout helper Thread ID is 9757
2022-04-20T16:16:04.793Z,1650471364.793 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2022-04-20T16:16:04.793Z,1650471364.793 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:04.814Z,1650471364.814 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2022-04-20T16:16:04.814Z,1650471364.814 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:04.814Z,1650471364.814 [DataOverHttps](INFO): Join timeout helper Thread ID is 9758
2022-04-20T16:16:05.645Z,1650471365.645 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread.
2022-04-20T16:16:05.645Z,1650471365.645 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:05.665Z,1650471365.665 [ComponentRegistry](INFO): Shutting down BackseatComponent ThreadHandler
2022-04-20T16:16:05.665Z,1650471365.665 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:05.666Z,1650471365.666 [BackseatComponent](INFO): Join timeout helper Thread ID is 9759
2022-04-20T16:16:05.777Z,1650471365.777 [BackseatComponent ThreadHandler](INFO): Uninitializing protected caller thread.
2022-04-20T16:16:05.777Z,1650471365.777 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:05.785Z,1650471365.785 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2022-04-20T16:16:05.785Z,1650471365.785 [logger ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:05.786Z,1650471365.786 [logger](INFO): Join timeout helper Thread ID is 9760
2022-04-20T16:16:05.806Z,1650471365.806 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2022-04-20T16:16:05.807Z,1650471365.807 [logger ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:05.826Z,1650471365.826 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2022-04-20T16:16:05.826Z,1650471365.826 [CommandLine ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:05.826Z,1650471365.826 [CommandLine](INFO): Join timeout helper Thread ID is 9761
2022-04-20T16:16:05.833Z,1650471365.833 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2022-04-20T16:16:05.833Z,1650471365.833 [CommandLine ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:05.847Z,1650471365.847 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler
2022-04-20T16:16:05.847Z,1650471365.847 [CommandExec ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:05.848Z,1650471365.848 [CommandExec](INFO): Join timeout helper Thread ID is 9762
2022-04-20T16:16:05.851Z,1650471365.851 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2022-04-20T16:16:05.851Z,1650471365.851 [controlThread ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:05.852Z,1650471365.852 [controlThread](INFO): Join timeout helper Thread ID is 9763
2022-04-20T16:16:07.621Z,1650471367.621 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2022-04-20T16:16:07.621Z,1650471367.621 [controlThread](DEBUG): Uninitializing ControlThread
2022-04-20T16:16:07.622Z,1650471367.622 [AHRS_M2](INFO): Powering down
2022-04-20T16:16:07.693Z,1650471367.693 [NAL9602](INFO): Powering down
2022-04-20T16:16:07.765Z,1650471367.765 [RDI_Pathfinder](INFO): Powering down
2022-04-20T16:16:07.837Z,1650471367.837 [RDI_PathfinderUp](INFO): Powering down
2022-04-20T16:16:07.838Z,1650471367.838 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2022-04-20T16:16:07.839Z,1650471367.839 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2022-04-20T16:16:07.840Z,1650471367.840 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2022-04-20T16:16:07.841Z,1650471367.841 [MissionManager](INFO): Uninitializing Mission Default
2022-04-20T16:16:07.841Z,1650471367.841 [Default] Stopped
2022-04-20T16:16:07.841Z,1650471367.841 [Default](DEBUG): Aggregate::uninitialize Default
2022-04-20T16:16:07.841Z,1650471367.841 [Default:B.GoToSurface] Stopped
2022-04-20T16:16:07.841Z,1650471367.841 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2022-04-20T16:16:07.841Z,1650471367.841 [Default:CheckIn] Stopped
2022-04-20T16:16:07.841Z,1650471367.841 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2022-04-20T16:16:07.841Z,1650471367.841 [Default:CheckIn:Read_Iridium] Stopped
2022-04-20T16:16:07.844Z,1650471367.844 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2022-04-20T16:16:07.844Z,1650471367.844 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2022-04-20T16:16:07.844Z,1650471367.844 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2022-04-20T16:16:07.845Z,1650471367.845 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2022-04-20T16:16:07.845Z,1650471367.845 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2022-04-20T16:16:07.845Z,1650471367.845 [BuoyancyServo](INFO): Powering down
2022-04-20T16:16:07.857Z,1650471367.857 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2022-04-20T16:16:07.857Z,1650471367.857 [ElevatorServo](INFO): Powering down
2022-04-20T16:16:07.858Z,1650471367.858 [MassServo](DEBUG): Uninitialize Mass Servo.
2022-04-20T16:16:07.858Z,1650471367.858 [MassServo](INFO): Powering down
2022-04-20T16:16:07.859Z,1650471367.859 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2022-04-20T16:16:07.859Z,1650471367.859 [RudderServo](INFO): Powering down
2022-04-20T16:16:07.860Z,1650471367.860 [ThrusterHE](DEBUG): Uninitialize Thruster Servo.
2022-04-20T16:16:07.860Z,1650471367.860 [ThrusterHE](INFO): Powering down
2022-04-20T16:16:07.861Z,1650471367.861 [SBIT](DEBUG): Uninitialize SBIT Component.
2022-04-20T16:16:07.861Z,1650471367.861 [IBIT](DEBUG): Uninitialize IBIT Component.
2022-04-20T16:16:07.861Z,1650471367.861 [CBIT](DEBUG): Uninitialize CBIT Component.
2022-04-20T16:16:07.861Z,1650471367.861 [CBIT](DEBUG): Powering off loads.
2022-04-20T16:16:07.872Z,1650471367.872 [CBIT](DEBUG): Disabling WDT.
2022-04-20T16:16:07.884Z,1650471367.884 [CBIT](DEBUG): Opening all GF detection circuits.
2022-04-20T16:16:07.886Z,1650471367.886 [controlThread ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:07.902Z,1650471367.902 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:07.906Z,1650471367.906 [Onboard ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:07.912Z,1650471367.912 [DataOverHttps ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:07.954Z,1650471367.954 [BackseatComponent ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:08.002Z,1650471368.002 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:08.005Z,1650471368.005 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:08.064Z,1650471368.064 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2022-04-20T16:16:08.135Z,1650471368.135 [logger ThreadHandler](INFO): Thread cancelled.