2021-04-12T03:57:48.609Z,1618199868.609 [Supervisor](DEBUG): Initializing supervisor.
2021-04-12T03:57:48.614Z,1618199868.614 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2021-04-12T03:57:48.614Z,1618199868.614 [SyncHandler](INFO): Protected caller Thread ID is 820
2021-04-12T03:57:48.615Z,1618199868.615 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2021-04-12T03:57:48.616Z,1618199868.616 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2021-04-12T03:57:48.616Z,1618199868.616 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 821
2021-04-12T03:57:48.621Z,1618199868.621 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2021-04-12T03:57:48.641Z,1618199868.641 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2021-04-12T03:57:48.642Z,1618199868.642 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2021-04-12T03:57:48.642Z,1618199868.642 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 822
2021-04-12T03:57:48.644Z,1618199868.644 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2021-04-12T03:57:48.645Z,1618199868.645 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2021-04-12T03:57:48.646Z,1618199868.646 [logger ThreadHandler](INFO): Protected caller Thread ID is 823
2021-04-12T03:57:48.650Z,1618199868.650 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2021-04-12T03:57:48.650Z,1618199868.650 [Supervisor](INFO): Looking for Config files in directory: Config/
2021-04-12T03:57:48.654Z,1618199868.654 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2021-04-12T03:57:49.025Z,1618199869.025 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2021-04-12T03:57:49.027Z,1618199869.027 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2021-04-12T03:57:49.718Z,1618199869.718 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2021-04-12T03:57:49.720Z,1618199869.720 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2021-04-12T03:57:49.824Z,1618199869.824 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2021-04-12T03:57:49.825Z,1618199869.825 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2021-04-12T03:57:50.391Z,1618199870.391 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2021-04-12T03:57:50.393Z,1618199870.393 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2021-04-12T03:57:50.493Z,1618199870.493 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2021-04-12T03:57:50.493Z,1618199870.493 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2021-04-12T03:57:50.577Z,1618199870.577 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2021-04-12T03:57:50.970Z,1618199870.970 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2021-04-12T03:57:50.972Z,1618199870.972 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2021-04-12T03:57:51.130Z,1618199871.130 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2021-04-12T03:57:51.130Z,1618199871.130 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2021-04-12T03:57:51.263Z,1618199871.263 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2021-04-12T03:57:51.264Z,1618199871.264 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg
2021-04-12T03:57:51.515Z,1618199871.515 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock
2021-04-12T03:57:51.516Z,1618199871.516 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2021-04-12T03:57:52.004Z,1618199872.004 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2021-04-12T03:57:52.289Z,1618199872.289 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2021-04-12T03:57:52.915Z,1618199872.915 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2021-04-12T03:57:52.917Z,1618199872.917 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2021-04-12T03:57:52.998Z,1618199872.998 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2021-04-12T03:57:53.212Z,1618199873.212 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2021-04-12T03:57:53.214Z,1618199873.214 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2021-04-12T03:57:53.439Z,1618199873.439 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2021-04-12T03:57:53.441Z,1618199873.441 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2021-04-12T03:57:53.708Z,1618199873.708 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2021-04-12T03:57:53.710Z,1618199873.710 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-brizo/
2021-04-12T03:57:53.714Z,1618199873.714 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Control.cfg
2021-04-12T03:57:53.815Z,1618199873.815 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Sensor.cfg
2021-04-12T03:57:53.972Z,1618199873.972 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Simulator.cfg
2021-04-12T03:57:54.061Z,1618199874.061 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/secure.cfg
2021-04-12T03:57:54.146Z,1618199874.146 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Servo.cfg
2021-04-12T03:57:54.260Z,1618199874.260 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/vehicle.cfg
2021-04-12T03:57:54.460Z,1618199874.460 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Battery.cfg
2021-04-12T03:57:54.924Z,1618199874.924 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2021-04-12T03:57:54.924Z,1618199874.924 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Science.cfg
2021-04-12T03:57:55.054Z,1618199875.054 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/logger.cfg
2021-04-12T03:57:55.155Z,1618199875.155 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/BIT.cfg
2021-04-12T03:57:55.267Z,1618199875.267 [Supervisor](INFO): Opening Config file at: Config/lrauv-brizo/Navigation.cfg
2021-04-12T03:57:55.365Z,1618199875.365 [Supervisor](FAULT): Ignoring configuration overrides from Data/persisted.cfg
2021-04-12T03:57:55.369Z,1618199875.369 [Module Loader](DEBUG): Loading Module at Modules/Dock.so
2021-04-12T03:57:55.509Z,1618199875.509 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking)
2021-04-12T03:57:55.510Z,1618199875.510 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2021-04-12T03:57:55.527Z,1618199875.527 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2021-04-12T03:57:55.528Z,1618199875.528 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2021-04-12T03:57:55.586Z,1618199875.586 [DepthRateCalculator] Loaded
2021-04-12T03:57:55.586Z,1618199875.586 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2021-04-12T03:57:55.591Z,1618199875.591 [PitchRateCalculator] Loaded
2021-04-12T03:57:55.592Z,1618199875.592 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2021-04-12T03:57:55.602Z,1618199875.602 [SpeedCalculator] Loaded
2021-04-12T03:57:55.603Z,1618199875.603 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2021-04-12T03:57:55.616Z,1618199875.616 [TempGradientCalculator] Loaded
2021-04-12T03:57:55.616Z,1618199875.616 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2021-04-12T03:57:55.622Z,1618199875.622 [YawRateCalculator] Loaded
2021-04-12T03:57:55.622Z,1618199875.622 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2021-04-12T03:57:55.642Z,1618199875.642 [ElevatorOffsetCalculator] Loaded
2021-04-12T03:57:55.643Z,1618199875.643 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2021-04-12T03:57:55.643Z,1618199875.643 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2021-04-12T03:57:55.644Z,1618199875.644 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2021-04-12T03:57:55.714Z,1618199875.714 [VerticalControl](DEBUG): Construct VerticalControl.
2021-04-12T03:57:55.773Z,1618199875.773 [VerticalControl] Loaded
2021-04-12T03:57:55.773Z,1618199875.773 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2021-04-12T03:57:55.776Z,1618199875.776 [HorizontalControl](DEBUG): Construct HorizontalControl.
2021-04-12T03:57:55.815Z,1618199875.815 [HorizontalControl] Loaded
2021-04-12T03:57:55.815Z,1618199875.815 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2021-04-12T03:57:55.817Z,1618199875.817 [SpeedControl](DEBUG): Construct SpeedControl.
2021-04-12T03:57:55.820Z,1618199875.820 [SpeedControl] Loaded
2021-04-12T03:57:55.820Z,1618199875.820 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2021-04-12T03:57:55.823Z,1618199875.823 [LoopControl](DEBUG): Construct LoopControl.
2021-04-12T03:57:55.824Z,1618199875.824 [LoopControl] Loaded
2021-04-12T03:57:55.824Z,1618199875.824 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2021-04-12T03:57:55.824Z,1618199875.824 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2021-04-12T03:57:55.826Z,1618199875.826 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2021-04-12T03:57:55.925Z,1618199875.925 [DeadReckonUsingMultipleVelocitySources] Loaded
2021-04-12T03:57:55.926Z,1618199875.926 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread.
2021-04-12T03:57:55.939Z,1618199875.939 [NavChart] Loaded
2021-04-12T03:57:55.939Z,1618199875.939 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2021-04-12T03:57:55.945Z,1618199875.945 [UniversalFixResidualReporter] Loaded
2021-04-12T03:57:55.945Z,1618199875.945 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2021-04-12T03:57:55.946Z,1618199875.946 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2021-04-12T03:57:55.947Z,1618199875.947 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2021-04-12T03:57:56.076Z,1618199876.076 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2021-04-12T03:57:56.077Z,1618199876.077 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2021-04-12T03:57:56.796Z,1618199876.796 [AHRS_M2] Loaded
2021-04-12T03:57:56.796Z,1618199876.796 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread.
2021-04-12T03:57:57.949Z,1618199877.949 [BPC1] Loaded
2021-04-12T03:57:57.949Z,1618199877.949 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2021-04-12T03:57:58.094Z,1618199878.094 [DataOverHttps] Loaded
2021-04-12T03:57:58.094Z,1618199878.094 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread.
2021-04-12T03:57:58.095Z,1618199878.095 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408674E0
2021-04-12T03:57:58.095Z,1618199878.095 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 905
2021-04-12T03:57:58.115Z,1618199878.115 [Depth_Keller] Loaded
2021-04-12T03:57:58.115Z,1618199878.115 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2021-04-12T03:57:58.120Z,1618199878.120 [DropWeight] Loaded
2021-04-12T03:57:58.120Z,1618199878.120 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread.
2021-04-12T03:57:58.155Z,1618199878.155 [DVL_micro] Loaded
2021-04-12T03:57:58.156Z,1618199878.156 [ComponentRegistry](DEBUG): SyncComponent "DVL_micro" handled in the control thread.
2021-04-12T03:57:58.215Z,1618199878.215 [NAL9602] Loaded
2021-04-12T03:57:58.215Z,1618199878.215 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2021-04-12T03:57:58.244Z,1618199878.244 [Onboard] Loaded
2021-04-12T03:57:58.245Z,1618199878.245 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread.
2021-04-12T03:57:58.246Z,1618199878.246 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408974E0
2021-04-12T03:57:58.246Z,1618199878.246 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 906
2021-04-12T03:57:58.259Z,1618199878.259 [Radio_Surface] Loaded
2021-04-12T03:57:58.259Z,1618199878.259 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2021-04-12T03:57:58.261Z,1618199878.261 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408C74E0
2021-04-12T03:57:58.261Z,1618199878.261 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 907
2021-04-12T03:57:58.343Z,1618199878.343 [DAT] Loaded
2021-04-12T03:57:58.343Z,1618199878.343 [ComponentRegistry](DEBUG): SyncComponent "DAT" handled in the control thread.
2021-04-12T03:57:58.344Z,1618199878.344 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2021-04-12T03:57:58.344Z,1618199878.344 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2021-04-12T03:57:58.477Z,1618199878.477 [BuoyancyServo] Loaded
2021-04-12T03:57:58.477Z,1618199878.477 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2021-04-12T03:57:58.497Z,1618199878.497 [ElevatorServo] Loaded
2021-04-12T03:57:58.498Z,1618199878.498 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2021-04-12T03:57:58.517Z,1618199878.517 [MassServo] Loaded
2021-04-12T03:57:58.517Z,1618199878.517 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2021-04-12T03:57:58.535Z,1618199878.535 [RudderServo] Loaded
2021-04-12T03:57:58.535Z,1618199878.535 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2021-04-12T03:57:58.553Z,1618199878.553 [ThrusterServo] Loaded
2021-04-12T03:57:58.554Z,1618199878.554 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2021-04-12T03:57:58.554Z,1618199878.554 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2021-04-12T03:57:58.555Z,1618199878.555 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2021-04-12T03:57:58.633Z,1618199878.633 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2021-04-12T03:57:58.633Z,1618199878.633 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2021-04-12T03:57:58.676Z,1618199878.676 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2021-04-12T03:57:58.677Z,1618199878.677 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2021-04-12T03:57:59.044Z,1618199879.044 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2021-04-12T03:57:59.044Z,1618199879.044 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2021-04-12T03:57:59.266Z,1618199879.266 [CTD_Seabird] Loaded
2021-04-12T03:57:59.267Z,1618199879.267 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2021-04-12T03:57:59.268Z,1618199879.268 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40A4F4E0
2021-04-12T03:57:59.268Z,1618199879.268 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 908
2021-04-12T03:57:59.302Z,1618199879.302 [ESPComponent] Loaded
2021-04-12T03:57:59.302Z,1618199879.302 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2021-04-12T03:57:59.322Z,1618199879.322 [PAR_Licor] Loaded
2021-04-12T03:57:59.322Z,1618199879.322 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2021-04-12T03:57:59.354Z,1618199879.354 [WetLabsBB2FL] Loaded
2021-04-12T03:57:59.354Z,1618199879.354 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2021-04-12T03:57:59.355Z,1618199879.355 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40A7F4E0
2021-04-12T03:57:59.356Z,1618199879.356 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 909
2021-04-12T03:57:59.357Z,1618199879.357 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2021-04-12T03:57:59.359Z,1618199879.359 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2021-04-12T03:57:59.529Z,1618199879.529 [SBIT](DEBUG): Construct Startup Built In Test.
2021-04-12T03:57:59.539Z,1618199879.539 [SBIT] Loaded
2021-04-12T03:57:59.539Z,1618199879.539 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2021-04-12T03:57:59.542Z,1618199879.542 [IBIT](DEBUG): Construct Initiated Built In Test.
2021-04-12T03:57:59.555Z,1618199879.555 [IBIT] Loaded
2021-04-12T03:57:59.556Z,1618199879.556 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2021-04-12T03:57:59.562Z,1618199879.562 [CBIT](DEBUG): Construct Continuous Built In Test.
2021-04-12T03:57:59.668Z,1618199879.668 [CBIT] Loaded
2021-04-12T03:57:59.668Z,1618199879.668 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2021-04-12T03:57:59.669Z,1618199879.669 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2021-04-12T03:57:59.675Z,1618199879.675 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2021-04-12T03:57:59.678Z,1618199879.678 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2021-04-12T03:57:59.688Z,1618199879.688 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2021-04-12T03:57:59.690Z,1618199879.690 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40AEB4E0
2021-04-12T03:57:59.690Z,1618199879.690 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 910
2021-04-12T03:57:59.695Z,1618199879.695 [Supervisor](INFO): Main Thread ID is 816
2021-04-12T03:57:59.695Z,1618199879.695 [Supervisor](DEBUG): Running supervisor.
2021-04-12T03:57:59.696Z,1618199879.696 [CommandLine ThreadHandler](INFO): Handler Thread ID is 911
2021-04-12T03:57:59.698Z,1618199879.698 [controlThread ThreadHandler](INFO): Handler Thread ID is 912
2021-04-12T03:57:59.698Z,1618199879.698 [controlThread](DEBUG): Initializing ControlThread
2021-04-12T03:57:59.699Z,1618199879.699 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2021-04-12T03:57:59.700Z,1618199879.700 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2021-04-12T03:57:59.700Z,1618199879.700 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2021-04-12T03:57:59.700Z,1618199879.700 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2021-04-12T03:57:59.701Z,1618199879.701 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2021-04-12T03:57:59.701Z,1618199879.701 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2021-04-12T03:57:59.702Z,1618199879.702 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2021-04-12T03:57:59.704Z,1618199879.704 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2021-04-12T03:57:59.704Z,1618199879.704 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2021-04-12T03:57:59.705Z,1618199879.705 [LoopControl](DEBUG): Initialize LoopControlComponent.
2021-04-12T03:57:59.706Z,1618199879.706 [NavChart](DEBUG): Initialize NavChart Navigation.
2021-04-12T03:57:59.706Z,1618199879.706 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2021-04-12T03:57:59.713Z,1618199879.713 [SBIT](INFO): Initialize SBIT Component.
2021-04-12T03:57:59.714Z,1618199879.714 [SBIT](IMPORTANT): git: 2021-04-08-2-gfc5b6cfe3
2021-04-12T03:57:59.714Z,1618199879.714 [SBIT](INFO): git hash: fc5b6cfe3a0a617c2655bbe510b7fa07d5046659
2021-04-12T03:57:59.714Z,1618199879.714 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2021-04-12T03:57:59.715Z,1618199879.715 [SBIT](IMPORTANT): Kernel Version:#1 PREEMPT Tue Sep 24 11:12:27 PDT 2019
2021-04-12T03:57:59.716Z,1618199879.716 [SBIT](INFO): Beginning SBIT in 39.000000 seconds.
2021-04-12T03:57:59.716Z,1618199879.716 [IBIT](INFO): Initialize IBIT Component.
2021-04-12T03:57:59.717Z,1618199879.717 [CBIT](DEBUG): Initialize CBIT Component.
2021-04-12T03:57:59.718Z,1618199879.718 [logger ThreadHandler](INFO): Handler Thread ID is 913
2021-04-12T03:57:59.729Z,1618199879.729 [CBIT](DEBUG): Initialized mux pins.
2021-04-12T03:57:59.729Z,1618199879.729 [CBIT](FAULT): LAST RESTART WAS UNINTENTIONAL.
2021-04-12T03:57:59.729Z,1618199879.729 [CBIT](DEBUG): Initializing the watchdog timer.
2021-04-12T03:57:59.738Z,1618199879.738 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 914
2021-04-12T03:57:59.739Z,1618199879.739 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2021-04-12T03:57:59.750Z,1618199879.750 [Onboard ThreadHandler](INFO): Handler Thread ID is 915
2021-04-12T03:57:59.754Z,1618199879.754 [CBIT](CRITICAL): LAST REBOOT DUE TO WATCHDOG TIMER RESET.
2021-04-12T03:57:59.759Z,1618199879.759 [CBIT](FAULT): Found backtrace file:
1618199722.237786 [MissionManager]: SIGSEGV: address not mapped to object
1618199722.237786 [MissionManager]: Backtrace:
./bin/LRAUV(_ZN7PCaller20DefaultSignalHandlerEiP7siginfoPv+0x20) [0x19f58c]
2021-04-12T03:57:59.771Z,1618199879.771 [CBIT](FAULT): Renaming backtrace file to Data/backtrace8
2021-04-12T03:57:59.775Z,1618199879.775 [CBIT](DEBUG): Initializing heartbeat.
2021-04-12T03:57:59.786Z,1618199879.786 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 916
2021-04-12T03:57:59.794Z,1618199879.794 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 917
2021-04-12T03:57:59.794Z,1618199879.794 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2021-04-12T03:57:59.799Z,1618199879.799 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 919
2021-04-12T03:57:59.802Z,1618199879.802 [WetLabsBB2FL](INFO): Powering up
2021-04-12T03:57:59.803Z,1618199879.803 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 921
2021-04-12T03:57:59.812Z,1618199879.812 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2021-04-12T03:57:59.812Z,1618199879.812 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2021-04-12T03:57:59.812Z,1618199879.812 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2021-04-12T03:57:59.812Z,1618199879.812 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2021-04-12T03:57:59.812Z,1618199879.812 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2021-04-12T03:57:59.813Z,1618199879.813 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2021-04-12T03:57:59.813Z,1618199879.813 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2021-04-12T03:57:59.813Z,1618199879.813 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2021-04-12T03:57:59.813Z,1618199879.813 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2021-04-12T03:57:59.814Z,1618199879.814 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2021-04-12T03:57:59.814Z,1618199879.814 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2021-04-12T03:57:59.814Z,1618199879.814 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2021-04-12T03:57:59.814Z,1618199879.814 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2021-04-12T03:57:59.814Z,1618199879.814 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2021-04-12T03:57:59.814Z,1618199879.814 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2021-04-12T03:57:59.814Z,1618199879.814 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2021-04-12T03:57:59.845Z,1618199879.845 [CBIT](DEBUG): Deactivating GF circuits.
2021-04-12T03:57:59.845Z,1618199879.845 [CBIT](DEBUG): Deactivating emergency mode.
2021-04-12T03:57:59.881Z,1618199879.881 [CBIT](DEBUG): Backplane powered.
2021-04-12T03:57:59.882Z,1618199879.882 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2021-04-12T03:57:59.909Z,1618199879.909 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2021-04-12T03:57:59.936Z,1618199879.936 [MissionManager](DEBUG):
2021-04-12T03:57:59.937Z,1618199879.937 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2021-04-12T03:58:00.035Z,1618199880.035 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2021-04-12T03:58:00.036Z,1618199880.036 [Default:A.Wait](DEBUG): Construct Wait.
2021-04-12T03:58:00.039Z,1618199880.039 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2021-04-12T03:58:00.095Z,1618199880.095 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2021-04-12T03:58:00.105Z,1618199880.105 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2021-04-12T03:58:00.111Z,1618199880.111 [Default:E.Execute](DEBUG): Construct Execute.
2021-04-12T03:58:00.135Z,1618199880.135 [MissionManager](DEBUG):
0
Wait a moment to see if the scheduler starts a new mission before
starting to actually run Default.
13
Burn on
Dropped weight due to communications timeout.
5
Default mission has been running for
Restarting logs and Default mission.
restart logs
2021-04-12T03:58:00.139Z,1618199880.139 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,DVL_micro,NAL9602,DAT,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2021-04-12T03:58:00.149Z,1618199880.149 [AHRS_M2](DEBUG): Initializing AHRS_M2.
2021-04-12T03:58:00.189Z,1618199880.189 [Radio_Surface](INFO): Powering up
2021-04-12T03:58:00.405Z,1618199880.405 [DAT](INFO): Powered 24V power converter LCB with command: ! echo 1 > /dev/loadB2
2021-04-12T03:58:00.405Z,1618199880.405 [DAT](INFO): Powering up
2021-04-12T03:58:00.405Z,1618199880.405 [DAT](DEBUG): Initializing DAT.
2021-04-12T03:58:00.495Z,1618199880.495 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2021-04-12T03:58:00.497Z,1618199880.497 [CommandLine](IMPORTANT): got command ! echo 1 > /dev/loadB2
2021-04-12T03:58:00.529Z,1618199880.529 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2021-04-12T03:58:00.531Z,1618199880.531 [ElevatorServo](DEBUG): Initializing EZServoServo.
2021-04-12T03:58:00.537Z,1618199880.537 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2021-04-12T03:58:00.539Z,1618199880.539 [MassServo](DEBUG): Initializing EZServoServo.
2021-04-12T03:58:00.549Z,1618199880.549 [MassServo](DEBUG): Initializing MassServo.
2021-04-12T03:58:00.550Z,1618199880.550 [RudderServo](DEBUG): Initializing EZServoServo.
2021-04-12T03:58:00.561Z,1618199880.561 [RudderServo](DEBUG): Initializing RudderServo.
2021-04-12T03:58:00.563Z,1618199880.563 [ThrusterServo](DEBUG): Initializing EZServoServo.
2021-04-12T03:58:00.573Z,1618199880.573 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2021-04-12T03:58:00.576Z,1618199880.576 [CommandLine](FAULT): Scheduling is paused
2021-04-12T03:58:00.577Z,1618199880.577 [CBIT](INFO): Critical error at 20210412T035759
2021-04-12T03:58:00.577Z,1618199880.577 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals
2021-04-12T03:58:02.413Z,1618199882.413 [WetLabsBB2FL](INFO): Powering down
2021-04-12T03:58:14.803Z,1618199894.803 [DAT](INFO): commRate: 800
2021-04-12T03:58:16.823Z,1618199896.823 [DAT](INFO): entering command mode
2021-04-12T03:58:17.224Z,1618199897.224 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:17.627Z,1618199897.627 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:18.040Z,1618199898.040 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:18.439Z,1618199898.439 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:18.839Z,1618199898.839 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:19.243Z,1618199899.243 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:19.647Z,1618199899.647 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:20.057Z,1618199900.057 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:20.464Z,1618199900.464 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:20.860Z,1618199900.860 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:21.263Z,1618199901.263 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:21.671Z,1618199901.671 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:22.072Z,1618199902.072 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:22.475Z,1618199902.475 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:22.888Z,1618199902.888 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:23.283Z,1618199903.283 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:23.687Z,1618199903.687 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:24.091Z,1618199904.091 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:24.496Z,1618199904.496 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:24.899Z,1618199904.899 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:25.315Z,1618199905.315 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:25.717Z,1618199905.717 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:26.111Z,1618199906.111 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:26.519Z,1618199906.519 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:26.924Z,1618199906.924 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:27.323Z,1618199907.323 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:27.727Z,1618199907.727 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:28.141Z,1618199908.141 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:28.535Z,1618199908.535 [NAL9602](INFO): Powering up NAL9602
2021-04-12T03:58:28.536Z,1618199908.536 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:28.939Z,1618199908.939 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:29.348Z,1618199909.348 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:29.747Z,1618199909.747 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:30.159Z,1618199910.159 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:30.565Z,1618199910.565 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:30.963Z,1618199910.963 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:31.363Z,1618199911.363 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:31.768Z,1618199911.768 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:32.171Z,1618199912.171 [DAT](DEBUG): checking for command mode acknowledgment
2021-04-12T03:58:32.171Z,1618199912.171 [DAT](FAULT): failed to enter command mode
2021-04-12T03:58:32.583Z,1618199912.583 [DAT](INFO): entering command mode
2021-04-12T03:58:33.026Z,1618199913.026 [DAT](INFO): setting verbose to 3
2021-04-12T03:58:33.385Z,1618199913.385 [DAT](INFO): set verbose to 3
2021-04-12T03:58:33.385Z,1618199913.385 [DAT](INFO): setting DatVerbose to 27440
2021-04-12T03:58:33.796Z,1618199913.796 [DAT](INFO): set DatVerbose to 27440
2021-04-12T03:58:33.797Z,1618199913.797 [DAT](INFO): setting transmit power to 8
2021-04-12T03:58:34.193Z,1618199914.193 [DAT](INFO): set transmit power to 8
2021-04-12T03:58:34.193Z,1618199914.193 [DAT](INFO): setting local address to 8
2021-04-12T03:58:34.597Z,1618199914.597 [DAT](INFO): set local address to 8
2021-04-12T03:58:39.443Z,1618199919.443 [NAL9602](INFO): NAL9602 initialized
2021-04-12T03:58:39.493Z,1618199919.493 [SBIT](IMPORTANT): Beginning Startup BIT
2021-04-12T03:58:39.501Z,1618199919.501 [CBIT](IMPORTANT): Beginning ground fault scan
2021-04-12T03:58:50.426Z,1618199930.426 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.003515
CHAN A1 (24V): -0.002383
CHAN A2 (12V): 0.000004
CHAN A3 (5V): 0.000326
CHAN B0 (3.3V): 0.000734
CHAN B1 (3.15aV): 0.001053
CHAN B2 (3.15bV): 0.000422
CHAN B3 (GND): 0.000461
OPEN: -0.004332
Full Scale Calc: 4.765 mA, -1.589 mA
2021-04-12T03:59:02.671Z,1618199942.671 [CommandLine](IMPORTANT): got command restart system
2021-04-12T03:59:04.789Z,1618199944.789 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2021-04-12T03:59:04.790Z,1618199944.790 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-04-12T03:59:04.957Z,1618199944.957 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye!
2021-04-12T03:59:04.957Z,1618199944.957 [CommandLine ThreadHandler](INFO): Thread cancelled.
2021-04-12T03:59:04.958Z,1618199944.958 [CommandLine](INFO): Join timeout helper Thread ID is 942
2021-04-12T03:59:04.961Z,1618199944.961 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2021-04-12T03:59:04.961Z,1618199944.961 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-04-12T03:59:04.962Z,1618199944.962 [NavChartDb](INFO): Join timeout helper Thread ID is 943
2021-04-12T03:59:05.201Z,1618199945.201 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2021-04-12T03:59:05.202Z,1618199945.202 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2021-04-12T03:59:05.221Z,1618199945.221 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2021-04-12T03:59:05.221Z,1618199945.221 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-04-12T03:59:05.222Z,1618199945.222 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 944
2021-04-12T03:59:05.320Z,1618199945.320 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2021-04-12T03:59:05.373Z,1618199945.373 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2021-04-12T03:59:05.373Z,1618199945.373 [WetLabsBB2FL](INFO): Powering down
2021-04-12T03:59:05.374Z,1618199945.374 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2021-04-12T03:59:05.377Z,1618199945.377 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2021-04-12T03:59:05.377Z,1618199945.377 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-04-12T03:59:05.378Z,1618199945.378 [CTD_Seabird](INFO): Join timeout helper Thread ID is 945
2021-04-12T03:59:06.058Z,1618199946.058 [CTD_Seabird](INFO): Powering down
2021-04-12T03:59:06.073Z,1618199946.073 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2021-04-12T03:59:06.073Z,1618199946.073 [CTD_Seabird](INFO): Powering down
2021-04-12T03:59:06.085Z,1618199946.085 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2021-04-12T03:59:06.086Z,1618199946.086 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2021-04-12T03:59:06.086Z,1618199946.086 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-04-12T03:59:06.086Z,1618199946.086 [Radio_Surface](INFO): Join timeout helper Thread ID is 946
2021-04-12T03:59:06.445Z,1618199946.445 [Radio_Surface](INFO): Powering down
2021-04-12T03:59:06.446Z,1618199946.446 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2021-04-12T03:59:06.447Z,1618199946.447 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2021-04-12T03:59:06.450Z,1618199946.450 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler
2021-04-12T03:59:06.450Z,1618199946.450 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-04-12T03:59:06.451Z,1618199946.451 [Onboard](INFO): Join timeout helper Thread ID is 947
2021-04-12T03:59:09.805Z,1618199949.805 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread.
2021-04-12T03:59:09.805Z,1618199949.805 [Onboard ThreadHandler](INFO): Thread cancelled.
2021-04-12T03:59:09.814Z,1618199949.814 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler
2021-04-12T03:59:09.814Z,1618199949