2018-12-31T20:48:28.824Z,1546289308.824 [Supervisor](DEBUG): Initializing supervisor.
2018-12-31T20:48:28.827Z,1546289308.827 [SyncHandler](DEBUG): Created PCaller Thread at 404514E0
2018-12-31T20:48:28.828Z,1546289308.828 [SyncHandler](INFO): Protected caller Thread ID is 6704
2018-12-31T20:48:28.828Z,1546289308.828 [ComponentRegistry](DEBUG): Component "controlThread" handled in its own thread.
2018-12-31T20:48:28.829Z,1546289308.829 [controlThread ThreadHandler](DEBUG): Created PCaller Thread at 404814E0
2018-12-31T20:48:28.829Z,1546289308.829 [controlThread ThreadHandler](INFO): Protected caller Thread ID is 6705
2018-12-31T20:48:28.832Z,1546289308.832 [ComponentRegistry](DEBUG): SyncComponent "CycleStarter" handled in the control thread.
2018-12-31T20:48:28.843Z,1546289308.843 [ComponentRegistry](DEBUG): Component "CommandLine" handled in its own thread.
2018-12-31T20:48:28.844Z,1546289308.844 [CommandLine ThreadHandler](DEBUG): Created PCaller Thread at 404B14E0
2018-12-31T20:48:28.845Z,1546289308.845 [CommandLine ThreadHandler](INFO): Protected caller Thread ID is 6706
2018-12-31T20:48:28.846Z,1546289308.846 [ComponentRegistry](DEBUG): Component "logger" handled in its own thread.
2018-12-31T20:48:28.847Z,1546289308.847 [logger ThreadHandler](DEBUG): Created PCaller Thread at 404E14E0
2018-12-31T20:48:28.847Z,1546289308.847 [logger ThreadHandler](INFO): Protected caller Thread ID is 6707
2018-12-31T20:48:28.849Z,1546289308.849 [ComponentRegistry](DEBUG): SyncComponent "LogSplitter" handled in the control thread.
2018-12-31T20:48:28.849Z,1546289308.849 [Supervisor](INFO): Looking for Config files in directory: Config/
2018-12-31T20:48:28.851Z,1546289308.851 [Supervisor](INFO): Opening Config file at: Config/Sample.cfg
2018-12-31T20:48:28.946Z,1546289308.946 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sample
2018-12-31T20:48:28.947Z,1546289308.947 [Supervisor](INFO): Opening Config file at: Config/workSite.cfg
2018-12-31T20:48:29.047Z,1546289309.047 [ComponentRegistry](DEBUG): Loaded Config Component "Config/workSite
2018-12-31T20:48:29.048Z,1546289309.048 [Supervisor](INFO): Opening Config file at: Config/logger.cfg
2018-12-31T20:48:29.233Z,1546289309.233 [ComponentRegistry](DEBUG): Loaded Config Component "Config/logger
2018-12-31T20:48:29.234Z,1546289309.234 [Supervisor](INFO): Opening Config file at: Config/Science.cfg
2018-12-31T20:48:29.594Z,1546289309.594 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Science
2018-12-31T20:48:29.595Z,1546289309.595 [Supervisor](INFO): Opening Config file at: Config/Control.cfg
2018-12-31T20:48:29.921Z,1546289309.921 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Control
2018-12-31T20:48:29.921Z,1546289309.921 [Supervisor](INFO): Opening Config file at: Config/Simulator.cfg
2018-12-31T20:48:30.356Z,1546289310.356 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Simulator
2018-12-31T20:48:30.356Z,1546289310.356 [Supervisor](INFO): Opening Config file at: Config/Sensor.cfg
2018-12-31T20:48:30.814Z,1546289310.814 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Sensor
2018-12-31T20:48:30.814Z,1546289310.814 [Supervisor](INFO): Opening Config file at: Config/vehicle.cfg
2018-12-31T20:48:31.250Z,1546289311.250 [ComponentRegistry](DEBUG): Loaded Config Component "Config/vehicle
2018-12-31T20:48:31.251Z,1546289311.251 [Supervisor](INFO): Opening Config file at: Config/Guidance.cfg
2018-12-31T20:48:31.329Z,1546289311.329 [Supervisor](INFO): Opening Config file at: Config/Servo.cfg
2018-12-31T20:48:31.627Z,1546289311.627 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Servo
2018-12-31T20:48:31.627Z,1546289311.627 [Supervisor](INFO): Opening Config file at: Config/Derivation.cfg
2018-12-31T20:48:31.771Z,1546289311.771 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Derivation
2018-12-31T20:48:31.771Z,1546289311.771 [Supervisor](INFO): Opening Config file at: Config/Navigation.cfg
2018-12-31T20:48:31.982Z,1546289311.982 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Navigation
2018-12-31T20:48:31.982Z,1546289311.982 [Supervisor](INFO): Opening Config file at: Config/BIT.cfg
2018-12-31T20:48:32.180Z,1546289312.180 [ComponentRegistry](DEBUG): Loaded Config Component "Config/BIT
2018-12-31T20:48:32.181Z,1546289312.181 [Supervisor](INFO): Opening Config file at: Config/secure.cfg
2018-12-31T20:48:32.276Z,1546289312.276 [ComponentRegistry](DEBUG): Loaded Config Component "Config/secure
2018-12-31T20:48:32.277Z,1546289312.277 [Supervisor](INFO): Opening Config file at: Config/Estimation.cfg
2018-12-31T20:48:32.417Z,1546289312.417 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Estimation
2018-12-31T20:48:32.419Z,1546289312.419 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/
2018-12-31T20:48:32.420Z,1546289312.420 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Battery.cfg
2018-12-31T20:48:32.647Z,1546289312.647 [ComponentRegistry](DEBUG): Loaded Config Component "Config/Battery
2018-12-31T20:48:32.647Z,1546289312.647 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/logger.cfg
2018-12-31T20:48:32.748Z,1546289312.748 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Science.cfg
2018-12-31T20:48:32.894Z,1546289312.894 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Control.cfg
2018-12-31T20:48:32.985Z,1546289312.985 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Simulator.cfg
2018-12-31T20:48:33.068Z,1546289313.068 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Sensor.cfg
2018-12-31T20:48:33.221Z,1546289313.221 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/vehicle.cfg
2018-12-31T20:48:33.416Z,1546289313.416 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Servo.cfg
2018-12-31T20:48:33.511Z,1546289313.511 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/Navigation.cfg
2018-12-31T20:48:33.604Z,1546289313.604 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/BIT.cfg
2018-12-31T20:48:33.699Z,1546289313.699 [Supervisor](INFO): Opening Config file at: Config/lrauv-makai/secure.cfg
2018-12-31T20:48:33.781Z,1546289313.781 [Supervisor](INFO): Looking for Config files in directory: Config/lrauv-makai/root/
2018-12-31T20:48:33.782Z,1546289313.782 [Supervisor](IMPORTANT): Reading configuration overrides from Data/persisted.cfg
2018-12-31T20:48:33.786Z,1546289313.786 [Module Loader](DEBUG): Loading Module at Modules/Simulator.so
2018-12-31T20:48:33.886Z,1546289313.886 [Module Loader](DEBUG): Loaded Module: Simulator (This is the module containing the Simulator)
2018-12-31T20:48:33.886Z,1546289313.886 [Module Loader](DEBUG): Loading Module at Modules/Sample.so
2018-12-31T20:48:33.899Z,1546289313.899 [Module Loader](DEBUG): Loaded Module: Sample (This is a Sample Module of Sample Components)
2018-12-31T20:48:33.900Z,1546289313.900 [Module Loader](DEBUG): Loading Module at Modules/Derivation.so
2018-12-31T20:48:33.941Z,1546289313.941 [DepthRateCalculator] Loaded
2018-12-31T20:48:33.941Z,1546289313.941 [ComponentRegistry](DEBUG): SyncComponent "DepthRateCalculator" handled in the control thread.
2018-12-31T20:48:33.947Z,1546289313.947 [PitchRateCalculator] Loaded
2018-12-31T20:48:33.947Z,1546289313.947 [ComponentRegistry](DEBUG): SyncComponent "PitchRateCalculator" handled in the control thread.
2018-12-31T20:48:33.963Z,1546289313.963 [SpeedCalculator] Loaded
2018-12-31T20:48:33.963Z,1546289313.963 [ComponentRegistry](DEBUG): SyncComponent "SpeedCalculator" handled in the control thread.
2018-12-31T20:48:33.983Z,1546289313.983 [TempGradientCalculator] Loaded
2018-12-31T20:48:33.983Z,1546289313.983 [ComponentRegistry](DEBUG): SyncComponent "TempGradientCalculator" handled in the control thread.
2018-12-31T20:48:33.989Z,1546289313.989 [YawRateCalculator] Loaded
2018-12-31T20:48:33.989Z,1546289313.989 [ComponentRegistry](DEBUG): SyncComponent "YawRateCalculator" handled in the control thread.
2018-12-31T20:48:34.028Z,1546289314.028 [ElevatorOffsetCalculator] Loaded
2018-12-31T20:48:34.028Z,1546289314.028 [ComponentRegistry](DEBUG): SyncComponent "ElevatorOffsetCalculator" handled in the control thread.
2018-12-31T20:48:34.029Z,1546289314.029 [Module Loader](DEBUG): Loaded Module: Derivation (Contains the base derivation components)
2018-12-31T20:48:34.029Z,1546289314.029 [Module Loader](DEBUG): Loading Module at Modules/Trigger.so
2018-12-31T20:48:34.055Z,1546289314.055 [Module Loader](DEBUG): Loaded Module: Trigger (Contains triggers for use in missions)
2018-12-31T20:48:34.056Z,1546289314.056 [Module Loader](DEBUG): Loading Module at Modules/Sensor.so
2018-12-31T20:48:34.345Z,1546289314.345 [AcousticModem_Benthos_ATM900] Loaded
2018-12-31T20:48:34.345Z,1546289314.345 [ComponentRegistry](DEBUG): SyncComponent "AcousticModem_Benthos_ATM900" handled in the control thread.
2018-12-31T20:48:34.411Z,1546289314.411 [DataOverHttps] Loaded
2018-12-31T20:48:34.412Z,1546289314.412 [ComponentRegistry](DEBUG): SyncComponent "DataOverHttps" handled in the control thread.
2018-12-31T20:48:34.424Z,1546289314.424 [Depth_Keller] Loaded
2018-12-31T20:48:34.425Z,1546289314.425 [ComponentRegistry](DEBUG): SyncComponent "Depth_Keller" handled in the control thread.
2018-12-31T20:48:34.521Z,1546289314.521 [NAL9602] Loaded
2018-12-31T20:48:34.521Z,1546289314.521 [ComponentRegistry](DEBUG): SyncComponent "NAL9602" handled in the control thread.
2018-12-31T20:48:34.537Z,1546289314.537 [Onboard] Loaded
2018-12-31T20:48:34.537Z,1546289314.537 [ComponentRegistry](DEBUG): SyncComponent "Onboard" handled in the control thread.
2018-12-31T20:48:34.547Z,1546289314.547 [Radio_Surface] Loaded
2018-12-31T20:48:34.547Z,1546289314.547 [ComponentRegistry](DEBUG): Component "Radio_Surface" handled in its own thread.
2018-12-31T20:48:34.548Z,1546289314.548 [Radio_Surface ThreadHandler](DEBUG): Created PCaller Thread at 407CE4E0
2018-12-31T20:48:34.549Z,1546289314.549 [Radio_Surface ThreadHandler](INFO): Protected caller Thread ID is 6786
2018-12-31T20:48:34.595Z,1546289314.595 [PNI_TCM] Loaded
2018-12-31T20:48:34.596Z,1546289314.596 [ComponentRegistry](DEBUG): SyncComponent "PNI_TCM" handled in the control thread.
2018-12-31T20:48:34.654Z,1546289314.654 [Rowe_600LCM] Loaded
2018-12-31T20:48:34.655Z,1546289314.655 [ComponentRegistry](DEBUG): Component "Rowe_600LCM" handled in its own thread.
2018-12-31T20:48:34.655Z,1546289314.655 [Rowe_600LCM ThreadHandler](DEBUG): Created PCaller Thread at 407FE4E0
2018-12-31T20:48:34.656Z,1546289314.656 [Rowe_600LCM ThreadHandler](INFO): Protected caller Thread ID is 6787
2018-12-31T20:48:36.492Z,1546289316.492 [BPC1] Loaded
2018-12-31T20:48:36.492Z,1546289316.492 [ComponentRegistry](DEBUG): SyncComponent "BPC1" handled in the control thread.
2018-12-31T20:48:36.493Z,1546289316.493 [Module Loader](DEBUG): Loaded Module: Sensor (Contains the sensor components)
2018-12-31T20:48:36.493Z,1546289316.493 [Module Loader](DEBUG): Loading Module at Modules/BIT.so
2018-12-31T20:48:36.628Z,1546289316.628 [SBIT](DEBUG): Construct Startup Built In Test.
2018-12-31T20:48:36.650Z,1546289316.650 [SBIT] Loaded
2018-12-31T20:48:36.651Z,1546289316.651 [ComponentRegistry](DEBUG): SyncComponent "SBIT" handled in the control thread.
2018-12-31T20:48:36.651Z,1546289316.651 [IBIT](DEBUG): Construct Initiated Built In Test.
2018-12-31T20:48:36.663Z,1546289316.663 [IBIT] Loaded
2018-12-31T20:48:36.663Z,1546289316.663 [ComponentRegistry](DEBUG): SyncComponent "IBIT" handled in the control thread.
2018-12-31T20:48:36.666Z,1546289316.666 [CBIT](DEBUG): Construct Continuous Built In Test.
2018-12-31T20:48:36.800Z,1546289316.800 [CBIT] Loaded
2018-12-31T20:48:36.800Z,1546289316.800 [ComponentRegistry](DEBUG): SyncComponent "CBIT" handled in the control thread.
2018-12-31T20:48:36.801Z,1546289316.801 [Module Loader](DEBUG): Loaded Module: BIT (Contains the BuiltInTest components, such as C Built In Test)
2018-12-31T20:48:36.801Z,1546289316.801 [Module Loader](DEBUG): Loading Module at Modules/Science.so
2018-12-31T20:48:37.044Z,1546289317.044 [CTD_Seabird] Loaded
2018-12-31T20:48:37.044Z,1546289317.044 [ComponentRegistry](DEBUG): Component "CTD_Seabird" handled in its own thread.
2018-12-31T20:48:37.045Z,1546289317.045 [CTD_Seabird ThreadHandler](DEBUG): Created PCaller Thread at 408DE4E0
2018-12-31T20:48:37.046Z,1546289317.046 [CTD_Seabird ThreadHandler](INFO): Protected caller Thread ID is 6788
2018-12-31T20:48:37.063Z,1546289317.063 [ESPComponent] Loaded
2018-12-31T20:48:37.063Z,1546289317.063 [ComponentRegistry](DEBUG): SyncComponent "ESPComponent" handled in the control thread.
2018-12-31T20:48:37.077Z,1546289317.077 [PAR_Licor] Loaded
2018-12-31T20:48:37.077Z,1546289317.077 [ComponentRegistry](DEBUG): SyncComponent "PAR_Licor" handled in the control thread.
2018-12-31T20:48:37.125Z,1546289317.125 [WetLabsBB2FL] Loaded
2018-12-31T20:48:37.125Z,1546289317.125 [ComponentRegistry](DEBUG): Component "WetLabsBB2FL" handled in its own thread.
2018-12-31T20:48:37.126Z,1546289317.126 [WetLabsBB2FL ThreadHandler](DEBUG): Created PCaller Thread at 4090E4E0
2018-12-31T20:48:37.127Z,1546289317.127 [WetLabsBB2FL ThreadHandler](INFO): Protected caller Thread ID is 6789
2018-12-31T20:48:37.128Z,1546289317.128 [Module Loader](DEBUG): Loaded Module: Science (Contains the science components)
2018-12-31T20:48:37.128Z,1546289317.128 [Module Loader](DEBUG): Loading Module at Modules/Guidance.so
2018-12-31T20:48:37.363Z,1546289317.363 [Module Loader](DEBUG): Loaded Module: Guidance (Contains behaviors and commands)
2018-12-31T20:48:37.363Z,1546289317.363 [Module Loader](DEBUG): Loading Module at Modules/Control.so
2018-12-31T20:48:37.431Z,1546289317.431 [VerticalControl](DEBUG): Construct VerticalControl.
2018-12-31T20:48:37.523Z,1546289317.523 [VerticalControl] Loaded
2018-12-31T20:48:37.523Z,1546289317.523 [ComponentRegistry](DEBUG): SyncComponent "VerticalControl" handled in the control thread.
2018-12-31T20:48:37.524Z,1546289317.524 [HorizontalControl](DEBUG): Construct HorizontalControl.
2018-12-31T20:48:37.583Z,1546289317.583 [HorizontalControl] Loaded
2018-12-31T20:48:37.583Z,1546289317.583 [ComponentRegistry](DEBUG): SyncComponent "HorizontalControl" handled in the control thread.
2018-12-31T20:48:37.584Z,1546289317.584 [SpeedControl](DEBUG): Construct SpeedControl.
2018-12-31T20:48:37.589Z,1546289317.589 [SpeedControl] Loaded
2018-12-31T20:48:37.589Z,1546289317.589 [ComponentRegistry](DEBUG): SyncComponent "SpeedControl" handled in the control thread.
2018-12-31T20:48:37.590Z,1546289317.590 [LoopControl](DEBUG): Construct LoopControl.
2018-12-31T20:48:37.590Z,1546289317.590 [LoopControl] Loaded
2018-12-31T20:48:37.591Z,1546289317.591 [ComponentRegistry](DEBUG): SyncComponent "LoopControl" handled in the control thread.
2018-12-31T20:48:37.591Z,1546289317.591 [Module Loader](DEBUG): Loaded Module: Control (Contains the Control components, such as Depth, Heading, and Speed Control)
2018-12-31T20:48:37.592Z,1546289317.592 [Module Loader](DEBUG): Loading Module at Modules/Estimation.so
2018-12-31T20:48:37.655Z,1546289317.655 [Module Loader](DEBUG): Loaded Module: Estimation (Contains the base estimation components)
2018-12-31T20:48:37.656Z,1546289317.656 [Module Loader](DEBUG): Loading Module at Modules/Servo.so
2018-12-31T20:48:37.755Z,1546289317.755 [BuoyancyServo] Loaded
2018-12-31T20:48:37.755Z,1546289317.755 [ComponentRegistry](DEBUG): SyncComponent "BuoyancyServo" handled in the control thread.
2018-12-31T20:48:37.766Z,1546289317.766 [ElevatorServo] Loaded
2018-12-31T20:48:37.767Z,1546289317.767 [ComponentRegistry](DEBUG): SyncComponent "ElevatorServo" handled in the control thread.
2018-12-31T20:48:37.777Z,1546289317.777 [MassServo] Loaded
2018-12-31T20:48:37.777Z,1546289317.777 [ComponentRegistry](DEBUG): SyncComponent "MassServo" handled in the control thread.
2018-12-31T20:48:37.788Z,1546289317.788 [RudderServo] Loaded
2018-12-31T20:48:37.788Z,1546289317.788 [ComponentRegistry](DEBUG): SyncComponent "RudderServo" handled in the control thread.
2018-12-31T20:48:37.799Z,1546289317.799 [ThrusterServo] Loaded
2018-12-31T20:48:37.799Z,1546289317.799 [ComponentRegistry](DEBUG): SyncComponent "ThrusterServo" handled in the control thread.
2018-12-31T20:48:37.800Z,1546289317.800 [Module Loader](DEBUG): Loaded Module: Servo (This is the module containing motor controllers)
2018-12-31T20:48:37.800Z,1546289317.800 [Module Loader](DEBUG): Loading Module at Modules/Navigation.so
2018-12-31T20:48:37.896Z,1546289317.896 [DeadReckonUsingSpeedCalculator] Loaded
2018-12-31T20:48:37.896Z,1546289317.896 [ComponentRegistry](DEBUG): SyncComponent "DeadReckonUsingSpeedCalculator" handled in the control thread.
2018-12-31T20:48:37.912Z,1546289317.912 [NavChart] Loaded
2018-12-31T20:48:37.912Z,1546289317.912 [ComponentRegistry](DEBUG): SyncComponent "NavChart" handled in the control thread.
2018-12-31T20:48:37.916Z,1546289317.916 [UniversalFixResidualReporter] Loaded
2018-12-31T20:48:37.916Z,1546289317.916 [ComponentRegistry](DEBUG): SyncComponent "UniversalFixResidualReporter" handled in the control thread.
2018-12-31T20:48:37.917Z,1546289317.917 [Module Loader](DEBUG): Loaded Module: Navigation (Contains the base navigation components)
2018-12-31T20:48:37.920Z,1546289317.920 [ComponentRegistry](DEBUG): SyncComponent "MissionManager" handled in the control thread.
2018-12-31T20:48:37.921Z,1546289317.921 [ComponentRegistry](DEBUG): SyncComponent "Reporter" handled in the control thread.
2018-12-31T20:48:37.928Z,1546289317.928 [ComponentRegistry](DEBUG): Component "NavChartDb" handled in its own thread.
2018-12-31T20:48:37.929Z,1546289317.929 [NavChartDb ThreadHandler](DEBUG): Created PCaller Thread at 40A684E0
2018-12-31T20:48:37.929Z,1546289317.929 [NavChartDb ThreadHandler](INFO): Protected caller Thread ID is 6790
2018-12-31T20:48:37.934Z,1546289317.934 [Supervisor](INFO): Main Thread ID is 6578
2018-12-31T20:48:37.934Z,1546289317.934 [Supervisor](DEBUG): Running supervisor.
2018-12-31T20:48:37.934Z,1546289317.934 [CommandLine ThreadHandler](INFO): Handler Thread ID is 6791
2018-12-31T20:48:37.937Z,1546289317.937 [controlThread ThreadHandler](INFO): Handler Thread ID is 6792
2018-12-31T20:48:37.937Z,1546289317.937 [controlThread](DEBUG): Initializing ControlThread
2018-12-31T20:48:37.938Z,1546289317.938 [DepthRateCalculator](DEBUG): Initializing DepthRateCalculator.
2018-12-31T20:48:37.939Z,1546289317.939 [PitchRateCalculator](DEBUG): Initializing PitchRateCalculator.
2018-12-31T20:48:37.939Z,1546289317.939 [SpeedCalculator](DEBUG): Initializing SpeedCalculator.
2018-12-31T20:48:37.939Z,1546289317.939 [TempGradientCalculator](DEBUG): Initializing TempGradientCalculator.
2018-12-31T20:48:37.940Z,1546289317.940 [YawRateCalculator](DEBUG): Initializing YawRateCalculator.
2018-12-31T20:48:37.940Z,1546289317.940 [ElevatorOffsetCalculator](DEBUG): Initializing ElevatorOffsetCalculator.
2018-12-31T20:48:37.943Z,1546289317.943 [SBIT](INFO): Initialize SBIT Component.
2018-12-31T20:48:37.944Z,1546289317.944 [SBIT](IMPORTANT): git: 2018-12-19
2018-12-31T20:48:37.944Z,1546289317.944 [SBIT](INFO): git hash: f0e90a53519ed2f91f39351bc58b7b0f50855756
2018-12-31T20:48:37.945Z,1546289317.945 [SBIT](IMPORTANT): Kernel Release: 2.6.27.8
2018-12-31T20:48:37.946Z,1546289317.946 [SBIT](INFO): Kernel Reporting Different Version From Configuration.
Kernel Expected: #2 PREEMPT Thu Jan 11 20:13:48 PST 2018
Kernel Reported: #1 PREEMPT Tue Dec 18 21:19:28 PST 2018
2018-12-31T20:48:37.947Z,1546289317.947 [SBIT](INFO): Beginning SBIT in 24.000000 seconds.
2018-12-31T20:48:37.947Z,1546289317.947 [IBIT](INFO): Initialize IBIT Component.
2018-12-31T20:48:37.948Z,1546289317.948 [CBIT](DEBUG): Initialize CBIT Component.
2018-12-31T20:48:37.949Z,1546289317.949 [logger ThreadHandler](INFO): Handler Thread ID is 6793
2018-12-31T20:48:37.962Z,1546289317.962 [CBIT](DEBUG): Initialized mux pins.
2018-12-31T20:48:37.962Z,1546289317.962 [CBIT](DEBUG): Initializing the watchdog timer.
2018-12-31T20:48:37.967Z,1546289317.967 [Radio_Surface ThreadHandler](INFO): Handler Thread ID is 6794
2018-12-31T20:48:37.973Z,1546289317.973 [Radio_Surface](INFO): Powering up
2018-12-31T20:48:37.983Z,1546289317.983 [Rowe_600LCM ThreadHandler](INFO): Handler Thread ID is 6795
2018-12-31T20:48:37.983Z,1546289317.983 [Rowe_600LCM](INFO): Initializing
2018-12-31T20:48:37.984Z,1546289317.984 [Rowe_600LCM](INFO): Checking LCM
2018-12-31T20:48:37.990Z,1546289317.990 [CBIT](INFO): Last reboot was NOT due to watchdog timer.
2018-12-31T20:48:37.990Z,1546289317.990 [CBIT](DEBUG): Initializing heartbeat.
2018-12-31T20:48:37.993Z,1546289317.993 [Rowe_600LCM](INFO): LCM OK
2018-12-31T20:48:37.993Z,1546289317.993 [Rowe_600LCM](INFO): Powering up
2018-12-31T20:48:37.999Z,1546289317.999 [CTD_Seabird ThreadHandler](INFO): Handler Thread ID is 6796
2018-12-31T20:48:37.000Z,1546289318.000 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T20:48:38.003Z,1546289318.003 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T20:48:38.004Z,1546289318.004 [WetLabsBB2FL ThreadHandler](INFO): Handler Thread ID is 6798
2018-12-31T20:48:38.005Z,1546289318.005 [WetLabsBB2FL](INFO): Powering down
2018-12-31T20:48:38.059Z,1546289318.059 [NavChartDb ThreadHandler](INFO): Handler Thread ID is 6799
2018-12-31T20:48:38.062Z,1546289318.062 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US1WC07M.000
2018-12-31T20:48:38.062Z,1546289318.062 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US1WC07M.000
2018-12-31T20:48:38.063Z,1546289318.063 [CBIT](DEBUG): Deactivating GF circuits.
2018-12-31T20:48:38.063Z,1546289318.063 [CBIT](DEBUG): Deactivating emergency mode.
2018-12-31T20:48:38.063Z,1546289318.063 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US2WC11M.000
2018-12-31T20:48:38.063Z,1546289318.063 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US2WC11M.000
2018-12-31T20:48:38.063Z,1546289318.063 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US3CA52M.000
2018-12-31T20:48:38.064Z,1546289318.064 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US3CA52M.000
2018-12-31T20:48:38.064Z,1546289318.064 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US4CA60M.000
2018-12-31T20:48:38.064Z,1546289318.064 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US4CA60M.000
2018-12-31T20:48:38.064Z,1546289318.064 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA50M.000
2018-12-31T20:48:38.064Z,1546289318.064 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA50M.000
2018-12-31T20:48:38.065Z,1546289318.065 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA61M.000
2018-12-31T20:48:38.065Z,1546289318.065 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA61M.000
2018-12-31T20:48:38.065Z,1546289318.065 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA62M.000
2018-12-31T20:48:38.065Z,1546289318.065 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA62M.000
2018-12-31T20:48:38.065Z,1546289318.065 [NavChartDb](INFO): Looking for Electronic Nav Chart file at: Resources/ElectronicNavigationCharts/US5CA83M.000
2018-12-31T20:48:38.065Z,1546289318.065 [NavChartDb](INFO): Already Loaded Electronic Nav Chart data from US5CA83M.000
2018-12-31T20:48:38.103Z,1546289318.103 [VerticalControl](DEBUG): Initialize VerticalControlComponent.
2018-12-31T20:48:38.104Z,1546289318.104 [HorizontalControl](DEBUG): Initialize HorizontalControlComponent.
2018-12-31T20:48:38.105Z,1546289318.105 [SpeedControl](DEBUG): Initialize SpeedControlComponent.
2018-12-31T20:48:38.105Z,1546289318.105 [LoopControl](DEBUG): Initialize LoopControlComponent.
2018-12-31T20:48:38.107Z,1546289318.107 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-31T20:48:38.108Z,1546289318.108 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-31T20:48:38.108Z,1546289318.108 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-31T20:48:38.109Z,1546289318.109 [NavChart](DEBUG): Initialize NavChart Navigation.
2018-12-31T20:48:38.109Z,1546289318.109 [UniversalFixResidualReporter](DEBUG): Initializing UniversalFixResidualReporter component.
2018-12-31T20:48:38.110Z,1546289318.110 [MissionManager](INFO): Loading Mission: Missions/Startup.xml
2018-12-31T20:48:38.121Z,1546289318.121 [Startup:A.GoToSurface](DEBUG): Construct GoToSurface.
2018-12-31T20:48:38.176Z,1546289318.176 [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>


2018-12-31T20:48:38.177Z,1546289318.177 [MissionManager](INFO): Loading Mission: Missions/Default.xml
2018-12-31T20:48:38.271Z,1546289318.271 [MissionManager](INFO): DefineArg Default.ElapsedSinceDefaultStarted = 0.000000 min
2018-12-31T20:48:38.272Z,1546289318.272 [Default:A.Wait](DEBUG): Construct Wait.
2018-12-31T20:48:38.273Z,1546289318.273 [Default:B.GoToSurface](DEBUG): Construct GoToSurface.
2018-12-31T20:48:38.340Z,1546289318.340 [Default:CheckIn:Read_Iridium:A_Timeout:A.Execute](DEBUG): Construct Execute.
2018-12-31T20:48:38.343Z,1546289318.343 [Default:CheckIn:C.Wait](DEBUG): Construct Wait.
2018-12-31T20:48:38.377Z,1546289318.377 [Default:E.Execute](DEBUG): Construct Execute.
2018-12-31T20:48:38.381Z,1546289318.381 [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>


2018-12-31T20:48:38.386Z,1546289318.386 [controlThread](DEBUG): Component order: CycleStarter,AcousticModem_Benthos_ATM900,DataOverHttps,Depth_Keller,NAL9602,Onboard,PNI_TCM,BPC1,ESPComponent,PAR_Licor,Depth_Keller,PAR_Licor,DepthRateCalculator,PitchRateCalculator,SpeedCalculator,TempGradientCalculator,YawRateCalculator,ElevatorOffsetCalculator,DeadReckonUsingSpeedCalculator,NavChart,UniversalFixResidualReporter,MissionManager,VerticalControl,HorizontalControl,SpeedControl,LoopControl,BuoyancyServo,ElevatorServo,MassServo,RudderServo,ThrusterServo,SBIT,IBIT,CBIT,Reporter,LogSplitter,
2018-12-31T20:48:38.435Z,1546289318.435 [AcousticModem_Benthos_ATM900](INFO): Powering up
2018-12-31T20:48:38.435Z,1546289318.435 [AcousticModem_Benthos_ATM900](DEBUG): Initializing AcousticModem_Benthos_ATM900.
2018-12-31T20:48:38.475Z,1546289318.475 [DataOverHttps](DEBUG): dashIP=134.89.2.23 starts with a digit so assuming it is a numeric IP
2018-12-31T20:48:38.744Z,1546289318.744 [ESPComponent](INFO): powering down ESP
2018-12-31T20:48:39.459Z,1546289319.459 [BuoyancyServo](DEBUG): Initializing EZServoServo.
2018-12-31T20:48:39.471Z,1546289319.471 [BuoyancyServo](DEBUG): Initializing BuoyancyServo.
2018-12-31T20:48:39.511Z,1546289319.511 [ElevatorServo](DEBUG): Initializing EZServoServo.
2018-12-31T20:48:39.523Z,1546289319.523 [ElevatorServo](DEBUG): Initializing ElevatorServo.
2018-12-31T20:48:39.540Z,1546289319.540 [MassServo](DEBUG): Initializing EZServoServo.
2018-12-31T20:48:39.551Z,1546289319.551 [MassServo](DEBUG): Initializing MassServo.
2018-12-31T20:48:39.564Z,1546289319.564 [RudderServo](DEBUG): Initializing EZServoServo.
2018-12-31T20:48:39.571Z,1546289319.571 [RudderServo](DEBUG): Initializing RudderServo.
2018-12-31T20:48:39.596Z,1546289319.596 [ThrusterServo](DEBUG): Initializing EZServoServo.
2018-12-31T20:48:39.603Z,1546289319.603 [ThrusterServo](DEBUG): Initializing ThrusterServo.
2018-12-31T20:48:42.381Z,1546289322.381 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-12-31T20:48:42.501Z,1546289322.501 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-12-31T20:48:42.559Z,1546289322.559 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-12-31T20:48:42.560Z,1546289322.560 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-12-31T20:48:42.561Z,1546289322.561 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-12-31T20:48:45.778Z,1546289325.778 [AcousticModem_Benthos_ATM900](DEBUG): 
2018-12-31T20:48:46.195Z,1546289326.195 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T20:48:46.195Z,1546289326.195 [PNI_TCM] Data Fault, FailCount= 1
2018-12-31T20:48:46.195Z,1546289326.195 [PNI_TCM](ERROR): Data Fault
2018-12-31T20:48:46.280Z,1546289326.280 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T20:48:46.594Z,1546289326.594 [PNI_TCM](INFO): Powering down
2018-12-31T20:48:47.377Z,1546289327.377 [AcousticModem_Benthos_ATM900](DEBUG): Teledyne Benthos ATM-900 Series OEM w/burn wire
2018-12-31T20:48:47.378Z,1546289327.378 [AcousticModem_Benthos_ATM900](DEBUG): MF Frequency Band
2018-12-31T20:48:47.378Z,1546289327.378 [AcousticModem_Benthos_ATM900](DEBUG): Standard version 8.6.3
2018-12-31T20:48:47.379Z,1546289327.379 [AcousticModem_Benthos_ATM900](DEBUG): Nov 13 2018 14:43:27 
2018-12-31T20:48:47.776Z,1546289327.776 [AcousticModem_Benthos_ATM900](DEBUG): WARNING: battery low
2018-12-31T20:48:47.867Z,1546289327.867 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T20:48:47.867Z,1546289327.867 [PNI_TCM] No Fault, FailCount= 1
2018-12-31T20:48:48.288Z,1546289328.288 [CBIT](CRITICAL): Environmental Failure. Press:14.704290 PSI. Humidity:16%. Temp:23 C. ABORTING MISSION
2018-12-31T20:48:48.288Z,1546289328.288 [Supervisor](INFO): Stop Mission called by CBIT::monitorEnvironmentals
2018-12-31T20:48:48.576Z,1546289328.576 [AcousticModem_Benthos_ATM900](INFO): entering command mode
2018-12-31T20:48:48.682Z,1546289328.682 [CommandLine](FAULT): Scheduling is paused
2018-12-31T20:48:48.682Z,1546289328.682 [CBIT](INFO): Critical error at 20181231T204848
2018-12-31T20:48:48.979Z,1546289328.979 [AcousticModem_Benthos_ATM900](DEBUG): checking for command mode acknowledgment
2018-12-31T20:48:48.979Z,1546289328.979 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 1: user:1>
2018-12-31T20:48:48.980Z,1546289328.980 [AcousticModem_Benthos_ATM900](INFO): command mode acknowledged
2018-12-31T20:48:49.376Z,1546289329.376 [AcousticModem_Benthos_ATM900](INFO): setting local address to 3
2018-12-31T20:48:49.776Z,1546289329.776 [AcousticModem_Benthos_ATM900](DEBUG): checking for local address setting acknowledgment
2018-12-31T20:48:49.777Z,1546289329.777 [AcousticModem_Benthos_ATM900](INFO): set local address to 3
2018-12-31T20:48:50.176Z,1546289330.176 [AcousticModem_Benthos_ATM900](DEBUG): read user prompt 2: user:2>
2018-12-31T20:48:52.042Z,1546289332.042 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T20:48:52.042Z,1546289332.042 [CTD_Seabird] Communications Fault, FailCount= 1
2018-12-31T20:48:52.042Z,1546289332.042 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T20:48:52.261Z,1546289332.261 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-31T20:48:52.447Z,1546289332.447 [CTD_Seabird](INFO): Powering down
2018-12-31T20:48:54.646Z,1546289334.646 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-31T20:48:54.646Z,1546289334.646 [CTD_Seabird] No Fault, FailCount= 1
2018-12-31T20:48:55.311Z,1546289335.311 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T20:48:55.312Z,1546289335.312 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T20:48:55.395Z,1546289335.395 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T20:48:55.395Z,1546289335.395 [PNI_TCM] Data Fault, FailCount= 2
2018-12-31T20:48:55.395Z,1546289335.395 [PNI_TCM](ERROR): Data Fault
2018-12-31T20:48:55.495Z,1546289335.495 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T20:48:55.795Z,1546289335.795 [PNI_TCM](INFO): Powering down
2018-12-31T20:48:57.119Z,1546289337.119 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T20:48:57.119Z,1546289337.119 [PNI_TCM] No Fault, FailCount= 2
2018-12-31T20:49:02.653Z,1546289342.653 [SBIT](IMPORTANT): Beginning Startup BIT
2018-12-31T20:49:02.658Z,1546289342.658 [CBIT](IMPORTANT): Beginning ground fault scan
2018-12-31T20:49:04.580Z,1546289344.580 [NAL9602](INFO): Powering up NAL9602
2018-12-31T20:49:04.599Z,1546289344.599 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T20:49:04.599Z,1546289344.599 [PNI_TCM] Data Fault, FailCount= 3
2018-12-31T20:49:04.599Z,1546289344.599 [PNI_TCM](ERROR): Data Fault
2018-12-31T20:49:04.779Z,1546289344.779 [CommandLine](IMPORTANT): got command show best depth
2018-12-31T20:49:04.780Z,1546289344.780 [CommandLine](IMPORTANT): depth best is Depth_Keller.depth
2018-12-31T20:49:05.079Z,1546289345.079 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T20:49:05.118Z,1546289345.118 [PNI_TCM](INFO): Powering down
2018-12-31T20:49:06.472Z,1546289346.472 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T20:49:06.472Z,1546289346.472 [PNI_TCM] No Fault, FailCount= 3
2018-12-31T20:49:09.360Z,1546289349.360 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T20:49:09.360Z,1546289349.360 [CTD_Seabird] Communications Fault, FailCount= 2
2018-12-31T20:49:09.360Z,1546289349.360 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T20:49:09.676Z,1546289349.676 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-31T20:49:09.762Z,1546289349.762 [CTD_Seabird](INFO): Powering down
2018-12-31T20:49:11.964Z,1546289351.964 [CommandLine](IMPORTANT): got command show best depth
2018-12-31T20:49:11.964Z,1546289351.964 [CommandLine](IMPORTANT): depth best is Depth_Keller.depth
2018-12-31T20:49:12.016Z,1546289352.016 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-31T20:49:12.016Z,1546289352.016 [CTD_Seabird] No Fault, FailCount= 2
2018-12-31T20:49:12.715Z,1546289352.715 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T20:49:12.716Z,1546289352.716 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T20:49:13.591Z,1546289353.591 [CBIT](IMPORTANT): No ground fault detected
mA:
CHAN A0 (Batt): -0.007073
CHAN A1 (24V): -0.011481
CHAN A2 (12V): -0.004884
CHAN A3 (5V): -0.002748
CHAN B0 (3.3V): -0.000661
CHAN B1 (3.15aV): -0.001497
CHAN B2 (3.15bV): -0.001212
CHAN B3 (GND): 0.000515
OPEN: 0.003993
Full Scale Calc: 4.765 mA, -1.589 mA
2018-12-31T20:49:13.906Z,1546289353.906 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T20:49:13.906Z,1546289353.906 [PNI_TCM] Data Fault, FailCount= 4
2018-12-31T20:49:13.906Z,1546289353.906 [PNI_TCM](ERROR): Data Fault
2018-12-31T20:49:13.992Z,1546289353.992 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T20:49:14.306Z,1546289354.306 [PNI_TCM](INFO): Powering down
2018-12-31T20:49:15.496Z,1546289355.496 [NAL9602](INFO): NAL9602 initialized
2018-12-31T20:49:15.608Z,1546289355.608 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T20:49:15.608Z,1546289355.608 [PNI_TCM] No Fault, FailCount= 4
2018-12-31T20:49:17.264Z,1546289357.264 [CommandLine](IMPORTANT): got command show best depth
2018-12-31T20:49:17.264Z,1546289357.264 [CommandLine](IMPORTANT): depth best is Depth_Keller.depth
2018-12-31T20:49:22.923Z,1546289362.923 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T20:49:22.923Z,1546289362.923 [PNI_TCM] Data Fault, FailCount= 5
2018-12-31T20:49:22.923Z,1546289362.923 [PNI_TCM](ERROR): Data Fault
2018-12-31T20:49:23.052Z,1546289363.052 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T20:49:23.052Z,1546289363.052 [CBIT](CRITICAL): Data Fault in component: PNI_TCM
2018-12-31T20:49:23.312Z,1546289363.312 [PNI_TCM](INFO): Powering down
2018-12-31T20:49:23.657Z,1546289363.657 [CBIT](INFO): Critical error at 20181231T204923
2018-12-31T20:49:26.770Z,1546289366.770 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T20:49:26.770Z,1546289366.770 [CTD_Seabird] Communications Fault, FailCount= 3
2018-12-31T20:49:26.770Z,1546289366.770 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T20:49:27.044Z,1546289367.044 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-31T20:49:27.044Z,1546289367.044 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2018-12-31T20:49:27.174Z,1546289367.174 [CTD_Seabird](INFO): Powering down
2018-12-31T20:49:28.959Z,1546289368.959 [CommandLine](IMPORTANT): got command get depth
2018-12-31T20:49:28.960Z,1546289368.960 [CommandLine](IMPORTANT): depth 0.046374 m
2018-12-31T20:49:45.486Z,1546289385.486 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2018-12-31T20:49:56.678Z,1546289396.678 [SBIT](IMPORTANT): SBIT PASSED
2018-12-31T20:49:56.708Z,1546289396.708 [CommandLine](IMPORTANT): got command configSet list
2018-12-31T20:49:56.708Z,1546289396.708 [CommandLine](IMPORTANT): Listing configuration overrides from Data/persisted.cfg
2018-12-31T20:49:56.709Z,1546289396.709 [CommandLine](IMPORTANT): Aanderaa_O2.loadAtStartup=0 bool;

2018-12-31T20:49:56.709Z,1546289396.709 [CommandLine](IMPORTANT): DropWeight.loadAtStartup=0 bool;

2018-12-31T20:49:56.709Z,1546289396.709 [CommandLine](IMPORTANT): PAR_Licor.loadAtStartup=1 bool;

2018-12-31T20:49:57.064Z,1546289397.064 [MissionManager](IMPORTANT): Started mission Startup
2018-12-31T20:49:57.065Z,1546289397.065 [Startup] Running Loop=1
2018-12-31T20:49:57.065Z,1546289397.065 [Startup](DEBUG): Aggregate::initialize Startup
2018-12-31T20:49:57.065Z,1546289397.065 [Startup:A.GoToSurface] Running Loop=1
2018-12-31T20:49:57.065Z,1546289397.065 [Startup:A.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-12-31T20:49:57.066Z,1546289397.066 [Startup:A.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-12-31T20:49:57.099Z,1546289397.099 [Startup:A.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-12-31T20:49:57.099Z,1546289397.099 [Startup:A.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-12-31T20:49:57.100Z,1546289397.100 [Startup:A.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-12-31T20:49:57.100Z,1546289397.100 [Startup:A.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-12-31T20:49:57.106Z,1546289397.106 [Startup:StartupSatComms] Running Loop=1
2018-12-31T20:49:57.106Z,1546289397.106 [Startup:StartupSatComms](DEBUG): Aggregate::initialize Startup:StartupSatComms
2018-12-31T20:49:57.106Z,1546289397.106 [Startup:StartupSatComms:A] Running Loop=1
2018-12-31T20:49:57.516Z,1546289397.516 [Startup:StartupSatComms:A](DEBUG): Initialize ReadDataComponent to sense latitude_fix
2018-12-31T20:50:22.709Z,1546289422.709 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2018-12-31T20:50:38.230Z,1546289438.230 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-12-31T20:50:38.230Z,1546289438.230 [Rowe_600LCM] Communications Fault, FailCount= 1
2018-12-31T20:50:38.230Z,1546289438.230 [Rowe_600LCM](ERROR): Communications Fault
2018-12-31T20:50:38.284Z,1546289438.284 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-12-31T20:50:38.284Z,1546289438.284 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 1
2018-12-31T20:50:38.284Z,1546289438.284 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-12-31T20:50:38.317Z,1546289438.317 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-12-31T20:50:38.318Z,1546289438.318 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-12-31T20:50:38.634Z,1546289438.634 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-12-31T20:50:38.762Z,1546289438.762 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-12-31T20:50:38.762Z,1546289438.762 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 1
2018-12-31T20:50:38.811Z,1546289438.811 [Rowe_600LCM](INFO): Powering down
2018-12-31T20:50:39.063Z,1546289439.063 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-31T20:50:39.064Z,1546289439.064 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-31T20:50:39.064Z,1546289439.064 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-31T20:50:40.295Z,1546289440.295 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-12-31T20:50:40.295Z,1546289440.295 [Rowe_600LCM] No Fault, FailCount= 1
2018-12-31T20:50:40.426Z,1546289440.426 [Rowe_600LCM](INFO): Initializing
2018-12-31T20:50:40.427Z,1546289440.427 [Rowe_600LCM](INFO): Checking LCM
2018-12-31T20:50:40.427Z,1546289440.427 [Rowe_600LCM](INFO): LCM OK
2018-12-31T20:50:40.427Z,1546289440.427 [Rowe_600LCM](INFO): Powering up
2018-12-31T20:50:44.552Z,1546289444.552 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-12-31T20:50:44.614Z,1546289444.614 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-12-31T20:50:44.615Z,1546289444.615 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-12-31T20:50:44.615Z,1546289444.615 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-12-31T20:50:44.616Z,1546289444.616 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-12-31T20:50:57.489Z,1546289457.489 [Startup:StartupSatComms:A](INFO): Timed out from 2018-12-31T20:49:57.1Z
2018-12-31T20:50:57.489Z,1546289457.489 [Startup:StartupSatComms:A] Stopped
2018-12-31T20:50:57.489Z,1546289457.489 [Startup:StartupSatComms:B] Running Loop=1
2018-12-31T20:50:57.892Z,1546289457.892 [Startup:StartupSatComms:B](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-12-31T20:51:27.155Z,1546289487.155 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-12-31T20:51:37.115Z,1546289497.115 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2018-12-31T20:51:47.885Z,1546289507.885 [DataOverHttps](INFO): setting available, lastComms_.elapsed()=0.004014
2018-12-31T20:51:52.704Z,1546289512.704 [DataOverHttps](INFO): Sending 123 bytes from file Logs/20181214T220706/Courier0028.lzma
2018-12-31T20:51:53.514Z,1546289513.514 [DataOverHttps](INFO): Moved sent file to Logs/20181214T220706/Courier0028.lzma.bak
2018-12-31T20:51:53.514Z,1546289513.514 [DataOverHttps](INFO): SBD MOMSN=9127496
2018-12-31T20:51:58.241Z,1546289518.241 [Startup:StartupSatComms:B](INFO): Timed out from 2018-12-31T20:50:57.5Z
2018-12-31T20:51:58.241Z,1546289518.241 [Startup:StartupSatComms:B] Stopped
2018-12-31T20:51:58.241Z,1546289518.241 [Startup:StartupSatComms](INFO): Completed Startup:StartupSatComms
2018-12-31T20:51:58.241Z,1546289518.241 [Startup:StartupSatComms] Stopped
2018-12-31T20:51:58.242Z,1546289518.242 [Startup:StartupSatComms](DEBUG): Aggregate::uninitialize Startup:StartupSatComms
2018-12-31T20:51:58.242Z,1546289518.242 [Startup](INFO): Completed Startup
2018-12-31T20:51:58.243Z,1546289518.243 [MissionManager](INFO): Startup is completed.
2018-12-31T20:51:58.243Z,1546289518.243 [MissionManager](INFO): Uninitializing Mission Startup
2018-12-31T20:51:58.243Z,1546289518.243 [Startup] Stopped
2018-12-31T20:51:58.243Z,1546289518.243 [Startup](DEBUG): Aggregate::uninitialize Startup
2018-12-31T20:51:58.243Z,1546289518.243 [Startup:A.GoToSurface] Stopped
2018-12-31T20:51:58.243Z,1546289518.243 [Startup:A.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-12-31T20:51:58.256Z,1546289518.256 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-31T20:51:58.256Z,1546289518.256 [CTD_Seabird] No Fault, FailCount= 3
2018-12-31T20:51:58.432Z,1546289518.432 [MissionManager](IMPORTANT): Started mission Default
2018-12-31T20:51:58.432Z,1546289518.432 [Default] Running Loop=1
2018-12-31T20:51:58.432Z,1546289518.432 [Default](DEBUG): Aggregate::initialize Default
2018-12-31T20:51:58.432Z,1546289518.432 [Default:B.GoToSurface] Running Loop=1
2018-12-31T20:51:58.432Z,1546289518.432 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2018-12-31T20:51:58.433Z,1546289518.433 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s.
2018-12-31T20:51:58.433Z,1546289518.433 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees.
2018-12-31T20:51:58.433Z,1546289518.433 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s.
2018-12-31T20:51:58.434Z,1546289518.434 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds.
2018-12-31T20:51:58.434Z,1546289518.434 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds.
2018-12-31T20:51:58.434Z,1546289518.434 [Default:A.Wait] Running Loop=1
2018-12-31T20:51:58.434Z,1546289518.434 [Default:A.Wait](DEBUG): Initialize Wait Component.
2018-12-31T20:51:58.451Z,1546289518.451 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T20:51:58.452Z,1546289518.452 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T20:52:08.308Z,1546289528.308 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181218T004555/Courier0000.lzma
2018-12-31T20:52:09.103Z,1546289529.103 [DataOverHttps](INFO): Moved sent file to Logs/20181218T004555/Courier0000.lzma.bak
2018-12-31T20:52:09.103Z,1546289529.103 [DataOverHttps](INFO): SBD MOMSN=9127501
2018-12-31T20:52:11.545Z,1546289531.545 [Default:A.Wait](INFO): Done Waiting.
2018-12-31T20:52:11.545Z,1546289531.545 [Default:A.Wait] Stopped
2018-12-31T20:52:11.545Z,1546289531.545 [Default:A.Wait](DEBUG): Uninitialize Wait Component.
2018-12-31T20:52:11.949Z,1546289531.949 [Default:CheckIn] Running Loop=1
2018-12-31T20:52:11.949Z,1546289531.949 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn
2018-12-31T20:52:11.950Z,1546289531.950 [Default:CheckIn:Read_GPS] Running Loop=1
2018-12-31T20:52:12.337Z,1546289532.337 [Default:CheckIn:Read_GPS](DEBUG): Initialize ReadDataComponent to sense time_fix
2018-12-31T20:52:12.502Z,1546289532.502 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T20:52:12.502Z,1546289532.502 [CTD_Seabird] Communications Fault, FailCount= 1
2018-12-31T20:52:12.502Z,1546289532.502 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T20:52:12.750Z,1546289532.750 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-31T20:52:12.906Z,1546289532.906 [CTD_Seabird](INFO): Powering down
2018-12-31T20:52:13.949Z,1546289533.949 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2018-12-31T20:52:15.148Z,1546289535.148 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-31T20:52:15.148Z,1546289535.148 [CTD_Seabird] No Fault, FailCount= 1
2018-12-31T20:52:15.855Z,1546289535.855 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T20:52:15.856Z,1546289535.856 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T20:52:29.907Z,1546289549.907 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T20:52:29.907Z,1546289549.907 [CTD_Seabird] Communications Fault, FailCount= 2
2018-12-31T20:52:29.907Z,1546289549.907 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T20:52:29.989Z,1546289549.989 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-31T20:52:30.311Z,1546289550.311 [CTD_Seabird](INFO): Powering down
2018-12-31T20:52:32.364Z,1546289552.364 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-31T20:52:32.364Z,1546289552.364 [CTD_Seabird] No Fault, FailCount= 2
2018-12-31T20:52:33.259Z,1546289553.259 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T20:52:33.261Z,1546289553.261 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T20:52:39.182Z,1546289559.182 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-12-31T20:52:39.190Z,1546289559.190 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 2
2018-12-31T20:52:39.190Z,1546289559.190 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-12-31T20:52:39.231Z,1546289559.231 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-12-31T20:52:39.591Z,1546289559.591 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-12-31T20:52:39.591Z,1546289559.591 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 2
2018-12-31T20:52:39.986Z,1546289559.986 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-31T20:52:39.994Z,1546289559.994 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-31T20:52:39.995Z,1546289559.995 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-31T20:52:40.838Z,1546289560.838 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-12-31T20:52:40.838Z,1546289560.838 [Rowe_600LCM] Communications Fault, FailCount= 2
2018-12-31T20:52:40.838Z,1546289560.838 [Rowe_600LCM](ERROR): Communications Fault
2018-12-31T20:52:41.163Z,1546289561.163 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-12-31T20:52:41.242Z,1546289561.242 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-12-31T20:52:41.398Z,1546289561.398 [Rowe_600LCM](INFO): Powering down
2018-12-31T20:52:42.751Z,1546289562.751 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-12-31T20:52:42.751Z,1546289562.751 [Rowe_600LCM] No Fault, FailCount= 2
2018-12-31T20:52:43.014Z,1546289563.014 [Rowe_600LCM](INFO): Initializing
2018-12-31T20:52:43.015Z,1546289563.015 [Rowe_600LCM](INFO): Checking LCM
2018-12-31T20:52:43.015Z,1546289563.015 [Rowe_600LCM](INFO): LCM OK
2018-12-31T20:52:43.015Z,1546289563.015 [Rowe_600LCM](INFO): Powering up
2018-12-31T20:52:47.229Z,1546289567.229 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-12-31T20:52:47.297Z,1546289567.297 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-12-31T20:52:47.298Z,1546289567.298 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-12-31T20:52:47.299Z,1546289567.299 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-12-31T20:52:47.300Z,1546289567.300 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-12-31T20:52:47.310Z,1546289567.310 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T20:52:47.311Z,1546289567.311 [CTD_Seabird] Communications Fault, FailCount= 3
2018-12-31T20:52:47.311Z,1546289567.311 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T20:52:47.568Z,1546289567.568 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-31T20:52:47.569Z,1546289567.569 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2018-12-31T20:52:47.714Z,1546289567.714 [CTD_Seabird](INFO): Powering down
2018-12-31T20:53:04.402Z,1546289584.402 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2018-12-31T20:53:16.429Z,1546289596.429 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-12-31T20:53:43.213Z,1546289623.213 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-12-31T20:54:19.096Z,1546289659.096 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session.
2018-12-31T20:54:23.155Z,1546289663.155 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T20:54:23.155Z,1546289663.155 [PNI_TCM] No Fault, FailCount= 5
2018-12-31T20:54:23.589Z,1546289663.589 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-12-31T20:54:30.719Z,1546289670.719 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T20:54:30.720Z,1546289670.720 [PNI_TCM] Data Fault, FailCount= 1
2018-12-31T20:54:30.720Z,1546289670.720 [PNI_TCM](ERROR): Data Fault
2018-12-31T20:54:30.784Z,1546289670.784 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2018-12-31T20:54:30.804Z,1546289670.804 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T20:54:31.119Z,1546289671.119 [PNI_TCM](INFO): Powering down
2018-12-31T20:54:32.355Z,1546289672.355 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T20:54:32.355Z,1546289672.355 [PNI_TCM] No Fault, FailCount= 1
2018-12-31T20:54:36.378Z,1546289676.378 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-12-31T20:54:39.918Z,1546289679.918 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T20:54:39.918Z,1546289679.918 [PNI_TCM] Data Fault, FailCount= 2
2018-12-31T20:54:39.918Z,1546289679.918 [PNI_TCM](ERROR): Data Fault
2018-12-31T20:54:39.943Z,1546289679.943 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T20:54:40.310Z,1546289680.310 [PNI_TCM](INFO): Powering down
2018-12-31T20:54:40.420Z,1546289680.420 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-12-31T20:54:40.420Z,1546289680.420 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 3
2018-12-31T20:54:40.421Z,1546289680.421 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-12-31T20:54:40.433Z,1546289680.433 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-12-31T20:54:40.755Z,1546289680.755 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-12-31T20:54:40.755Z,1546289680.755 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 3
2018-12-31T20:54:41.139Z,1546289681.139 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-31T20:54:41.139Z,1546289681.139 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-31T20:54:41.139Z,1546289681.139 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-31T20:54:41.552Z,1546289681.552 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T20:54:41.552Z,1546289681.552 [PNI_TCM] No Fault, FailCount= 2
2018-12-31T20:54:43.082Z,1546289683.082 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-12-31T20:54:43.082Z,1546289683.082 [Rowe_600LCM] Communications Fault, FailCount= 3
2018-12-31T20:54:43.082Z,1546289683.082 [Rowe_600LCM](ERROR): Communications Fault
2018-12-31T20:54:43.168Z,1546289683.168 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-12-31T20:54:43.495Z,1546289683.495 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-12-31T20:54:43.663Z,1546289683.663 [Rowe_600LCM](INFO): Powering down
2018-12-31T20:54:45.148Z,1546289685.148 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-12-31T20:54:45.148Z,1546289685.148 [Rowe_600LCM] No Fault, FailCount= 3
2018-12-31T20:54:45.278Z,1546289685.278 [Rowe_600LCM](INFO): Initializing
2018-12-31T20:54:45.279Z,1546289685.279 [Rowe_600LCM](INFO): Checking LCM
2018-12-31T20:54:45.279Z,1546289685.279 [Rowe_600LCM](INFO): LCM OK
2018-12-31T20:54:45.279Z,1546289685.279 [Rowe_600LCM](INFO): Powering up
2018-12-31T20:54:48.775Z,1546289688.775 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-12-31T20:54:49.115Z,1546289689.115 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T20:54:49.115Z,1546289689.115 [PNI_TCM] Data Fault, FailCount= 3
2018-12-31T20:54:49.115Z,1546289689.115 [PNI_TCM](ERROR): Data Fault
2018-12-31T20:54:49.186Z,1546289689.186 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T20:54:49.401Z,1546289689.401 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-12-31T20:54:49.465Z,1546289689.465 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-12-31T20:54:49.466Z,1546289689.466 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-12-31T20:54:49.467Z,1546289689.467 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-12-31T20:54:49.468Z,1546289689.468 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-12-31T20:54:49.537Z,1546289689.537 [PNI_TCM](INFO): Powering down
2018-12-31T20:54:50.755Z,1546289690.755 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T20:54:50.755Z,1546289690.755 [PNI_TCM] No Fault, FailCount= 3
2018-12-31T20:54:58.316Z,1546289698.316 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T20:54:58.316Z,1546289698.316 [PNI_TCM] Data Fault, FailCount= 4
2018-12-31T20:54:58.316Z,1546289698.316 [PNI_TCM](ERROR): Data Fault
2018-12-31T20:54:58.426Z,1546289698.426 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T20:54:58.721Z,1546289698.721 [PNI_TCM](INFO): Powering down
2018-12-31T20:54:59.956Z,1546289699.956 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T20:54:59.956Z,1546289699.956 [PNI_TCM] No Fault, FailCount= 4
2018-12-31T20:55:03.498Z,1546289703.498 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-12-31T20:55:09.565Z,1546289709.565 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T20:55:09.565Z,1546289709.565 [PNI_TCM] Data Fault, FailCount= 5
2018-12-31T20:55:09.565Z,1546289709.565 [PNI_TCM](ERROR): Data Fault
2018-12-31T20:55:09.625Z,1546289709.625 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T20:55:09.625Z,1546289709.625 [CBIT](CRITICAL): Data Fault in component: PNI_TCM
2018-12-31T20:55:09.961Z,1546289709.961 [PNI_TCM](INFO): Powering down
2018-12-31T20:55:09.985Z,1546289709.985 [CBIT](INFO): Critical error at 20181231T205509
2018-12-31T20:55:17.616Z,1546289717.616 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-31T20:55:17.616Z,1546289717.616 [CTD_Seabird] No Fault, FailCount= 3
2018-12-31T20:55:17.715Z,1546289717.715 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T20:55:17.716Z,1546289717.716 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T20:55:31.758Z,1546289731.758 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T20:55:31.758Z,1546289731.758 [CTD_Seabird] Communications Fault, FailCount= 1
2018-12-31T20:55:31.758Z,1546289731.758 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T20:55:31.993Z,1546289731.993 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-31T20:55:32.163Z,1546289732.163 [CTD_Seabird](INFO): Powering down
2018-12-31T20:55:34.388Z,1546289734.388 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-31T20:55:34.388Z,1546289734.388 [CTD_Seabird] No Fault, FailCount= 1
2018-12-31T20:55:35.107Z,1546289735.107 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T20:55:35.109Z,1546289735.109 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T20:55:49.163Z,1546289749.163 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T20:55:49.164Z,1546289749.164 [CTD_Seabird] Communications Fault, FailCount= 2
2018-12-31T20:55:49.165Z,1546289749.165 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T20:55:49.245Z,1546289749.245 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-31T20:55:49.567Z,1546289749.567 [CTD_Seabird](INFO): Powering down
2018-12-31T20:55:51.587Z,1546289751.587 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-31T20:55:51.588Z,1546289751.588 [CTD_Seabird] No Fault, FailCount= 2
2018-12-31T20:55:52.517Z,1546289752.517 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T20:55:52.519Z,1546289752.519 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T20:56:06.563Z,1546289766.563 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T20:56:06.563Z,1546289766.563 [CTD_Seabird] Communications Fault, FailCount= 3
2018-12-31T20:56:06.563Z,1546289766.563 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T20:56:06.684Z,1546289766.684 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-31T20:56:06.684Z,1546289766.684 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2018-12-31T20:56:06.966Z,1546289766.966 [CTD_Seabird](INFO): Powering down
2018-12-31T20:56:41.396Z,1546289801.396 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-12-31T20:56:41.396Z,1546289801.396 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 4
2018-12-31T20:56:41.396Z,1546289801.396 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-12-31T20:56:41.411Z,1546289801.411 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-12-31T20:56:41.791Z,1546289801.792 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-12-31T20:56:41.792Z,1546289801.792 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 4
2018-12-31T20:56:42.183Z,1546289802.183 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-31T20:56:42.183Z,1546289802.183 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-31T20:56:42.184Z,1546289802.184 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-31T20:56:45.770Z,1546289805.770 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-12-31T20:56:45.770Z,1546289805.770 [Rowe_600LCM] Communications Fault, FailCount= 4
2018-12-31T20:56:45.770Z,1546289805.770 [Rowe_600LCM](ERROR): Communications Fault
2018-12-31T20:56:45.846Z,1546289805.846 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-12-31T20:56:46.175Z,1546289806.175 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-12-31T20:56:46.321Z,1546289806.321 [Rowe_600LCM](INFO): Powering down
2018-12-31T20:56:47.849Z,1546289807.849 [CBIT](INFO): Clearing failed state for component Rowe_600LCM
2018-12-31T20:56:47.849Z,1546289807.849 [Rowe_600LCM] No Fault, FailCount= 4
2018-12-31T20:56:47.938Z,1546289807.938 [Rowe_600LCM](INFO): Initializing
2018-12-31T20:56:47.939Z,1546289807.939 [Rowe_600LCM](INFO): Checking LCM
2018-12-31T20:56:47.939Z,1546289807.939 [Rowe_600LCM](INFO): LCM OK
2018-12-31T20:56:47.939Z,1546289807.939 [Rowe_600LCM](INFO): Powering up
2018-12-31T20:56:52.062Z,1546289812.062 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of Rowe LCM interface
2018-12-31T20:56:52.129Z,1546289812.129 [Rowe_600LCM](INFO): Started Rowe LCM interface with command:nohup ./lrauv-framework/onboard/bin/roweadcp -ldir /mnt/mmc/LRAUV/Logs/latest/ -dev /dev/ttyB4 -b 9600 >& /dev/null &
2018-12-31T20:56:52.130Z,1546289812.130 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.bottom_track
2018-12-31T20:56:52.132Z,1546289812.132 [Rowe_600LCM](INFO): LCM subscribed to channel:Rowe_600LCM.adcp_dvl.vehicle_water_velocity
2018-12-31T20:56:52.132Z,1546289812.132 [Rowe_600LCM](INFO): LCM subscribed to channel:rowe_dvl.rowe
2018-12-31T20:57:12.229Z,1546289832.229 [Default:CheckIn:Read_GPS](INFO): Timed out from 2018-12-31T20:52:11.9Z
2018-12-31T20:57:12.230Z,1546289832.230 [Default:CheckIn:Read_GPS] Stopped
2018-12-31T20:57:12.230Z,1546289832.230 [Default:CheckIn:Read_Iridium] Running Loop=1
2018-12-31T20:57:12.646Z,1546289832.646 [Default:CheckIn:Read_Iridium](DEBUG): Initialize ReadDataComponent to sense platform_communications
2018-12-31T20:57:17.545Z,1546289837.545 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181218T004904/Courier0000.lzma
2018-12-31T20:57:17.654Z,1546289837.654 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2018-12-31T20:57:18.345Z,1546289838.345 [DataOverHttps](INFO): Moved sent file to Logs/20181218T004904/Courier0000.lzma.bak
2018-12-31T20:57:18.345Z,1546289838.345 [DataOverHttps](INFO): SBD MOMSN=9127505
2018-12-31T20:57:28.056Z,1546289848.056 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20181218T005100/Courier0000.lzma
2018-12-31T20:57:28.857Z,1546289848.857 [DataOverHttps](INFO): Moved sent file to Logs/20181218T005100/Courier0000.lzma.bak
2018-12-31T20:57:28.857Z,1546289848.857 [DataOverHttps](INFO): SBD MOMSN=9127509
2018-12-31T20:57:40.424Z,1546289860.424 [DataOverHttps](INFO): Sending 146 bytes from file Logs/20181218T052912/Courier0000.lzma
2018-12-31T20:57:41.217Z,1546289861.217 [DataOverHttps](INFO): Moved sent file to Logs/20181218T052912/Courier0000.lzma.bak
2018-12-31T20:57:41.217Z,1546289861.217 [DataOverHttps](INFO): SBD MOMSN=9127512
2018-12-31T20:57:50.868Z,1546289870.868 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181218T055742/Courier0000.lzma
2018-12-31T20:57:51.641Z,1546289871.641 [DataOverHttps](INFO): Moved sent file to Logs/20181218T055742/Courier0000.lzma.bak
2018-12-31T20:57:51.641Z,1546289871.641 [DataOverHttps](INFO): SBD MOMSN=9127516
2018-12-31T20:58:02.107Z,1546289882.107 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181218T060127/Courier0000.lzma
2018-12-31T20:58:02.885Z,1546289882.885 [DataOverHttps](INFO): Moved sent file to Logs/20181218T060127/Courier0000.lzma.bak
2018-12-31T20:58:02.885Z,1546289882.885 [DataOverHttps](INFO): SBD MOMSN=9127520
2018-12-31T20:58:12.581Z,1546289892.581 [DataOverHttps](INFO): Sending 252 bytes from file Logs/20181218T195241/Courier0000.lzma
2018-12-31T20:58:13.353Z,1546289893.353 [DataOverHttps](INFO): Moved sent file to Logs/20181218T195241/Courier0000.lzma.bak
2018-12-31T20:58:13.353Z,1546289893.353 [DataOverHttps](INFO): SBD MOMSN=9127524
2018-12-31T20:58:24.334Z,1546289904.334 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181218T201240/Courier0000.lzma
2018-12-31T20:58:25.133Z,1546289905.133 [DataOverHttps](INFO): Moved sent file to Logs/20181218T201240/Courier0000.lzma.bak
2018-12-31T20:58:25.133Z,1546289905.133 [DataOverHttps](INFO): SBD MOMSN=9127533
2018-12-31T20:58:34.771Z,1546289914.771 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181218T224056/Courier0000.lzma
2018-12-31T20:58:35.557Z,1546289915.557 [DataOverHttps](INFO): Moved sent file to Logs/20181218T224056/Courier0000.lzma.bak
2018-12-31T20:58:35.557Z,1546289915.557 [DataOverHttps](INFO): SBD MOMSN=9127537
2018-12-31T20:58:37.211Z,1546289917.211 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2018-12-31T20:58:37.230Z,1546289917.230 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-31T20:58:37.230Z,1546289917.230 [CTD_Seabird] No Fault, FailCount= 3
2018-12-31T20:58:37.399Z,1546289917.399 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T20:58:37.400Z,1546289917.400 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T20:58:45.711Z,1546289925.711 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-12-31T20:58:45.711Z,1546289925.711 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 5
2018-12-31T20:58:45.711Z,1546289925.711 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-12-31T20:58:45.736Z,1546289925.736 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-12-31T20:58:45.860Z,1546289925.860 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-12-31T20:58:45.860Z,1546289925.860 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 5
2018-12-31T20:58:46.190Z,1546289926.190 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-31T20:58:46.191Z,1546289926.191 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-31T20:58:46.191Z,1546289926.191 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-31T20:58:48.346Z,1546289928.346 [Rowe_600LCM](FAULT): Did not receive valid device response within the specified allowable sample time.
2018-12-31T20:58:48.346Z,1546289928.346 [Rowe_600LCM] Communications Fault, FailCount= 5
2018-12-31T20:58:48.346Z,1546289928.346 [Rowe_600LCM](ERROR): Communications Fault
2018-12-31T20:58:48.750Z,1546289928.750 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-12-31T20:58:48.910Z,1546289928.910 [Rowe_600LCM](INFO): Powering down
2018-12-31T20:58:50.628Z,1546289930.628 [CBIT](ERROR): Communications Fault in component: Rowe_600LCM
2018-12-31T20:58:50.629Z,1546289930.629 [CBIT](FAULT): Communications Fault in component: Rowe_600LCM
2018-12-31T20:58:50.643Z,1546289930.643 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181219T165752/Courier0000.lzma
2018-12-31T20:58:51.441Z,1546289931.441 [DataOverHttps](INFO): Moved sent file to Logs/20181219T165752/Courier0000.lzma.bak
2018-12-31T20:58:51.441Z,1546289931.441 [DataOverHttps](INFO): SBD MOMSN=9127541
2018-12-31T20:58:51.442Z,1546289931.442 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T20:58:51.442Z,1546289931.442 [CTD_Seabird] Communications Fault, FailCount= 1
2018-12-31T20:58:51.443Z,1546289931.443 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T20:58:51.532Z,1546289931.532 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-31T20:58:51.847Z,1546289931.847 [CTD_Seabird](INFO): Powering down
2018-12-31T20:58:56.285Z,1546289936.285 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-31T20:58:56.285Z,1546289936.285 [CTD_Seabird] No Fault, FailCount= 1
2018-12-31T20:58:56.410Z,1546289936.410 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T20:58:56.412Z,1546289936.412 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T20:59:05.813Z,1546289945.813 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181219T170142/Courier0000.lzma
2018-12-31T20:59:06.605Z,1546289946.605 [DataOverHttps](INFO): Moved sent file to Logs/20181219T170142/Courier0000.lzma.bak
2018-12-31T20:59:06.605Z,1546289946.605 [DataOverHttps](INFO): SBD MOMSN=9127545
2018-12-31T20:59:10.454Z,1546289950.454 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T20:59:10.454Z,1546289950.454 [CTD_Seabird] Communications Fault, FailCount= 2
2018-12-31T20:59:10.454Z,1546289950.454 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T20:59:10.858Z,1546289950.858 [CTD_Seabird](INFO): Powering down
2018-12-31T20:59:11.451Z,1546289951.451 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-31T20:59:13.120Z,1546289953.120 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-31T20:59:13.120Z,1546289953.120 [CTD_Seabird] No Fault, FailCount= 2
2018-12-31T20:59:13.807Z,1546289953.807 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T20:59:13.815Z,1546289953.815 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T20:59:21.464Z,1546289961.464 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181219T170557/Courier0000.lzma
2018-12-31T20:59:21.852Z,1546289961.852 [NAL9602](FAULT): GPS failed to acquire within timeout.
2018-12-31T20:59:21.852Z,1546289961.852 [NAL9602] Data Fault, FailCount= 1
2018-12-31T20:59:21.852Z,1546289961.852 [NAL9602](ERROR): Data Fault
2018-12-31T20:59:22.024Z,1546289962.024 [CBIT](ERROR): Data Fault in component: NAL9602
2018-12-31T20:59:22.249Z,1546289962.249 [DataOverHttps](INFO): Moved sent file to Logs/20181219T170557/Courier0000.lzma.bak
2018-12-31T20:59:22.249Z,1546289962.249 [DataOverHttps](INFO): SBD MOMSN=9127549
2018-12-31T20:59:22.255Z,1546289962.255 [NAL9602](INFO): Powering down
2018-12-31T20:59:24.511Z,1546289964.511 [CBIT](INFO): Clearing failed state for component NAL9602
2018-12-31T20:59:24.511Z,1546289964.511 [NAL9602] No Fault, FailCount= 1
2018-12-31T20:59:27.862Z,1546289967.862 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T20:59:27.862Z,1546289967.862 [CTD_Seabird] Communications Fault, FailCount= 3
2018-12-31T20:59:27.862Z,1546289967.862 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T20:59:28.076Z,1546289968.076 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-31T20:59:28.076Z,1546289968.076 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2018-12-31T20:59:28.266Z,1546289968.266 [CTD_Seabird](INFO): Powering down
2018-12-31T20:59:37.019Z,1546289977.019 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20181219T173941/Courier0000.lzma
2018-12-31T20:59:37.791Z,1546289977.791 [DataOverHttps](INFO): Moved sent file to Logs/20181219T173941/Courier0000.lzma.bak
2018-12-31T20:59:37.792Z,1546289977.792 [DataOverHttps](INFO): SBD MOMSN=9127553
2018-12-31T20:59:48.867Z,1546289988.867 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20181219T174349/Courier0000.lzma
2018-12-31T20:59:49.644Z,1546289989.644 [DataOverHttps](INFO): Moved sent file to Logs/20181219T174349/Courier0000.lzma.bak
2018-12-31T20:59:49.644Z,1546289989.644 [DataOverHttps](INFO): SBD MOMSN=9127556
2018-12-31T20:59:54.489Z,1546289994.489 [NAL9602](INFO): Powering up NAL9602
2018-12-31T21:00:00.189Z,1546290000.189 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181219T175449/Courier0000.lzma
2018-12-31T21:00:00.989Z,1546290000.989 [DataOverHttps](INFO): Moved sent file to Logs/20181219T175449/Courier0000.lzma.bak
2018-12-31T21:00:00.989Z,1546290000.989 [DataOverHttps](INFO): SBD MOMSN=9127559
2018-12-31T21:00:06.159Z,1546290006.159 [NAL9602](INFO): NAL9602 initialized
2018-12-31T21:00:10.492Z,1546290010.492 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T21:00:10.492Z,1546290010.492 [PNI_TCM] No Fault, FailCount= 5
2018-12-31T21:00:10.505Z,1546290010.505 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181219T184313/Courier0000.lzma
2018-12-31T21:00:11.305Z,1546290011.305 [DataOverHttps](INFO): Moved sent file to Logs/20181219T184313/Courier0000.lzma.bak
2018-12-31T21:00:11.305Z,1546290011.305 [DataOverHttps](INFO): SBD MOMSN=9127563
2018-12-31T21:00:23.486Z,1546290023.486 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T21:00:23.486Z,1546290023.486 [PNI_TCM] Data Fault, FailCount= 1
2018-12-31T21:00:23.486Z,1546290023.486 [PNI_TCM](ERROR): Data Fault
2018-12-31T21:00:23.546Z,1546290023.546 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2018-12-31T21:00:23.597Z,1546290023.597 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-12-31T21:00:23.632Z,1546290023.632 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T21:00:23.645Z,1546290023.645 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181219T190836/Courier0000.lzma
2018-12-31T21:00:23.694Z,1546290023.694 [PNI_TCM](INFO): Powering down
2018-12-31T21:00:24.441Z,1546290024.441 [DataOverHttps](INFO): Moved sent file to Logs/20181219T190836/Courier0000.lzma.bak
2018-12-31T21:00:24.441Z,1546290024.441 [DataOverHttps](INFO): SBD MOMSN=9127567
2018-12-31T21:00:26.079Z,1546290026.079 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T21:00:26.079Z,1546290026.079 [PNI_TCM] No Fault, FailCount= 1
2018-12-31T21:00:33.990Z,1546290033.990 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181219T200550/Courier0000.lzma
2018-12-31T21:00:34.790Z,1546290034.790 [DataOverHttps](INFO): Moved sent file to Logs/20181219T200550/Courier0000.lzma.bak
2018-12-31T21:00:34.790Z,1546290034.790 [DataOverHttps](INFO): SBD MOMSN=9127571
2018-12-31T21:00:36.393Z,1546290036.393 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T21:00:36.393Z,1546290036.393 [PNI_TCM] Data Fault, FailCount= 2
2018-12-31T21:00:36.393Z,1546290036.393 [PNI_TCM](ERROR): Data Fault
2018-12-31T21:00:36.532Z,1546290036.532 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T21:00:36.618Z,1546290036.618 [PNI_TCM](INFO): Powering down
2018-12-31T21:00:40.195Z,1546290040.195 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T21:00:40.196Z,1546290040.196 [PNI_TCM] No Fault, FailCount= 2
2018-12-31T21:00:45.646Z,1546290045.646 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181219T200712/Courier0000.lzma
2018-12-31T21:00:46.445Z,1546290046.445 [DataOverHttps](INFO): Moved sent file to Logs/20181219T200712/Courier0000.lzma.bak
2018-12-31T21:00:46.445Z,1546290046.445 [DataOverHttps](INFO): SBD MOMSN=9127575
2018-12-31T21:00:46.488Z,1546290046.488 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-12-31T21:00:46.488Z,1546290046.488 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 6
2018-12-31T21:00:46.488Z,1546290046.488 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-12-31T21:00:46.500Z,1546290046.500 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-12-31T21:00:48.132Z,1546290048.132 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T21:00:48.132Z,1546290048.132 [PNI_TCM] Data Fault, FailCount= 3
2018-12-31T21:00:48.132Z,1546290048.132 [PNI_TCM](ERROR): Data Fault
2018-12-31T21:00:48.186Z,1546290048.186 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T21:00:48.187Z,1546290048.187 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-12-31T21:00:48.187Z,1546290048.187 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 6
2018-12-31T21:00:48.243Z,1546290048.243 [PNI_TCM](INFO): Powering down
2018-12-31T21:00:48.343Z,1546290048.343 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-31T21:00:48.344Z,1546290048.344 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-31T21:00:48.344Z,1546290048.344 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-31T21:00:51.724Z,1546290051.724 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T21:00:51.724Z,1546290051.724 [PNI_TCM] No Fault, FailCount= 3
2018-12-31T21:00:56.495Z,1546290056.495 [DataOverHttps](INFO): Sending 18 bytes from file Logs/20181219T201432/Courier0000.lzma
2018-12-31T21:00:57.293Z,1546290057.293 [DataOverHttps](INFO): Moved sent file to Logs/20181219T201432/Courier0000.lzma.bak
2018-12-31T21:00:57.293Z,1546290057.293 [DataOverHttps](INFO): SBD MOMSN=9127579
2018-12-31T21:01:02.078Z,1546290062.078 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T21:01:02.078Z,1546290062.078 [PNI_TCM] Data Fault, FailCount= 4
2018-12-31T21:01:02.078Z,1546290062.078 [PNI_TCM](ERROR): Data Fault
2018-12-31T21:01:02.166Z,1546290062.166 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T21:01:02.243Z,1546290062.243 [PNI_TCM](INFO): Powering down
2018-12-31T21:01:03.462Z,1546290063.462 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2018-12-31T21:01:03.496Z,1546290063.496 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T21:01:03.496Z,1546290063.496 [PNI_TCM] No Fault, FailCount= 4
2018-12-31T21:01:07.003Z,1546290067.003 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181219T201657/Courier0000.lzma
2018-12-31T21:01:07.802Z,1546290067.802 [DataOverHttps](INFO): Moved sent file to Logs/20181219T201657/Courier0000.lzma.bak
2018-12-31T21:01:07.802Z,1546290067.802 [DataOverHttps](INFO): SBD MOMSN=9127582
2018-12-31T21:01:13.000Z,1546290073.000 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T21:01:13.000Z,1546290073.000 [PNI_TCM] Data Fault, FailCount= 5
2018-12-31T21:01:13.000Z,1546290073.000 [PNI_TCM](ERROR): Data Fault
2018-12-31T21:01:13.044Z,1546290073.044 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T21:01:13.044Z,1546290073.044 [CBIT](CRITICAL): Data Fault in component: PNI_TCM
2018-12-31T21:01:13.395Z,1546290073.395 [PNI_TCM](INFO): Powering down
2018-12-31T21:01:13.501Z,1546290073.501 [CBIT](INFO): Critical error at 20181231T210113
2018-12-31T21:01:17.315Z,1546290077.315 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181219T230724/Courier0000.lzma
2018-12-31T21:01:18.113Z,1546290078.113 [DataOverHttps](INFO): Moved sent file to Logs/20181219T230724/Courier0000.lzma.bak
2018-12-31T21:01:18.113Z,1546290078.113 [DataOverHttps](INFO): SBD MOMSN=9127586
2018-12-31T21:01:28.966Z,1546290088.966 [DataOverHttps](INFO): Sending 147 bytes from file Logs/20181219T231243/Courier0000.lzma
2018-12-31T21:01:29.765Z,1546290089.765 [DataOverHttps](INFO): Moved sent file to Logs/20181219T231243/Courier0000.lzma.bak
2018-12-31T21:01:29.765Z,1546290089.765 [DataOverHttps](INFO): SBD MOMSN=9127590
2018-12-31T21:01:39.828Z,1546290099.828 [DataOverHttps](INFO): Sending 325 bytes from file Logs/20181220T164135/Courier0000.lzma
2018-12-31T21:01:40.489Z,1546290100.489 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0000.lzma.bak
2018-12-31T21:01:40.489Z,1546290100.489 [DataOverHttps](INFO): SBD MOMSN=9127594
2018-12-31T21:01:51.859Z,1546290111.859 [DataOverHttps](INFO): Sending 219 bytes from file Logs/20181220T164135/Courier0004.lzma
2018-12-31T21:01:52.630Z,1546290112.630 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0004.lzma.bak
2018-12-31T21:01:52.630Z,1546290112.630 [DataOverHttps](INFO): SBD MOMSN=9127600
2018-12-31T21:01:58.022Z,1546290118.022 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-31T21:01:58.022Z,1546290118.022 [CTD_Seabird] No Fault, FailCount= 3
2018-12-31T21:01:58.294Z,1546290118.294 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T21:01:58.296Z,1546290118.296 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T21:02:07.884Z,1546290127.884 [DataOverHttps](INFO): Sending 132 bytes from file Logs/20181220T164135/Courier0007.lzma
2018-12-31T21:02:08.669Z,1546290128.669 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0007.lzma.bak
2018-12-31T21:02:08.670Z,1546290128.670 [DataOverHttps](INFO): SBD MOMSN=9127604
2018-12-31T21:02:12.342Z,1546290132.342 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T21:02:12.342Z,1546290132.342 [CTD_Seabird] Communications Fault, FailCount= 1
2018-12-31T21:02:12.342Z,1546290132.342 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T21:02:12.746Z,1546290132.746 [CTD_Seabird](INFO): Powering down
2018-12-31T21:02:13.567Z,1546290133.567 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-31T21:02:14.819Z,1546290134.819 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-31T21:02:14.819Z,1546290134.819 [CTD_Seabird] No Fault, FailCount= 1
2018-12-31T21:02:15.695Z,1546290135.695 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T21:02:15.703Z,1546290135.703 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T21:02:23.735Z,1546290143.735 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0010.lzma
2018-12-31T21:02:23.891Z,1546290143.891 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-12-31T21:02:24.529Z,1546290144.529 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0010.lzma.bak
2018-12-31T21:02:24.530Z,1546290144.530 [DataOverHttps](INFO): SBD MOMSN=9127607
2018-12-31T21:02:29.750Z,1546290149.750 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T21:02:29.750Z,1546290149.750 [CTD_Seabird] Communications Fault, FailCount= 2
2018-12-31T21:02:29.750Z,1546290149.750 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T21:02:30.154Z,1546290150.154 [CTD_Seabird](INFO): Powering down
2018-12-31T21:02:30.709Z,1546290150.709 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-31T21:02:32.368Z,1546290152.368 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-31T21:02:32.368Z,1546290152.368 [CTD_Seabird] No Fault, FailCount= 2
2018-12-31T21:02:33.103Z,1546290153.103 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T21:02:33.111Z,1546290153.111 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T21:02:40.676Z,1546290160.676 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0013.lzma
2018-12-31T21:02:41.465Z,1546290161.465 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0013.lzma.bak
2018-12-31T21:02:41.466Z,1546290161.466 [DataOverHttps](INFO): SBD MOMSN=9127610
2018-12-31T21:02:47.150Z,1546290167.150 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T21:02:47.150Z,1546290167.150 [CTD_Seabird] Communications Fault, FailCount= 3
2018-12-31T21:02:47.150Z,1546290167.150 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T21:02:47.423Z,1546290167.423 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-31T21:02:47.424Z,1546290167.424 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2018-12-31T21:02:47.554Z,1546290167.554 [CTD_Seabird](INFO): Powering down
2018-12-31T21:02:51.296Z,1546290171.296 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-12-31T21:02:51.296Z,1546290171.296 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 7
2018-12-31T21:02:51.296Z,1546290171.296 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-12-31T21:02:51.309Z,1546290171.309 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-12-31T21:02:51.322Z,1546290171.322 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0016.lzma
2018-12-31T21:02:51.420Z,1546290171.420 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-12-31T21:02:51.420Z,1546290171.420 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 7
2018-12-31T21:02:51.763Z,1546290171.763 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-31T21:02:51.764Z,1546290171.764 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-31T21:02:51.764Z,1546290171.764 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-31T21:02:52.121Z,1546290172.121 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0016.lzma.bak
2018-12-31T21:02:52.122Z,1546290172.122 [DataOverHttps](INFO): SBD MOMSN=9127613
2018-12-31T21:03:02.566Z,1546290182.566 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0019.lzma
2018-12-31T21:03:03.338Z,1546290183.338 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0019.lzma.bak
2018-12-31T21:03:03.338Z,1546290183.338 [DataOverHttps](INFO): SBD MOMSN=9127616
2018-12-31T21:03:10.316Z,1546290190.316 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2018-12-31T21:03:14.967Z,1546290194.967 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0022.lzma
2018-12-31T21:03:15.765Z,1546290195.765 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0022.lzma.bak
2018-12-31T21:03:15.766Z,1546290195.766 [DataOverHttps](INFO): SBD MOMSN=9127619
2018-12-31T21:03:26.155Z,1546290206.155 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0025.lzma
2018-12-31T21:03:26.949Z,1546290206.949 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0025.lzma.bak
2018-12-31T21:03:26.949Z,1546290206.949 [DataOverHttps](INFO): SBD MOMSN=9127622
2018-12-31T21:03:36.545Z,1546290216.545 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0028.lzma
2018-12-31T21:03:37.345Z,1546290217.345 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0028.lzma.bak
2018-12-31T21:03:37.346Z,1546290217.346 [DataOverHttps](INFO): SBD MOMSN=9127625
2018-12-31T21:03:49.093Z,1546290229.093 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0031.lzma
2018-12-31T21:03:49.889Z,1546290229.889 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0031.lzma.bak
2018-12-31T21:03:49.889Z,1546290229.889 [DataOverHttps](INFO): SBD MOMSN=9127628
2018-12-31T21:04:00.384Z,1546290240.384 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0034.lzma
2018-12-31T21:04:01.166Z,1546290241.166 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0034.lzma.bak
2018-12-31T21:04:01.166Z,1546290241.166 [DataOverHttps](INFO): SBD MOMSN=9127631
2018-12-31T21:04:10.787Z,1546290250.787 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0037.lzma
2018-12-31T21:04:11.585Z,1546290251.585 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0037.lzma.bak
2018-12-31T21:04:11.585Z,1546290251.585 [DataOverHttps](INFO): SBD MOMSN=9127634
2018-12-31T21:04:21.146Z,1546290261.146 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0040.lzma
2018-12-31T21:04:21.945Z,1546290261.945 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0040.lzma.bak
2018-12-31T21:04:21.946Z,1546290261.946 [DataOverHttps](INFO): SBD MOMSN=9127637
2018-12-31T21:04:34.024Z,1546290274.024 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0043.lzma
2018-12-31T21:04:34.821Z,1546290274.821 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0043.lzma.bak
2018-12-31T21:04:34.822Z,1546290274.822 [DataOverHttps](INFO): SBD MOMSN=9127640
2018-12-31T21:04:40.241Z,1546290280.240 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-12-31T21:04:44.475Z,1546290284.475 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0046.lzma
2018-12-31T21:04:45.254Z,1546290285.254 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0046.lzma.bak
2018-12-31T21:04:45.254Z,1546290285.254 [DataOverHttps](INFO): SBD MOMSN=9127643
2018-12-31T21:04:54.908Z,1546290294.908 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-12-31T21:04:54.928Z,1546290294.928 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-12-31T21:04:54.928Z,1546290294.928 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 8
2018-12-31T21:04:54.928Z,1546290294.928 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-12-31T21:04:54.941Z,1546290294.941 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-12-31T21:04:54.953Z,1546290294.953 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0049.lzma
2018-12-31T21:04:55.087Z,1546290295.087 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-12-31T21:04:55.087Z,1546290295.087 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 8
2018-12-31T21:04:55.419Z,1546290295.419 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-31T21:04:55.420Z,1546290295.420 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-31T21:04:55.420Z,1546290295.420 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-31T21:04:55.753Z,1546290295.753 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0049.lzma.bak
2018-12-31T21:04:55.753Z,1546290295.753 [DataOverHttps](INFO): SBD MOMSN=9127646
2018-12-31T21:05:06.156Z,1546290306.156 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0052.lzma
2018-12-31T21:05:06.925Z,1546290306.925 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0052.lzma.bak
2018-12-31T21:05:06.925Z,1546290306.925 [DataOverHttps](INFO): SBD MOMSN=9127649
2018-12-31T21:05:18.332Z,1546290318.332 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-31T21:05:18.332Z,1546290318.332 [CTD_Seabird] No Fault, FailCount= 3
2018-12-31T21:05:18.344Z,1546290318.344 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0055.lzma
2018-12-31T21:05:18.411Z,1546290318.411 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T21:05:18.414Z,1546290318.414 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T21:05:19.142Z,1546290319.142 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0055.lzma.bak
2018-12-31T21:05:19.142Z,1546290319.142 [DataOverHttps](INFO): SBD MOMSN=9127652
2018-12-31T21:05:32.462Z,1546290332.462 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T21:05:32.462Z,1546290332.462 [CTD_Seabird] Communications Fault, FailCount= 1
2018-12-31T21:05:32.462Z,1546290332.462 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T21:05:32.866Z,1546290332.866 [CTD_Seabird](INFO): Powering down
2018-12-31T21:05:34.256Z,1546290334.256 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-31T21:05:34.268Z,1546290334.268 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0058.lzma
2018-12-31T21:05:35.065Z,1546290335.065 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0058.lzma.bak
2018-12-31T21:05:35.066Z,1546290335.066 [DataOverHttps](INFO): SBD MOMSN=9127655
2018-12-31T21:05:35.141Z,1546290335.141 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-31T21:05:35.141Z,1546290335.141 [CTD_Seabird] No Fault, FailCount= 1
2018-12-31T21:05:35.815Z,1546290335.815 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T21:05:35.823Z,1546290335.823 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T21:05:49.870Z,1546290349.870 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T21:05:49.870Z,1546290349.870 [CTD_Seabird] Communications Fault, FailCount= 2
2018-12-31T21:05:49.870Z,1546290349.870 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T21:05:50.274Z,1546290350.274 [CTD_Seabird](INFO): Powering down
2018-12-31T21:05:51.649Z,1546290351.649 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-31T21:05:51.694Z,1546290351.694 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0061.lzma
2018-12-31T21:05:52.462Z,1546290352.462 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0061.lzma.bak
2018-12-31T21:05:52.462Z,1546290352.462 [DataOverHttps](INFO): SBD MOMSN=9127658
2018-12-31T21:05:52.533Z,1546290352.533 [CBIT](INFO): Clearing failed state for component CTD_Seabird
2018-12-31T21:05:52.533Z,1546290352.533 [CTD_Seabird] No Fault, FailCount= 2
2018-12-31T21:05:53.223Z,1546290353.223 [CTD_Seabird](DEBUG): Initializing CTD_Seabird.
2018-12-31T21:05:53.231Z,1546290353.231 [CTD_Seabird](INFO): Opening uart, block timeout 10ths=20
2018-12-31T21:06:04.328Z,1546290364.328 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2018-12-31T21:06:07.302Z,1546290367.302 [CTD_Seabird](FAULT): Failed to initialize within timeout.
2018-12-31T21:06:07.302Z,1546290367.302 [CTD_Seabird] Communications Fault, FailCount= 3
2018-12-31T21:06:07.302Z,1546290367.302 [CTD_Seabird](ERROR): Communications Fault
2018-12-31T21:06:07.707Z,1546290367.707 [CTD_Seabird](INFO): Powering down
2018-12-31T21:06:09.154Z,1546290369.154 [CBIT](ERROR): Communications Fault in component: CTD_Seabird
2018-12-31T21:06:09.154Z,1546290369.154 [CBIT](FAULT): Communications Fault in component: CTD_Seabird
2018-12-31T21:06:09.166Z,1546290369.166 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0064.lzma
2018-12-31T21:06:09.965Z,1546290369.965 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0064.lzma.bak
2018-12-31T21:06:09.966Z,1546290369.966 [DataOverHttps](INFO): SBD MOMSN=9127661
2018-12-31T21:06:14.807Z,1546290374.807 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T21:06:14.807Z,1546290374.807 [PNI_TCM] No Fault, FailCount= 5
2018-12-31T21:06:19.624Z,1546290379.624 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2018-12-31T21:06:19.668Z,1546290379.668 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0067.lzma
2018-12-31T21:06:20.465Z,1546290380.465 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0067.lzma.bak
2018-12-31T21:06:20.465Z,1546290380.465 [DataOverHttps](INFO): SBD MOMSN=9127664
2018-12-31T21:06:25.263Z,1546290385.263 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T21:06:25.263Z,1546290385.263 [PNI_TCM] Data Fault, FailCount= 1
2018-12-31T21:06:25.263Z,1546290385.263 [PNI_TCM](ERROR): Data Fault
2018-12-31T21:06:25.343Z,1546290385.343 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T21:06:25.404Z,1546290385.404 [PNI_TCM](INFO): Powering down
2018-12-31T21:06:26.643Z,1546290386.643 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T21:06:26.643Z,1546290386.643 [PNI_TCM] No Fault, FailCount= 1
2018-12-31T21:06:35.206Z,1546290395.206 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2018-12-31T21:06:35.424Z,1546290395.424 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0070.lzma
2018-12-31T21:06:36.213Z,1546290396.213 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0070.lzma.bak
2018-12-31T21:06:36.213Z,1546290396.213 [DataOverHttps](INFO): SBD MOMSN=9127667
2018-12-31T21:06:44.005Z,1546290404.005 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T21:06:44.005Z,1546290404.005 [PNI_TCM] Data Fault, FailCount= 2
2018-12-31T21:06:44.005Z,1546290404.005 [PNI_TCM](ERROR): Data Fault
2018-12-31T21:06:44.056Z,1546290404.056 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T21:06:44.130Z,1546290404.130 [PNI_TCM](INFO): Powering down
2018-12-31T21:06:45.332Z,1546290405.332 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T21:06:45.332Z,1546290405.332 [PNI_TCM] No Fault, FailCount= 2
2018-12-31T21:06:52.174Z,1546290412.174 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0073.lzma
2018-12-31T21:06:52.973Z,1546290412.973 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0073.lzma.bak
2018-12-31T21:06:52.973Z,1546290412.973 [DataOverHttps](INFO): SBD MOMSN=9127670
2018-12-31T21:06:57.781Z,1546290417.781 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T21:06:57.781Z,1546290417.781 [PNI_TCM] Data Fault, FailCount= 3
2018-12-31T21:06:57.781Z,1546290417.781 [PNI_TCM](ERROR): Data Fault
2018-12-31T21:06:57.788Z,1546290417.788 [DeadReckonUsingSpeedCalculator](FAULT): Unable to read the rotation from vehicle frame to navigation frame for more than 120 seconds.
2018-12-31T21:06:57.788Z,1546290417.788 [DeadReckonUsingSpeedCalculator] Software Fault, FailCount= 9
2018-12-31T21:06:57.788Z,1546290417.788 [DeadReckonUsingSpeedCalculator](ERROR): Software Fault
2018-12-31T21:06:57.825Z,1546290417.825 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T21:06:57.825Z,1546290417.825 [CBIT](ERROR): Software Fault in component: DeadReckonUsingSpeedCalculator
2018-12-31T21:06:57.894Z,1546290417.894 [PNI_TCM](INFO): Powering down
2018-12-31T21:06:58.023Z,1546290418.023 [CBIT](INFO): Clearing failed state for component DeadReckonUsingSpeedCalculator
2018-12-31T21:06:58.024Z,1546290418.024 [DeadReckonUsingSpeedCalculator] No Fault, FailCount= 9
2018-12-31T21:06:58.271Z,1546290418.271 [DeadReckonUsingSpeedCalculator](DEBUG): Initializing DeadReckonUsingSpeedCalculator component.
2018-12-31T21:06:58.271Z,1546290418.271 [DeadReckonUsingSpeedCalculator](INFO): Will consider orientation measurement stale after 120s.
2018-12-31T21:06:58.271Z,1546290418.271 [DeadReckonUsingSpeedCalculator](INFO): Will consider velocity measurement stale after 20s.
2018-12-31T21:06:59.086Z,1546290419.086 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T21:06:59.086Z,1546290419.086 [PNI_TCM] No Fault, FailCount= 3
2018-12-31T21:07:03.432Z,1546290423.432 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0076.lzma
2018-12-31T21:07:04.229Z,1546290424.229 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0076.lzma.bak
2018-12-31T21:07:04.230Z,1546290424.230 [DataOverHttps](INFO): SBD MOMSN=9127673
2018-12-31T21:07:09.066Z,1546290429.066 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T21:07:09.067Z,1546290429.067 [PNI_TCM] Data Fault, FailCount= 4
2018-12-31T21:07:09.067Z,1546290429.067 [PNI_TCM](ERROR): Data Fault
2018-12-31T21:07:09.130Z,1546290429.130 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T21:07:09.175Z,1546290429.175 [PNI_TCM](INFO): Powering down
2018-12-31T21:07:10.419Z,1546290430.419 [CBIT](INFO): Clearing failed state for component PNI_TCM
2018-12-31T21:07:10.419Z,1546290430.419 [PNI_TCM] No Fault, FailCount= 4
2018-12-31T21:07:15.126Z,1546290435.126 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0079.lzma
2018-12-31T21:07:15.176Z,1546290435.176 [BPC1](ERROR): BPC1B: No match for serial number 0000 in BPC1B's battery stick inventory (sticks 32-63 in onboard configuration file).
2018-12-31T21:07:15.897Z,1546290435.897 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0079.lzma.bak
2018-12-31T21:07:15.898Z,1546290435.898 [DataOverHttps](INFO): SBD MOMSN=9127676
2018-12-31T21:07:21.791Z,1546290441.791 [PNI_TCM](FAULT): Failed to set parameters during initialization.
2018-12-31T21:07:21.791Z,1546290441.791 [PNI_TCM] Data Fault, FailCount= 5
2018-12-31T21:07:21.792Z,1546290441.792 [PNI_TCM](ERROR): Data Fault
2018-12-31T21:07:21.885Z,1546290441.885 [CBIT](ERROR): Data Fault in component: PNI_TCM
2018-12-31T21:07:21.885Z,1546290441.885 [CBIT](CRITICAL): Data Fault in component: PNI_TCM
2018-12-31T21:07:21.965Z,1546290441.965 [PNI_TCM](INFO): Powering down
2018-12-31T21:07:22.077Z,1546290442.077 [CBIT](INFO): Critical error at 20181231T210721
2018-12-31T21:07:28.475Z,1546290448.475 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0082.lzma
2018-12-31T21:07:29.321Z,1546290449.321 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0082.lzma.bak
2018-12-31T21:07:29.321Z,1546290449.321 [DataOverHttps](INFO): SBD MOMSN=9127679
2018-12-31T21:07:39.747Z,1546290459.747 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0085.lzma
2018-12-31T21:07:40.545Z,1546290460.545 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0085.lzma.bak
2018-12-31T21:07:40.545Z,1546290460.545 [DataOverHttps](INFO): SBD MOMSN=9127682
2018-12-31T21:07:51.127Z,1546290471.127 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0088.lzma
2018-12-31T21:07:51.894Z,1546290471.894 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0088.lzma.bak
2018-12-31T21:07:51.894Z,1546290471.894 [DataOverHttps](INFO): SBD MOMSN=9127685
2018-12-31T21:08:03.626Z,1546290483.626 [BPC1](ERROR): BPC1B failed to parse battery data due to unrecognized msg size.
2018-12-31T21:08:03.722Z,1546290483.722 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0091.lzma
2018-12-31T21:08:03.889Z,1546290483.889 [BPC1](ERROR): BPC1A failed to parse battery data due to unrecognized msg size.
2018-12-31T21:08:04.504Z,1546290484.504 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0091.lzma.bak
2018-12-31T21:08:04.504Z,1546290484.504 [DataOverHttps](INFO): SBD MOMSN=9127688
2018-12-31T21:08:20.168Z,1546290500.168 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0094.lzma
2018-12-31T21:08:20.957Z,1546290500.957 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0094.lzma.bak
2018-12-31T21:08:20.957Z,1546290500.957 [DataOverHttps](INFO): SBD MOMSN=9127691
2018-12-31T21:08:30.642Z,1546290510.642 [DataOverHttps](INFO): Sending 79 bytes from file Logs/20181220T164135/Courier0097.lzma
2018-12-31T21:08:31.441Z,1546290511.441 [DataOverHttps](INFO): Moved sent file to Logs/20181220T164135/Courier0097.lzma.bak
2018-12-31T21:08:31.441Z,1546290511.441 [DataOverHttps](INFO): SBD MOMSN=9127694
2018-12-31T21:08:33.827Z,1546290513.827 [CommandLine](IMPORTANT): got command quit
2018-12-31T21:08:34.833Z,1546290514.833 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread.
2018-12-31T21:08:34.834Z,1546290514.834 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:34.918Z,1546290514.918 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup.  Bye!
2018-12-31T21:08:34.918Z,1546290514.918 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:34.919Z,1546290514.919 [CommandLine](INFO): Join timeout helper Thread ID is 6913
2018-12-31T21:08:34.930Z,1546290514.930 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler
2018-12-31T21:08:34.930Z,1546290514.930 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:34.931Z,1546290514.931 [NavChartDb](INFO): Join timeout helper Thread ID is 6914
2018-12-31T21:08:35.107Z,1546290515.107 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread.
2018-12-31T21:08:35.107Z,1546290515.107 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:35.126Z,1546290515.126 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler
2018-12-31T21:08:35.126Z,1546290515.126 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:35.127Z,1546290515.127 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 6915
2018-12-31T21:08:35.347Z,1546290515.347 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread.
2018-12-31T21:08:35.347Z,1546290515.347 [WetLabsBB2FL](INFO): Powering down
2018-12-31T21:08:35.347Z,1546290515.347 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:35.366Z,1546290515.366 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler
2018-12-31T21:08:35.366Z,1546290515.366 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:35.367Z,1546290515.367 [CTD_Seabird](INFO): Join timeout helper Thread ID is 6916
2018-12-31T21:08:35.763Z,1546290515.763 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread.
2018-12-31T21:08:35.763Z,1546290515.763 [CTD_Seabird](INFO): Powering down
2018-12-31T21:08:35.778Z,1546290515.778 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:35.790Z,1546290515.790 [ComponentRegistry](INFO): Shutting down Rowe_600LCM ThreadHandler
2018-12-31T21:08:35.790Z,1546290515.790 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:35.791Z,1546290515.791 [Rowe_600LCM](INFO): Join timeout helper Thread ID is 6917
2018-12-31T21:08:36.110Z,1546290516.110 [Rowe_600LCM ThreadHandler](INFO): Uninitializing protected caller thread.
2018-12-31T21:08:36.110Z,1546290516.110 [Rowe_600LCM](INFO): Stopping potential previous instance(s) of roweadcp LCM interface
2018-12-31T21:08:36.260Z,1546290516.260 [Rowe_600LCM](INFO): Powering down
2018-12-31T21:08:36.261Z,1546290516.261 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:36.264Z,1546290516.264 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler
2018-12-31T21:08:36.264Z,1546290516.264 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:36.264Z,1546290516.264 [Radio_Surface](INFO): Join timeout helper Thread ID is 6919
2018-12-31T21:08:36.359Z,1546290516.359 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread.
2018-12-31T21:08:36.359Z,1546290516.359 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:36.371Z,1546290516.371 [ComponentRegistry](INFO): Shutting down logger ThreadHandler
2018-12-31T21:08:36.371Z,1546290516.371 [logger ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:36.372Z,1546290516.372 [logger](INFO): Join timeout helper Thread ID is 6920
2018-12-31T21:08:36.414Z,1546290516.414 [logger ThreadHandler](INFO): Uninitializing protected caller thread.
2018-12-31T21:08:36.415Z,1546290516.415 [logger ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:36.423Z,1546290516.423 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler
2018-12-31T21:08:36.423Z,1546290516.423 [CommandLine ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:36.423Z,1546290516.423 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler
2018-12-31T21:08:36.424Z,1546290516.424 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:36.424Z,1546290516.424 [controlThread](INFO): Join timeout helper Thread ID is 6921
2018-12-31T21:08:36.629Z,1546290516.629 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread.
2018-12-31T21:08:36.629Z,1546290516.629 [controlThread](DEBUG): Uninitializing ControlThread
2018-12-31T21:08:36.629Z,1546290516.629 [AcousticModem_Benthos_ATM900](INFO): Powering down
2018-12-31T21:08:36.756Z,1546290516.756 [NAL9602](INFO): Powering down
2018-12-31T21:08:36.757Z,1546290516.757 [PNI_TCM](INFO): Powering down
2018-12-31T21:08:36.761Z,1546290516.761 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator.
2018-12-31T21:08:36.762Z,1546290516.762 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator.
2018-12-31T21:08:36.762Z,1546290516.762 [NavChart](DEBUG): Uninitialize NavChart Navigation.
2018-12-31T21:08:36.763Z,1546290516.763 [MissionManager](INFO): Uninitializing Mission Default
2018-12-31T21:08:36.763Z,1546290516.763 [Default] Stopped
2018-12-31T21:08:36.763Z,1546290516.763 [Default](DEBUG): Aggregate::uninitialize Default
2018-12-31T21:08:36.763Z,1546290516.763 [Default:B.GoToSurface] Stopped
2018-12-31T21:08:36.763Z,1546290516.763 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2018-12-31T21:08:36.763Z,1546290516.763 [Default:CheckIn] Stopped
2018-12-31T21:08:36.763Z,1546290516.763 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn
2018-12-31T21:08:36.764Z,1546290516.764 [Default:CheckIn:Read_Iridium] Stopped
2018-12-31T21:08:36.767Z,1546290516.767 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent.
2018-12-31T21:08:36.767Z,1546290516.767 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent.
2018-12-31T21:08:36.767Z,1546290516.767 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent.
2018-12-31T21:08:36.768Z,1546290516.768 [LoopControl](DEBUG): Uninitialize LoopControlComponent.
2018-12-31T21:08:36.768Z,1546290516.768 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo.
2018-12-31T21:08:36.768Z,1546290516.768 [BuoyancyServo](INFO): Powering down
2018-12-31T21:08:36.783Z,1546290516.783 [ElevatorServo](DEBUG): Uninitialize Elevator Servo.
2018-12-31T21:08:36.783Z,1546290516.783 [ElevatorServo](INFO): Powering down
2018-12-31T21:08:36.784Z,1546290516.784 [MassServo](DEBUG): Uninitialize Mass Servo.
2018-12-31T21:08:36.784Z,1546290516.784 [MassServo](INFO): Powering down
2018-12-31T21:08:36.784Z,1546290516.784 [RudderServo](DEBUG): Uninitialize Rudder Servo.
2018-12-31T21:08:36.785Z,1546290516.785 [RudderServo](INFO): Powering down
2018-12-31T21:08:36.785Z,1546290516.785 [ThrusterServo](DEBUG): Uninitialize Thruster Servo.
2018-12-31T21:08:36.785Z,1546290516.785 [ThrusterServo](INFO): Powering down
2018-12-31T21:08:36.786Z,1546290516.786 [SBIT](DEBUG): Uninitialize SBIT Component.
2018-12-31T21:08:36.787Z,1546290516.787 [IBIT](DEBUG): Uninitialize IBIT Component.
2018-12-31T21:08:36.787Z,1546290516.787 [CBIT](DEBUG): Uninitialize CBIT Component.
2018-12-31T21:08:36.787Z,1546290516.787 [CBIT](DEBUG): Powering off loads.
2018-12-31T21:08:36.798Z,1546290516.798 [CBIT](DEBUG): Disabling WDT.
2018-12-31T21:08:36.810Z,1546290516.810 [CBIT](DEBUG): Opening all GF detection circuits.
2018-12-31T21:08:36.811Z,1546290516.811 [controlThread ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:36.903Z,1546290516.903 [Rowe_600LCM ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:36.909Z,1546290516.909 [Radio_Surface ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:36.956Z,1546290516.956 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:36.961Z,1546290516.961 [CTD_Seabird ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:37.017Z,1546290517.017 [NavChartDb ThreadHandler](INFO): Thread cancelled.
2018-12-31T21:08:37.080Z,1546290517.080 [logger ThreadHandler](INFO): Thread cancelled.