1970-01-14T21:14:50.018Z,1199690.018 [Supervisor](DEBUG): Initializing supervisor. 1970-01-14T21:14:50.022Z,1199690.022 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0 1970-01-14T21:14:50.023Z,1199690.023 [SyncHandler](INFO): Protected caller Thread ID is 6188 1970-01-14T21:14:50.023Z,1199690.023 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread. 1970-01-14T21:14:50.024Z,1199690.024 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0 1970-01-14T21:14:50.024Z,1199690.024 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6189 1970-01-14T21:14:50.028Z,1199690.028 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread. 1970-01-14T21:14:50.045Z,1199690.045 [ComponentRegistry](DEBUG): Component "CommandExec" handled in its own thread. 1970-01-14T21:14:50.046Z,1199690.046 [CommandExec ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0 1970-01-14T21:14:50.047Z,1199690.047 [CommandExec ThreadHandler](INFO): Protected caller Thread ID is 6190 1970-01-14T21:14:50.051Z,1199690.051 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread. 1970-01-14T21:14:50.052Z,1199690.052 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0 1970-01-14T21:14:50.052Z,1199690.052 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6191 1970-01-14T21:14:50.054Z,1199690.054 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread. 1970-01-14T21:14:50.055Z,1199690.055 [logger ThreadHandler](DEBUG): Created PCaller Thread at 405114E0 1970-01-14T21:14:50.055Z,1199690.055 [logger ThreadHandler](INFO): Protected caller Thread ID is 6192 1970-01-14T21:14:50.059Z,1199690.059 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread. 1970-01-14T21:14:50.059Z,1199690.059 [Supervisor](INFO): Looking for Config files in directory: Config/ 1970-01-14T21:14:50.061Z,1199690.061 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg 1970-01-14T21:14:50.138Z,1199690.138 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg 1970-01-14T21:14:50.262Z,1199690.262 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite 1970-01-14T21:14:50.263Z,1199690.263 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg 1970-01-14T21:14:50.459Z,1199690.459 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation 1970-01-14T21:14:50.460Z,1199690.460 [Supervisor](INFO): Opening Config file at: Config/Science.cfg 1970-01-14T21:14:50.778Z,1199690.778 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science 1970-01-14T21:14:50.778Z,1199690.778 [Supervisor](INFO): Opening Config file at: Config/logger.cfg 1970-01-14T21:14:50.952Z,1199690.952 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger 1970-01-14T21:14:50.953Z,1199690.953 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg 1970-01-14T21:14:51.314Z,1199691.314 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo 1970-01-14T21:14:51.314Z,1199691.314 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg 1970-01-14T21:14:51.421Z,1199691.421 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation 1970-01-14T21:14:51.422Z,1199691.422 [Supervisor](INFO): Opening Config file at: Config/secure.cfg 1970-01-14T21:14:51.516Z,1199691.516 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure 1970-01-14T21:14:51.516Z,1199691.516 [Supervisor](INFO): Opening Config file at: Config/Dock.cfg 1970-01-14T21:14:51.728Z,1199691.728 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Dock 1970-01-14T21:14:51.728Z,1199691.728 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg 1970-01-14T21:14:51.921Z,1199691.921 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT 1970-01-14T21:14:51.922Z,1199691.922 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg 1970-01-14T21:14:52.000Z,1199692.000 [Supervisor](INFO): Opening Config file at: Config/Control.cfg 1970-01-14T21:14:52.310Z,1199692.310 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control 1970-01-14T21:14:52.311Z,1199692.311 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg 1970-01-14T21:14:52.777Z,1199692.777 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle 1970-01-14T21:14:52.778Z,1199692.778 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg 1970-01-14T21:14:53.334Z,1199693.334 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator 1970-01-14T21:14:53.335Z,1199693.335 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg 1970-01-14T21:14:54.061Z,1199694.061 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor 1970-01-14T21:14:54.062Z,1199694.062 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg 1970-01-14T21:14:54.341Z,1199694.341 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation 1970-01-14T21:14:54.343Z,1199694.343 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/ 1970-01-14T21:14:54.344Z,1199694.344 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Science.cfg 1970-01-14T21:14:54.467Z,1199694.467 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/logger.cfg 1970-01-14T21:14:54.557Z,1199694.557 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Servo.cfg 1970-01-14T21:14:54.663Z,1199694.663 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/secure.cfg 1970-01-14T21:14:54.751Z,1199694.751 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/BIT.cfg 1970-01-14T21:14:54.857Z,1199694.857 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Control.cfg 1970-01-14T21:14:54.949Z,1199694.949 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Battery.cfg 1970-01-14T21:14:55.202Z,1199695.202 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery 1970-01-14T21:14:55.202Z,1199695.202 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/vehicle.cfg 1970-01-14T21:14:55.353Z,1199695.353 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Simulator.cfg 1970-01-14T21:14:55.435Z,1199695.435 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Sensor.cfg 1970-01-14T21:14:55.579Z,1199695.579 [Supervisor](INFO): Opening Config file at: Config/lrauv-ahi/Navigation.cfg 1970-01-14T21:14:55.678Z,1199695.678 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-ahi/root/ 1970-01-14T21:14:55.679Z,1199695.679 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg 1970-01-14T21:14:55.680Z,1199695.680 [Module Loader](DEBUG): Loading Module at Modules/Dock.so 1970-01-14T21:14:55.777Z,1199695.777 [Module Loader](DEBUG): Loaded Module: Dock (Contains behaviors and commands for docking) 1970-01-14T21:14:55.778Z,1199695.778 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so 1970-01-14T21:14:56.179Z,1199696.179 [AHRS_M2] Loaded 1970-01-14T21:14:56.180Z,1199696.180 [ComponentRegistry](DEBUG): SyncComponent "AHRS_M2" handled in the control thread. 1970-01-14T21:14:56.963Z,1199696.963 [BPC1] Loaded 1970-01-14T21:14:56.964Z,1199696.964 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread. 1970-01-14T21:14:57.035Z,1199697.035 [DataOverHttps] Loaded 1970-01-14T21:14:57.035Z,1199697.035 [ComponentRegistry](DEBUG): Component "DataOverHttps" handled in its own thread. 1970-01-14T21:14:57.036Z,1199697.036 [DataOverHttps ThreadHandler](DEBUG): Created PCaller Thread at 408204E0 1970-01-14T21:14:57.037Z,1199697.037 [DataOverHttps ThreadHandler](INFO): Protected caller Thread ID is 6275 1970-01-14T21:14:57.057Z,1199697.057 [Depth_Keller] Loaded 1970-01-14T21:14:57.057Z,1199697.057 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread. 1970-01-14T21:14:57.062Z,1199697.062 [DropWeight] Loaded 1970-01-14T21:14:57.062Z,1199697.062 [ComponentRegistry](DEBUG): SyncComponent "DropWeight" handled in the control thread. 1970-01-14T21:14:57.123Z,1199697.123 [NAL9602] Loaded 1970-01-14T21:14:57.123Z,1199697.123 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread. 1970-01-14T21:14:57.150Z,1199697.150 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/voltage_now 1970-01-14T21:14:57.150Z,1199697.150 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/current_now 1970-01-14T21:14:57.151Z,1199697.151 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_now 1970-01-14T21:14:57.151Z,1199697.151 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-0/charge_full 1970-01-14T21:14:57.152Z,1199697.152 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/voltage_now 1970-01-14T21:14:57.152Z,1199697.152 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/current_now 1970-01-14T21:14:57.153Z,1199697.153 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_now 1970-01-14T21:14:57.153Z,1199697.153 [Onboard](ERROR): Can't open SysFS node file: /sys/class/power_supply/ds2782-1/charge_full 1970-01-14T21:14:57.153Z,1199697.153 [Onboard] Loaded 1970-01-14T21:14:57.154Z,1199697.154 [ComponentRegistry](DEBUG): Component "Onboard" handled in its own thread. 1970-01-14T21:14:57.155Z,1199697.155 [Onboard ThreadHandler](DEBUG): Created PCaller Thread at 408504E0 1970-01-14T21:14:57.155Z,1199697.155 [Onboard ThreadHandler](INFO): Protected caller Thread ID is 6276 1970-01-14T21:14:57.168Z,1199697.168 [Power24vConverter] Loaded 1970-01-14T21:14:57.168Z,1199697.168 [ComponentRegistry](DEBUG): SyncComponent "Power24vConverter" handled in the control thread. 1970-01-14T21:14:57.200Z,1199697.200 [PNI_TCM] Loaded 1970-01-14T21:14:57.201Z,1199697.201 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread. 1970-01-14T21:14:57.214Z,1199697.214 [Radio_Surface] Loaded 1970-01-14T21:14:57.214Z,1199697.215 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread. 1970-01-14T21:14:57.215Z,1199697.215 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 408804E0 1970-01-14T21:14:57.216Z,1199697.216 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6277 1970-01-14T21:14:57.333Z,1199697.333 [DAT] Loaded 1970-01-14T21:14:57.333Z,1199697.333 [ComponentRegistry](DEBUG): Component "DAT" handled in its own thread. 1970-01-14T21:14:57.334Z,1199697.334 [DAT ThreadHandler](DEBUG): Created PCaller Thread at 408B04E0 1970-01-14T21:14:57.334Z,1199697.334 [DAT ThreadHandler](INFO): Protected caller Thread ID is 6278 1970-01-14T21:14:57.335Z,1199697.335 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components) 1970-01-14T21:14:57.335Z,1199697.335 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so 1970-01-14T21:14:57.363Z,1199697.363 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions) 1970-01-14T21:14:57.363Z,1199697.363 [Module Loader](DEBUG): Loading Module at Modules/Sample.so 1970-01-14T21:14:57.373Z,1199697.373 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components) 1970-01-14T21:14:57.374Z,1199697.374 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so 1970-01-14T21:14:57.425Z,1199697.425 [DepthRateCalculator] Loaded 1970-01-14T21:14:57.425Z,1199697.425 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread. 1970-01-14T21:14:57.431Z,1199697.431 [PitchRateCalculator] Loaded 1970-01-14T21:14:57.431Z,1199697.431 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread. 1970-01-14T21:14:57.441Z,1199697.441 [SpeedCalculator] Loaded 1970-01-14T21:14:57.441Z,1199697.441 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread. 1970-01-14T21:14:57.446Z,1199697.446 [YawRateCalculator] Loaded 1970-01-14T21:14:57.446Z,1199697.446 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread. 1970-01-14T21:14:57.468Z,1199697.468 [ElevatorOffsetCalculator] Loaded 1970-01-14T21:14:57.468Z,1199697.468 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread. 1970-01-14T21:14:57.468Z,1199697.468 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components) 1970-01-14T21:14:57.469Z,1199697.469 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so 1970-01-14T21:14:57.614Z,1199697.614 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator) 1970-01-14T21:14:57.614Z,1199697.614 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so 1970-01-14T21:14:57.670Z,1199697.670 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components) 1970-01-14T21:14:57.671Z,1199697.671 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so 1970-01-14T21:14:57.780Z,1199697.780 [DeadReckonUsingMultipleVelocitySources] Loaded 1970-01-14T21:14:57.781Z,1199697.781 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingMultipleVelocitySources" handled in the control thread. 1970-01-14T21:14:57.821Z,1199697.821 [DeadReckonUsingSpeedCalculator] Loaded 1970-01-14T21:14:57.821Z,1199697.821 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread. 1970-01-14T21:14:57.862Z,1199697.862 [DeadReckonWithRespectToSeafloor] Loaded 1970-01-14T21:14:57.862Z,1199697.862 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonWithRespectToSeafloor" handled in the control thread. 1970-01-14T21:14:57.875Z,1199697.875 [NavChart] Loaded 1970-01-14T21:14:57.876Z,1199697.876 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread. 1970-01-14T21:14:57.881Z,1199697.881 [UniversalFixResidualReporter] Loaded 1970-01-14T21:14:57.881Z,1199697.881 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread. 1970-01-14T21:14:57.882Z,1199697.882 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components) 1970-01-14T21:14:57.882Z,1199697.882 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so 1970-01-14T21:14:58.187Z,1199698.187 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands) 1970-01-14T21:14:58.187Z,1199698.187 [Module Loader](DEBUG): Loading Module at Modules/BIT.so 1970-01-14T21:14:58.324Z,1199698.324 [SBIT](DEBUG): Construct Startup Built In Test. 1970-01-14T21:14:58.338Z,1199698.338 [SBIT] Loaded 1970-01-14T21:14:58.338Z,1199698.338 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread. 1970-01-14T21:14:58.341Z,1199698.341 [IBIT](DEBUG): Construct Initiated Built In Test. 1970-01-14T21:14:58.354Z,1199698.354 [IBIT] Loaded 1970-01-14T21:14:58.354Z,1199698.354 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread. 1970-01-14T21:14:58.360Z,1199698.360 [CBIT](DEBUG): Construct Continuous Built In Test. 1970-01-14T21:14:58.460Z,1199698.460 [CBIT] Loaded 1970-01-14T21:14:58.460Z,1199698.460 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread. 1970-01-14T21:14:58.461Z,1199698.461 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test) 1970-01-14T21:14:58.461Z,1199698.461 [Module Loader](DEBUG): Loading Module at Modules/Control.so 1970-01-14T21:14:58.511Z,1199698.511 [VerticalControl](DEBUG): Construct VerticalControl. 1970-01-14T21:14:58.563Z,1199698.563 [VerticalControl] Loaded 1970-01-14T21:14:58.564Z,1199698.564 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread. 1970-01-14T21:14:58.567Z,1199698.567 [HorizontalControl](DEBUG): Construct HorizontalControl. 1970-01-14T21:14:58.604Z,1199698.604 [HorizontalControl] Loaded 1970-01-14T21:14:58.605Z,1199698.605 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread. 1970-01-14T21:14:58.607Z,1199698.607 [SpeedControl](DEBUG): Construct SpeedControl. 1970-01-14T21:14:58.610Z,1199698.610 [SpeedControl] Loaded 1970-01-14T21:14:58.610Z,1199698.610 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread. 1970-01-14T21:14:58.613Z,1199698.613 [LoopControl](DEBUG): Construct LoopControl. 1970-01-14T21:14:58.613Z,1199698.613 [LoopControl] Loaded 1970-01-14T21:14:58.613Z,1199698.613 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread. 1970-01-14T21:14:58.614Z,1199698.614 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control) 1970-01-14T21:14:58.614Z,1199698.614 [Module Loader](DEBUG): Loading Module at Modules/Science.so 1970-01-14T21:14:58.748Z,1199698.748 [Aanderaa_O2] Loaded 1970-01-14T21:14:58.749Z,1199698.749 [ComponentRegistry](DEBUG): SyncComponent "Aanderaa_O2" handled in the control thread. 1970-01-14T21:14:58.807Z,1199698.807 [CTD_Seabird] Loaded 1970-01-14T21:14:58.808Z,1199698.808 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread. 1970-01-14T21:14:58.809Z,1199698.809 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 40B104E0 1970-01-14T21:14:58.809Z,1199698.809 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 6279 1970-01-14T21:14:58.841Z,1199698.841 [ESPComponent] Loaded 1970-01-14T21:14:58.842Z,1199698.842 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread. 1970-01-14T21:14:58.861Z,1199698.861 [PAR_Licor] Loaded 1970-01-14T21:14:58.861Z,1199698.861 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread. 1970-01-14T21:14:58.892Z,1199698.892 [WetLabsBB2FL] Loaded 1970-01-14T21:14:58.892Z,1199698.892 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread. 1970-01-14T21:14:58.893Z,1199698.893 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 40B404E0 1970-01-14T21:14:58.893Z,1199698.893 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6280 1970-01-14T21:14:58.894Z,1199698.894 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components) 1970-01-14T21:14:58.895Z,1199698.895 [Module Loader](DEBUG): Loading Module at Modules/Servo.so 1970-01-14T21:14:59.024Z,1199699.024 [BuoyancyServo] Loaded 1970-01-14T21:14:59.024Z,1199699.024 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread. 1970-01-14T21:14:59.044Z,1199699.044 [ElevatorServo] Loaded 1970-01-14T21:14:59.045Z,1199699.045 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread. 1970-01-14T21:14:59.064Z,1199699.064 [MassServo] Loaded 1970-01-14T21:14:59.064Z,1199699.064 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread. 1970-01-14T21:14:59.082Z,1199699.082 [RudderServo] Loaded 1970-01-14T21:14:59.083Z,1199699.083 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread. 1970-01-14T21:14:59.097Z,1199699.097 [ThrusterHE] Loaded 1970-01-14T21:14:59.098Z,1199699.098 [ComponentRegistry](DEBUG): SyncComponent "ThrusterHE" handled in the control thread. 1970-01-14T21:14:59.098Z,1199699.098 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers) 1970-01-14T21:14:59.104Z,1199699.104 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread. 1970-01-14T21:14:59.107Z,1199699.107 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread. 1970-01-14T21:14:59.118Z,1199699.118 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread. 1970-01-14T21:14:59.119Z,1199699.119 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40BA64E0 1970-01-14T21:14:59.119Z,1199699.119 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6281 1970-01-14T21:14:59.123Z,1199699.123 [Supervisor](INFO): Main Thread ID is 6187 1970-01-14T21:14:59.124Z,1199699.124 [Supervisor](DEBUG): Running supervisor. 1970-01-14T21:14:59.124Z,1199699.124 [CommandExec ThreadHandler](INFO): Handler Thread ID is 6282 1970-01-14T21:14:59.125Z,1199699.125 [CommandExec](INFO): Initializing the command executive. 1970-01-14T21:14:59.126Z,1199699.126 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6283 1970-01-14T21:14:59.133Z,1199699.133 [controlThread ThreadHandler](INFO): Handler Thread ID is 6284 1970-01-14T21:14:59.133Z,1199699.133 [controlThread](DEBUG): Initializing ControlThread 1970-01-14T21:14:59.139Z,1199699.139 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator. 1970-01-14T21:14:59.139Z,1199699.139 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator. 1970-01-14T21:14:59.139Z,1199699.139 [SpeedCalculator](DEBUG): Initializing SpeedCalculator. 1970-01-14T21:14:59.140Z,1199699.140 [YawRateCalculator](DEBUG): Initializing YawRateCalculator. 1970-01-14T21:14:59.140Z,1199699.140 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator. 1970-01-14T21:14:59.141Z,1199699.141 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component. 1970-01-14T21:14:59.142Z,1199699.142 [NavChart](DEBUG): Initialize NavChart Navigation. 1970-01-14T21:14:59.142Z,1199699.142 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component. 1970-01-14T21:14:59.142Z,1199699.142 [SBIT](INFO): Initialize SBIT Component. 1970-01-14T21:14:59.143Z,1199699.143 [SBIT](IMPORTANT): git: 2023-01-26 1970-01-14T21:14:59.143Z,1199699.143 [SBIT](INFO): git hash: fbcd350f88251f9a867f3fca05699dec8f096e0d 1970-01-14T21:14:59.143Z,1199699.143 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8 1970-01-14T21:14:59.145Z,1199699.145 [SBIT](INFO): Kernel Reporting Different Version From Configuration. Kernel Expected: #639 PREEMPT Wed Mar 12 12:53:33 PDT 2014 Kernel Reported: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018 1970-01-14T21:14:59.146Z,1199699.146 [SBIT](INFO): Beginning SBIT in 71.000000 seconds. 1970-01-14T21:14:59.147Z,1199699.147 [IBIT](INFO): Initialize IBIT Component. 1970-01-14T21:14:59.147Z,1199699.147 [CBIT](DEBUG): Initialize CBIT Component. 1970-01-14T21:14:59.148Z,1199699.148 [logger ThreadHandler](INFO): Handler Thread ID is 6285 1970-01-14T21:14:59.161Z,1199699.161 [CBIT](DEBUG): Initialized mux pins. 1970-01-14T21:14:59.161Z,1199699.161 [CBIT](DEBUG): Initializing the watchdog timer. 1970-01-14T21:14:59.165Z,1199699.165 [DataOverHttps ThreadHandler](INFO): Handler Thread ID is 6286 1970-01-14T21:14:59.166Z,1199699.166 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP 1970-01-14T21:14:59.173Z,1199699.173 [Onboard ThreadHandler](INFO): Handler Thread ID is 6287 1970-01-14T21:14:59.186Z,1199699.186 [CBIT](INFO): Last reboot was NOT due to watchdog timer. 1970-01-14T21:14:59.186Z,1199699.186 [CBIT](DEBUG): Initializing heartbeat. 1970-01-14T21:14:59.193Z,1199699.193 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6288 1970-01-14T21:14:59.209Z,1199699.209 [DAT ThreadHandler](INFO): Handler Thread ID is 6289 1970-01-14T21:14:59.212Z,1199699.212 [DAT](INFO): Powering up 1970-01-14T21:14:59.212Z,1199699.212 [DAT](DEBUG): Initializing DAT. 1970-01-14T21:14:59.214Z,1199699.214 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 6291 1970-01-14T21:14:59.215Z,1199699.215 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 1970-01-14T21:14:59.218Z,1199699.218 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6293 1970-01-14T21:14:59.221Z,1199699.221 [WetLabsBB2FL](INFO): Powering up 1970-01-14T21:14:59.223Z,1199699.223 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6295 1970-01-14T21:14:59.226Z,1199699.226 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2HA05M.000 1970-01-14T21:14:59.226Z,1199699.226 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2HA05M.000 1970-01-14T21:14:59.226Z,1199699.226 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3HA20M.000 1970-01-14T21:14:59.226Z,1199699.226 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3HA20M.000 1970-01-14T21:14:59.227Z,1199699.227 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 1970-01-14T21:14:59.227Z,1199699.227 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 1970-01-14T21:14:59.227Z,1199699.227 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4HA51M.000 1970-01-14T21:14:59.227Z,1199699.227 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4HA51M.000 1970-01-14T21:14:59.227Z,1199699.227 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA53M.000 1970-01-14T21:14:59.227Z,1199699.227 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA53M.000 1970-01-14T21:14:59.227Z,1199699.227 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5HA55M.000 1970-01-14T21:14:59.228Z,1199699.228 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5HA55M.000 1970-01-14T21:14:59.257Z,1199699.257 [CBIT](DEBUG): Deactivating GF circuits. 1970-01-14T21:14:59.257Z,1199699.257 [CBIT](DEBUG): Deactivating emergency mode. 1970-01-14T21:14:59.293Z,1199699.293 [CBIT](DEBUG): Backplane powered. 1970-01-14T21:14:59.293Z,1199699.293 [VerticalControl](DEBUG): Initialize VerticalControlComponent. 1970-01-14T21:14:59.295Z,1199699.295 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent. 1970-01-14T21:14:59.296Z,1199699.296 [SpeedControl](DEBUG): Initialize SpeedControlComponent. 1970-01-14T21:14:59.296Z,1199699.296 [LoopControl](DEBUG): Initialize LoopControlComponent. 1970-01-14T21:14:59.303Z,1199699.303 [MissionManager](INFO): Loading Mission from file: Missions/Startup.xml 1970-01-14T21:14:59.332Z,1199699.332 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface. 1970-01-14T21:14:59.363Z,1199699.363 [MissionManager](DEBUG): 1970-01-14T21:14:59.364Z,1199699.364 [MissionManager](INFO): Loading Mission from file: Missions/Default.xml 1970-01-14T21:14:59.467Z,1199699.467 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min 1970-01-14T21:14:59.468Z,1199699.468 [Default:A.Wait](DEBUG): Construct Wait. 1970-01-14T21:14:59.471Z,1199699.471 [Default:B.GoToSurface](DEBUG): Construct GoToSurface. 1970-01-14T21:14:59.511Z,1199699.511 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute. 1970-01-14T21:14:59.514Z,1199699.514 [Default:CheckIn:C.Wait](DEBUG): Construct Wait. 1970-01-14T21:14:59.558Z,1199699.558 [Default:E.Execute](DEBUG): Construct Execute. 1970-01-14T21:14:59.562Z,1199699.562 [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 1970-01-14T21:14:59.569Z,1199699.569 [controlThread](DEBUG): Component order: CycleStarter,AHRS_M2,BPC1,Depth_Keller,DropWeight,NAL9602,Power24vConverter,PNI_TCM,Aanderaa_O2,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingMultipleVelocitySources,DeadReckonUsingSpeedCalculator,DeadReckonWithRespectToSeafloor,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterHE,SBIT,IBIT,CBIT,Reporter,LogSplitter, 1970-01-14T21:14:59.589Z,1199699.589 [AHRS_M2](DEBUG): Initializing AHRS_M2. 1970-01-14T21:14:59.597Z,1199699.597 [Radio_Surface](INFO): Powering up 1970-01-14T21:14:59.662Z,1199699.662 [Power24vConverter](INFO): Powering up. 1970-01-14T21:14:59.737Z,1199699.737 [BuoyancyServo](DEBUG): Initializing EZServoServo. 1970-01-14T21:14:59.745Z,1199699.745 [BuoyancyServo](DEBUG): Initializing BuoyancyServo. 1970-01-14T21:14:59.746Z,1199699.746 [ElevatorServo](DEBUG): Initializing EZServoServo. 1970-01-14T21:14:59.753Z,1199699.753 [ElevatorServo](DEBUG): Initializing ElevatorServo. 1970-01-14T21:14:59.754Z,1199699.754 [MassServo](DEBUG): Initializing EZServoServo. 1970-01-14T21:14:59.761Z,1199699.761 [MassServo](DEBUG): Initializing MassServo. 1970-01-14T21:14:59.762Z,1199699.762 [RudderServo](DEBUG): Initializing EZServoServo. 1970-01-14T21:14:59.769Z,1199699.769 [RudderServo](DEBUG): Initializing RudderServo. 1970-01-14T21:14:59.770Z,1199699.770 [ThrusterHE](DEBUG): Initializing EZServoServo. 1970-01-14T21:14:59.777Z,1199699.777 [ThrusterHE](DEBUG): Initializing ThrusterHE. 1970-01-14T21:15:00.026Z,1199700.026 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 1970-01-14T21:15:00.026Z,1199700.026 [DropWeight] Hardware Fault, FailCount= 1 1970-01-14T21:15:00.026Z,1199700.026 [DropWeight](ERROR): Hardware Fault 1970-01-14T21:15:00.096Z,1199700.096 [CommandExec](FAULT): Scheduling is paused 1970-01-14T21:15:00.097Z,1199700.097 [CBIT](INFO): Critical error at 19700114T211500 1970-01-14T21:15:00.097Z,1199700.097 [Supervisor](INFO): Stop Mission called by CBIT::checkCriticals 1970-01-14T21:15:00.099Z,1199700.099 [CBIT](ERROR): Hardware Fault in component: DropWeight 1970-01-14T21:15:00.100Z,1199700.100 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 1970-01-14T21:15:00.506Z,1199700.506 [CBIT](INFO): Critical error at 19700114T211500 1970-01-14T21:15:02.807Z,1199702.807 [AHRS_M2](DEBUG): boresightMatrix m[ decimal 0 0 2 2 f0.0 f0.0 f-1.0 f0.0 f-1.0 f0.0 f-1.0 f0.0 f0.0 ]m set drop 1970-01-14T21:15:03.210Z,1199703.210 [AHRS_M2](DEBUG): chan0Format 2 set drop 1970-01-14T21:15:03.614Z,1199703.614 [AHRS_M2](DEBUG): chan0Trigger 5 set drop 1970-01-14T21:15:04.018Z,1199704.018 [AHRS_M2](DEBUG): chan0Enables array[ 0 15 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 ]array set drop 1970-01-14T21:15:04.018Z,1199704.018 [AHRS_M2](DEBUG): chan0EnableBit pitch dvid@ set drop 1970-01-14T21:15:04.422Z,1199704.422 [AHRS_M2](DEBUG): chan0EnableBit roll dvid@ set drop 1970-01-14T21:15:04.509Z,1199704.509 [WetLabsBB2FL] Communications Fault, FailCount= 1 1970-01-14T21:15:04.509Z,1199704.509 [WetLabsBB2FL](ERROR): Communications Fault 1970-01-14T21:15:04.826Z,1199704.826 [AHRS_M2](DEBUG): chan0EnableBit yaw dvid@ set drop 1970-01-14T21:15:04.900Z,1199704.900 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 1970-01-14T21:15:05.009Z,1199705.009 [WetLabsBB2FL](INFO): Powering down 1970-01-14T21:15:05.230Z,1199705.230 [AHRS_M2](DEBUG): chan0EnableBit magp dvid@ set drop 1970-01-14T21:15:05.414Z,1199705.414 [ThrusterHE](ERROR): Zero Speed Commanded. 1970-01-14T21:15:05.634Z,1199705.634 [AHRS_M2](DEBUG): chan0EnableBit accelp dvid@ set drop 1970-01-14T21:15:05.853Z,1199705.853 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 1970-01-14T21:15:05.853Z,1199705.853 [WetLabsBB2FL] No Fault, FailCount= 1 1970-01-14T21:15:06.038Z,1199706.038 [AHRS_M2](DEBUG): chan0EnableBit gyrop dvid@ set drop 1970-01-14T21:15:06.226Z,1199706.226 [WetLabsBB2FL](INFO): Powering up 1970-01-14T21:15:06.442Z,1199706.442 [AHRS_M2](DEBUG): chan0EnableBit yawErrEst dvid@ set drop 1970-01-14T21:15:06.846Z,1199706.846 [AHRS_M2](DEBUG): chan0EnableBit temperature dvid@ set drop 1970-01-14T21:15:06.854Z,1199706.854 [PNI_TCM](FAULT): Failed to set parameters during initialization. 1970-01-14T21:15:06.855Z,1199706.855 [PNI_TCM] Data Fault, FailCount= 1 1970-01-14T21:15:06.855Z,1199706.855 [PNI_TCM](ERROR): Data Fault 1970-01-14T21:15:06.918Z,1199706.918 [CBIT](ERROR): Data Fault in component: PNI_TCM 1970-01-14T21:15:07.251Z,1199707.251 [AHRS_M2](DEBUG): chan0EnableBit magBufferActiveIndex dvid@ set drop 1970-01-14T21:15:07.254Z,1199707.254 [PNI_TCM](INFO): Powering down 1970-01-14T21:15:07.654Z,1199707.654 [AHRS_M2](DEBUG): chan0TriggerDivisor 40 set drop 1970-01-14T21:15:08.521Z,1199708.521 [CBIT](INFO): Clearing failed state for component PNI_TCM 1970-01-14T21:15:08.521Z,1199708.521 [PNI_TCM] No Fault, FailCount= 1 1970-01-14T21:15:09.341Z,1199709.341 [CBIT](CRITICAL): Environmental Failure. Press:14.854256 PSI. Humidity:34%. Temp:25 C. ABORTING MISSION 1970-01-14T21:15:09.689Z,1199709.689 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 1970-01-14T21:15:09.689Z,1199709.689 [Aanderaa_O2] Communications Fault, FailCount= 1 1970-01-14T21:15:09.689Z,1199709.689 [Aanderaa_O2](ERROR): Communications Fault 1970-01-14T21:15:09.791Z,1199709.791 [CBIT](INFO): Critical error at 19700114T211509 1970-01-14T21:15:09.794Z,1199709.794 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 1970-01-14T21:15:10.201Z,1199710.201 [Aanderaa_O2](INFO): Powering down 1970-01-14T21:15:10.973Z,1199710.973 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 1970-01-14T21:15:10.973Z,1199710.973 [Aanderaa_O2] No Fault, FailCount= 1 1970-01-14T21:15:11.517Z,1199711.517 [WetLabsBB2FL] Communications Fault, FailCount= 2 1970-01-14T21:15:11.517Z,1199711.517 [WetLabsBB2FL](ERROR): Communications Fault 1970-01-14T21:15:11.762Z,1199711.762 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 1970-01-14T21:15:12.017Z,1199712.017 [WetLabsBB2FL](INFO): Powering down 1970-01-14T21:15:12.265Z,1199712.265 [CTD_Seabird](FAULT): Failed to initialize within timeout. 1970-01-14T21:15:12.265Z,1199712.265 [CTD_Seabird] Communications Fault, FailCount= 1 1970-01-14T21:15:12.265Z,1199712.265 [CTD_Seabird](ERROR): Communications Fault 1970-01-14T21:15:12.557Z,1199712.557 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 1970-01-14T21:15:12.670Z,1199712.670 [CTD_Seabird](INFO): Powering down 1970-01-14T21:15:12.972Z,1199712.972 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 1970-01-14T21:15:12.972Z,1199712.972 [WetLabsBB2FL] No Fault, FailCount= 2 1970-01-14T21:15:13.230Z,1199713.230 [WetLabsBB2FL](INFO): Powering up 1970-01-14T21:15:13.769Z,1199713.769 [CBIT](INFO): Clearing failed state for component CTD_Seabird 1970-01-14T21:15:13.769Z,1199713.769 [CTD_Seabird] No Fault, FailCount= 1 1970-01-14T21:15:14.013Z,1199714.013 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 1970-01-14T21:15:16.142Z,1199716.142 [PNI_TCM](FAULT): Failed to set parameters during initialization. 1970-01-14T21:15:16.142Z,1199716.142 [PNI_TCM] Data Fault, FailCount= 2 1970-01-14T21:15:16.142Z,1199716.142 [PNI_TCM](ERROR): Data Fault 1970-01-14T21:15:16.223Z,1199716.223 [CBIT](ERROR): Data Fault in component: PNI_TCM 1970-01-14T21:15:16.546Z,1199716.546 [PNI_TCM](INFO): Powering down 1970-01-14T21:15:17.754Z,1199717.754 [AHRS_M2](FAULT): Failed to acquire valid data within timeout. 1970-01-14T21:15:17.754Z,1199717.754 [AHRS_M2] Data Fault, FailCount= 1 1970-01-14T21:15:17.754Z,1199717.754 [AHRS_M2](ERROR): Data Fault 1970-01-14T21:15:17.829Z,1199717.829 [CBIT](ERROR): Data Fault in component: AHRS_M2 1970-01-14T21:15:17.829Z,1199717.829 [CBIT](CRITICAL): Data Fault in component: AHRS_M2 1970-01-14T21:15:17.829Z,1199717.829 [CBIT](INFO): Clearing failed state for component PNI_TCM 1970-01-14T21:15:17.830Z,1199717.830 [PNI_TCM] No Fault, FailCount= 2 1970-01-14T21:15:18.235Z,1199718.235 [CBIT](INFO): Critical error at 19700114T211517 1970-01-14T21:15:18.521Z,1199718.521 [WetLabsBB2FL] Communications Fault, FailCount= 3 1970-01-14T21:15:18.521Z,1199718.521 [WetLabsBB2FL](ERROR): Communications Fault 1970-01-14T21:15:18.625Z,1199718.625 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 1970-01-14T21:15:19.021Z,1199719.021 [WetLabsBB2FL](INFO): Powering down 1970-01-14T21:15:19.858Z,1199719.858 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 1970-01-14T21:15:19.858Z,1199719.858 [WetLabsBB2FL] No Fault, FailCount= 3 1970-01-14T21:15:20.242Z,1199720.242 [WetLabsBB2FL](INFO): Powering up 1970-01-14T21:15:21.394Z,1199721.394 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 1970-01-14T21:15:21.395Z,1199721.395 [Aanderaa_O2] Communications Fault, FailCount= 2 1970-01-14T21:15:21.395Z,1199721.395 [Aanderaa_O2](ERROR): Communications Fault 1970-01-14T21:15:21.473Z,1199721.473 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 1970-01-14T21:15:21.917Z,1199721.917 [Aanderaa_O2](INFO): Powering down 1970-01-14T21:15:22.693Z,1199722.693 [CBIT](INFO): Clearing failed state for component Aanderaa_O2 1970-01-14T21:15:22.693Z,1199722.693 [Aanderaa_O2] No Fault, FailCount= 2 1970-01-14T21:15:25.434Z,1199725.434 [PNI_TCM](FAULT): Failed to set parameters during initialization. 1970-01-14T21:15:25.434Z,1199725.434 [PNI_TCM] Data Fault, FailCount= 3 1970-01-14T21:15:25.434Z,1199725.434 [PNI_TCM](ERROR): Data Fault 1970-01-14T21:15:25.503Z,1199725.503 [CBIT](ERROR): Data Fault in component: PNI_TCM 1970-01-14T21:15:25.541Z,1199725.541 [WetLabsBB2FL] Communications Fault, FailCount= 4 1970-01-14T21:15:25.541Z,1199725.541 [WetLabsBB2FL](ERROR): Communications Fault 1970-01-14T21:15:25.838Z,1199725.838 [PNI_TCM](INFO): Powering down 1970-01-14T21:15:25.995Z,1199725.995 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 1970-01-14T21:15:26.044Z,1199726.044 [WetLabsBB2FL](INFO): Powering down 1970-01-14T21:15:27.065Z,1199727.065 [CTD_Seabird](FAULT): Failed to initialize within timeout. 1970-01-14T21:15:27.065Z,1199727.065 [CTD_Seabird] Communications Fault, FailCount= 2 1970-01-14T21:15:27.065Z,1199727.065 [CTD_Seabird](ERROR): Communications Fault 1970-01-14T21:15:27.108Z,1199727.108 [CBIT](INFO): Clearing failed state for component PNI_TCM 1970-01-14T21:15:27.108Z,1199727.108 [PNI_TCM] No Fault, FailCount= 3 1970-01-14T21:15:27.109Z,1199727.109 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 1970-01-14T21:15:27.109Z,1199727.109 [CBIT](INFO): Clearing failed state for component WetLabsBB2FL 1970-01-14T21:15:27.109Z,1199727.109 [WetLabsBB2FL] No Fault, FailCount= 4 1970-01-14T21:15:27.258Z,1199727.258 [WetLabsBB2FL](INFO): Powering up 1970-01-14T21:15:27.454Z,1199727.454 [NAL9602](INFO): Powering up NAL9602 1970-01-14T21:15:27.469Z,1199727.469 [CTD_Seabird](INFO): Powering down 1970-01-14T21:15:28.713Z,1199728.713 [CBIT](INFO): Clearing failed state for component CTD_Seabird 1970-01-14T21:15:28.713Z,1199728.713 [CTD_Seabird] No Fault, FailCount= 2 1970-01-14T21:15:28.813Z,1199728.813 [CTD_Seabird](DEBUG): Initializing CTD_Seabird. 1970-01-14T21:15:32.557Z,1199732.557 [WetLabsBB2FL] Communications Fault, FailCount= 5 1970-01-14T21:15:32.557Z,1199732.557 [WetLabsBB2FL](ERROR): Communications Fault 1970-01-14T21:15:32.751Z,1199732.751 [CBIT](ERROR): Communications Fault in component: WetLabsBB2FL 1970-01-14T21:15:32.751Z,1199732.751 [CBIT](FAULT): Communications Fault in component: WetLabsBB2FL 1970-01-14T21:15:33.057Z,1199733.057 [WetLabsBB2FL](INFO): Powering down 1970-01-14T21:15:33.115Z,1199733.114 [Aanderaa_O2](FAULT): Failed to initialize within timeout. 1970-01-14T21:15:33.115Z,1199733.115 [Aanderaa_O2] Communications Fault, FailCount= 3 1970-01-14T21:15:33.115Z,1199733.115 [Aanderaa_O2](ERROR): Communications Fault 1970-01-14T21:15:33.179Z,1199733.179 [CBIT](ERROR): Communications Fault in component: Aanderaa_O2 1970-01-14T21:15:33.180Z,1199733.180 [CBIT](FAULT): Communications Fault in component: Aanderaa_O2 1970-01-14T21:15:33.637Z,1199733.637 [Aanderaa_O2](INFO): Powering down 1970-01-14T21:15:34.730Z,1199734.730 [PNI_TCM](FAULT): Failed to set parameters during initialization. 1970-01-14T21:15:34.730Z,1199734.730 [PNI_TCM] Data Fault, FailCount= 4 1970-01-14T21:15:34.730Z,1199734.730 [PNI_TCM](ERROR): Data Fault 1970-01-14T21:15:34.798Z,1199734.798 [CBIT](ERROR): Data Fault in component: PNI_TCM 1970-01-14T21:15:35.131Z,1199735.131 [PNI_TCM](INFO): Powering down 1970-01-14T21:15:36.381Z,1199736.381 [CBIT](INFO): Clearing failed state for component PNI_TCM 1970-01-14T21:15:36.381Z,1199736.381 [PNI_TCM] No Fault, FailCount= 4 1970-01-14T21:15:38.366Z,1199738.366 [NAL9602](INFO): NAL9602 initialized 1970-01-14T21:15:41.869Z,1199741.869 [CTD_Seabird](FAULT): Failed to initialize within timeout. 1970-01-14T21:15:41.869Z,1199741.869 [CTD_Seabird] Communications Fault, FailCount= 3 1970-01-14T21:15:41.869Z,1199741.869 [CTD_Seabird](ERROR): Communications Fault 1970-01-14T21:15:42.069Z,1199742.069 [CBIT](ERROR): Communications Fault in component: CTD_Seabird 1970-01-14T21:15:42.070Z,1199742.070 [CBIT](FAULT): Communications Fault in component: CTD_Seabird 1970-01-14T21:15:42.273Z,1199742.273 [CTD_Seabird](INFO): Powering down 1970-01-14T21:15:44.023Z,1199744.023 [PNI_TCM](FAULT): Failed to set parameters during initialization. 1970-01-14T21:15:44.023Z,1199744.023 [PNI_TCM] Data Fault, FailCount= 5 1970-01-14T21:15:44.023Z,1199744.023 [PNI_TCM](ERROR): Data Fault 1970-01-14T21:15:44.088Z,1199744.088 [CBIT](ERROR): Data Fault in component: PNI_TCM 1970-01-14T21:15:44.088Z,1199744.088 [CBIT](CRITICAL): Data Fault in component: PNI_TCM 1970-01-14T21:15:44.424Z,1199744.424 [PNI_TCM](INFO): Powering down 1970-01-14T21:15:44.559Z,1199744.559 [CBIT](INFO): Critical error at 19700114T211544 1970-01-14T21:15:56.097Z,1199756.097 [CommandExec](IMPORTANT): got command quit 1970-01-14T21:15:57.101Z,1199757.101 [CommandExec ThreadHandler](INFO): Uninitializing protected caller thread. 1970-01-14T21:15:57.101Z,1199757.101 [CommandExec](INFO): Uninitializing the command executive. 1970-01-14T21:15:57.101Z,1199757.101 [CommandExec](INFO): Uninitializing the command scheduler. 1970-01-14T21:15:57.101Z,1199757.101 [CommandExec ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:57.257Z,1199757.257 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 1970-01-14T21:15:57.257Z,1199757.257 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 1970-01-14T21:15:57.257Z,1199757.257 [NavChartDb ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:57.258Z,1199757.258 [NavChartDb](INFO): Join timeout helper Thread ID is 6317 1970-01-14T21:15:57.545Z,1199757.545 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 1970-01-14T21:15:57.545Z,1199757.545 [NavChartDb ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:57.557Z,1199757.557 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 1970-01-14T21:15:57.557Z,1199757.557 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:57.557Z,1199757.557 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6318 1970-01-14T21:15:57.701Z,1199757.701 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 1970-01-14T21:15:57.701Z,1199757.701 [WetLabsBB2FL](INFO): Powering down 1970-01-14T21:15:57.702Z,1199757.702 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:57.717Z,1199757.717 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 1970-01-14T21:15:57.717Z,1199757.717 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:57.717Z,1199757.717 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6319 1970-01-14T21:15:57.757Z,1199757.757 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 1970-01-14T21:15:57.757Z,1199757.757 [CTD_Seabird](INFO): Powering down 1970-01-14T21:15:57.769Z,1199757.769 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:57.777Z,1199757.777 [ComponentRegistry](INFO): Shutting down DAT ThreadHandler 1970-01-14T21:15:57.777Z,1199757.777 [DAT ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:57.777Z,1199757.777 [DAT](INFO): Join timeout helper Thread ID is 6320 1970-01-14T21:15:57.957Z,1199757.957 [DAT](INFO): Powering down 1970-01-14T21:15:58.029Z,1199758.029 [DAT ThreadHandler](INFO): Uninitializing protected caller thread. 1970-01-14T21:15:58.029Z,1199758.029 [DAT](INFO): Powering down 1970-01-14T21:15:58.030Z,1199758.030 [DAT ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:58.041Z,1199758.041 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 1970-01-14T21:15:58.041Z,1199758.041 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:58.041Z,1199758.041 [Radio_Surface](INFO): Join timeout helper Thread ID is 6321 1970-01-14T21:15:58.229Z,1199758.229 [Radio_Surface](INFO): Powering down 1970-01-14T21:15:58.230Z,1199758.230 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 1970-01-14T21:15:58.230Z,1199758.230 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:58.250Z,1199758.250 [ComponentRegistry](INFO): Shutting down Onboard ThreadHandler 1970-01-14T21:15:58.250Z,1199758.250 [Onboard ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:58.250Z,1199758.250 [Onboard](INFO): Join timeout helper Thread ID is 6322 1970-01-14T21:15:59.221Z,1199759.221 [Onboard ThreadHandler](INFO): Uninitializing protected caller thread. 1970-01-14T21:15:59.221Z,1199759.221 [Onboard ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:59.229Z,1199759.229 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 1970-01-14T21:15:59.229Z,1199759.229 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:59.230Z,1199759.230 [DataOverHttps](INFO): Join timeout helper Thread ID is 6323 1970-01-14T21:15:59.405Z,1199759.405 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 1970-01-14T21:15:59.406Z,1199759.406 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:59.422Z,1199759.422 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 1970-01-14T21:15:59.422Z,1199759.422 [logger ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:59.422Z,1199759.422 [logger](INFO): Join timeout helper Thread ID is 6324 1970-01-14T21:15:59.455Z,1199759.455 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 1970-01-14T21:15:59.455Z,1199759.455 [logger ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:59.461Z,1199759.461 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 1970-01-14T21:15:59.461Z,1199759.461 [CommandLine ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:59.462Z,1199759.462 [CommandLine](INFO): Join timeout helper Thread ID is 6325 1970-01-14T21:15:59.505Z,1199759.505 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 1970-01-14T21:15:59.505Z,1199759.505 [CommandLine ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:59.521Z,1199759.521 [ComponentRegistry](INFO): Shutting down CommandExec ThreadHandler 1970-01-14T21:15:59.522Z,1199759.522 [CommandExec ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:59.522Z,1199759.522 [CommandExec](INFO): Join timeout helper Thread ID is 6326 1970-01-14T21:15:59.523Z,1199759.523 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 1970-01-14T21:15:59.523Z,1199759.523 [controlThread ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:59.524Z,1199759.524 [controlThread](INFO): Join timeout helper Thread ID is 6327 1970-01-14T21:15:59.765Z,1199759.765 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 1970-01-14T21:15:59.765Z,1199759.765 [controlThread](DEBUG): Uninitializing ControlThread 1970-01-14T21:15:59.767Z,1199759.767 [NAL9602](INFO): Powering down 1970-01-14T21:15:59.768Z,1199759.768 [PNI_TCM](INFO): Powering down 1970-01-14T21:15:59.769Z,1199759.769 [Aanderaa_O2](INFO): Powering down 1970-01-14T21:15:59.771Z,1199759.771 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 1970-01-14T21:15:59.772Z,1199759.772 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 1970-01-14T21:15:59.772Z,1199759.772 [NavChart](DEBUG): Uninitialize NavChart Navigation. 1970-01-14T21:15:59.773Z,1199759.773 [MissionManager](INFO): Uninitializing Mission Default 1970-01-14T21:15:59.775Z,1199759.775 [MissionManager](INFO): Uninitializing Mission Startup 1970-01-14T21:15:59.776Z,1199759.776 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 1970-01-14T21:15:59.777Z,1199759.777 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 1970-01-14T21:15:59.777Z,1199759.777 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 1970-01-14T21:15:59.777Z,1199759.777 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 1970-01-14T21:15:59.777Z,1199759.777 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 1970-01-14T21:15:59.778Z,1199759.778 [BuoyancyServo](INFO): Powering down 1970-01-14T21:15:59.789Z,1199759.789 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 1970-01-14T21:15:59.789Z,1199759.789 [ElevatorServo](INFO): Powering down 1970-01-14T21:15:59.790Z,1199759.790 [MassServo](DEBUG): Uninitialize Mass Servo. 1970-01-14T21:15:59.790Z,1199759.790 [MassServo](INFO): Powering down 1970-01-14T21:15:59.791Z,1199759.791 [RudderServo](DEBUG): Uninitialize Rudder Servo. 1970-01-14T21:15:59.791Z,1199759.791 [RudderServo](INFO): Powering down 1970-01-14T21:15:59.792Z,1199759.792 [ThrusterHE](DEBUG): Uninitialize Thruster Servo. 1970-01-14T21:15:59.792Z,1199759.792 [ThrusterHE](INFO): Powering down 1970-01-14T21:15:59.793Z,1199759.793 [SBIT](DEBUG): Uninitialize SBIT Component. 1970-01-14T21:15:59.793Z,1199759.793 [IBIT](DEBUG): Uninitialize IBIT Component. 1970-01-14T21:15:59.793Z,1199759.793 [CBIT](DEBUG): Uninitialize CBIT Component. 1970-01-14T21:15:59.793Z,1199759.793 [CBIT](DEBUG): Powering off loads. 1970-01-14T21:15:59.805Z,1199759.805 [CBIT](DEBUG): Disabling WDT. 1970-01-14T21:15:59.817Z,1199759.817 [CBIT](DEBUG): Opening all GF detection circuits. 1970-01-14T21:15:59.817Z,1199759.817 [controlThread ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:59.826Z,1199759.826 [DAT ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:59.831Z,1199759.831 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:59.835Z,1199759.835 [Onboard ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:59.841Z,1199759.841 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:59.968Z,1199759.968 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:15:59.973Z,1199759.973 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:16:00.227Z,1199760.227 [NavChartDb ThreadHandler](INFO): Thread cancelled. 1970-01-14T21:16:00.284Z,1199760.284 [logger ThreadHandler](INFO): Thread cancelled.