2019-12-07T05:33:55.514Z,1575696835.514 [CommandLine](IMPORTANT): got command restart logs 2019-12-07T05:34:55.653Z,1575696895.653 [CommandLine](IMPORTANT): got command set NAL9602.time_fix 1575696768.000000 second 2019-12-07T05:35:02.537Z,1575696902.537 [CommandLine](IMPORTANT): got command show stack 2019-12-07T05:35:02.538Z,1575696902.538 [CommandLine](IMPORTANT): Behavior Stack: 2019-12-07T05:35:02.538Z,1575696902.538 [Default](IMPORTANT): Priority 0: Default:B.GoToSurface 2019-12-07T05:35:02.538Z,1575696902.538 [Default:CheckIn](IMPORTANT): Priority 1: Default:CheckIn:Read_GPS 2019-12-07T05:35:03.613Z,1575696903.613 [CBIT](INFO): Clearing failed state for component NAL9602 2019-12-07T05:35:03.613Z,1575696903.613 [NAL9602] No Fault, FailCount= 5 2019-12-07T05:35:03.965Z,1575696903.965 [NAL9602](INFO): Powering up NAL9602 2019-12-07T05:35:14.869Z,1575696914.869 [NAL9602](INFO): NAL9602 initialized 2019-12-07T05:35:43.015Z,1575696943.015 [CommandLine](IMPORTANT): got command set NAL9602.time_fix 1575696896.000000 second 2019-12-07T05:35:43.176Z,1575696943.176 [Default:CheckIn:Read_GPS] Stopped 2019-12-07T05:35:43.176Z,1575696943.176 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-12-07T05:35:50.094Z,1575696950.094 [CommandLine](IMPORTANT): got command maintain 2019-12-07T05:35:50.094Z,1575696950.094 [Maintain_NAL9602.latitude_fix](INFO): NAL9602.latitude_fix maintaining 36.799999 arcdeg 2019-12-07T05:35:50.094Z,1575696950.094 [Maintain_NAL9602.longitude_fix](INFO): NAL9602.longitude_fix maintaining -121.900002 arcdeg 2019-12-07T05:35:50.095Z,1575696950.095 [Maintain_Depth_Keller.depth](INFO): Depth_Keller.depth maintaining 0.000000 m 2019-12-07T05:35:52.372Z,1575696952.372 [DataOverHttps](INFO): Sending 127 bytes from file Logs/20191207T004620/Courier0025.lzma 2019-12-07T05:35:54.378Z,1575696954.378 [DataOverHttps](INFO): Moved sent file to Logs/20191207T004620/Courier0025.lzma.bak 2019-12-07T05:35:54.378Z,1575696954.378 [DataOverHttps](INFO): SBD MOMSN=12127280 2019-12-07T05:36:13.156Z,1575696973.156 [DataOverHttps](INFO): Sending 145 bytes from file Logs/20191207T053355/Courier0000.lzma 2019-12-07T05:36:15.162Z,1575696975.162 [DataOverHttps](INFO): Moved sent file to Logs/20191207T053355/Courier0000.lzma.bak 2019-12-07T05:36:15.162Z,1575696975.162 [DataOverHttps](INFO): SBD MOMSN=12127283 2019-12-07T05:36:36.505Z,1575696996.505 [DataOverHttps](INFO): Sending 2323 bytes from file Logs/20191207T004620/Express0026.lzma 2019-12-07T05:36:38.507Z,1575696998.507 [DataOverHttps](INFO): Moved sent file to Logs/20191207T004620/Express0026.lzma.bak 2019-12-07T05:36:38.507Z,1575696998.507 [DataOverHttps](INFO): SBD MOMSN=12127286 2019-12-07T05:36:46.390Z,1575697006.390 [CommandLine](IMPORTANT): got command set NAL9602.time_fix 1575697024.000000 second 2019-12-07T05:36:59.449Z,1575697019.449 [DataOverHttps](INFO): Sending 415 bytes from file Logs/20191207T053355/Express0001.lzma 2019-12-07T05:37:01.454Z,1575697021.454 [DataOverHttps](INFO): Moved sent file to Logs/20191207T053355/Express0001.lzma.bak 2019-12-07T05:37:01.454Z,1575697021.454 [DataOverHttps](INFO): SBD MOMSN=12127426 2019-12-07T05:37:02.780Z,1575697022.780 [Default:CheckIn:Read_Iridium] Stopped 2019-12-07T05:37:02.780Z,1575697022.780 [Default:CheckIn:C.Wait] Running Loop=1 2019-12-07T05:37:02.780Z,1575697022.780 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-12-07T05:39:30.863Z,1575697170.863 [CommandLine](IMPORTANT): got command quit 2019-12-07T05:39:31.869Z,1575697171.869 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2019-12-07T05:39:31.869Z,1575697171.869 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:32.029Z,1575697172.029 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2019-12-07T05:39:32.029Z,1575697172.029 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:32.029Z,1575697172.029 [CommandLine](INFO): Join timeout helper Thread ID is 4599 2019-12-07T05:39:32.030Z,1575697172.030 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2019-12-07T05:39:32.030Z,1575697172.030 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:32.031Z,1575697172.031 [NavChartDb](INFO): Join timeout helper Thread ID is 4600 2019-12-07T05:39:32.349Z,1575697172.349 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2019-12-07T05:39:32.349Z,1575697172.349 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:32.353Z,1575697172.353 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2019-12-07T05:39:32.353Z,1575697172.353 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:32.353Z,1575697172.353 [Radio_Surface](INFO): Join timeout helper Thread ID is 4601 2019-12-07T05:39:32.485Z,1575697172.485 [Radio_Surface](INFO): Powering down 2019-12-07T05:39:32.486Z,1575697172.486 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2019-12-07T05:39:32.486Z,1575697172.486 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:32.493Z,1575697172.493 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2019-12-07T05:39:32.493Z,1575697172.493 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:32.493Z,1575697172.493 [DataOverHttps](INFO): Join timeout helper Thread ID is 4602 2019-12-07T05:39:33.469Z,1575697173.469 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2019-12-07T05:39:33.469Z,1575697173.469 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:33.470Z,1575697173.470 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2019-12-07T05:39:33.470Z,1575697173.470 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:33.470Z,1575697173.470 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 4603 2019-12-07T05:39:33.881Z,1575697173.881 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2019-12-07T05:39:33.881Z,1575697173.881 [WetLabsBB2FL](INFO): Powering down 2019-12-07T05:39:33.882Z,1575697173.882 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:33.898Z,1575697173.898 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2019-12-07T05:39:33.898Z,1575697173.898 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:33.898Z,1575697173.898 [CTD_Seabird](INFO): Join timeout helper Thread ID is 4604 2019-12-07T05:39:34.589Z,1575697174.589 [CTD_Seabird](INFO): Powering down 2019-12-07T05:39:34.601Z,1575697174.601 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2019-12-07T05:39:34.601Z,1575697174.601 [CTD_Seabird](INFO): Powering down 2019-12-07T05:39:34.613Z,1575697174.613 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:34.626Z,1575697174.626 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2019-12-07T05:39:34.626Z,1575697174.626 [logger ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:34.626Z,1575697174.626 [logger](INFO): Join timeout helper Thread ID is 4605 2019-12-07T05:39:34.649Z,1575697174.649 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2019-12-07T05:39:34.650Z,1575697174.650 [logger ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:34.654Z,1575697174.654 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2019-12-07T05:39:34.655Z,1575697174.655 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:34.655Z,1575697174.655 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2019-12-07T05:39:34.655Z,1575697174.655 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:34.655Z,1575697174.655 [controlThread](INFO): Join timeout helper Thread ID is 4606 2019-12-07T05:39:34.690Z,1575697174.690 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2019-12-07T05:39:34.690Z,1575697174.690 [controlThread](DEBUG): Uninitializing ControlThread 2019-12-07T05:39:34.690Z,1575697174.690 [Aanderaa_O2](INFO): Powering down 2019-12-07T05:39:34.693Z,1575697174.693 [AHRS_M2](INFO): Powering down 2019-12-07T05:39:34.765Z,1575697174.765 [NAL9602](INFO): Powering down 2019-12-07T05:39:34.767Z,1575697174.767 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2019-12-07T05:39:34.768Z,1575697174.768 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2019-12-07T05:39:34.769Z,1575697174.769 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2019-12-07T05:39:34.769Z,1575697174.769 [MissionManager](INFO): Uninitializing Mission Default 2019-12-07T05:39:34.769Z,1575697174.769 [Default] Stopped 2019-12-07T05:39:34.770Z,1575697174.770 [Default](DEBUG): Aggregate::uninitialize Default 2019-12-07T05:39:34.770Z,1575697174.770 [Default:B.GoToSurface] Stopped 2019-12-07T05:39:34.770Z,1575697174.770 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-12-07T05:39:34.770Z,1575697174.770 [Default:CheckIn] Stopped 2019-12-07T05:39:34.770Z,1575697174.770 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-12-07T05:39:34.770Z,1575697174.770 [Default:CheckIn:C.Wait] Stopped 2019-12-07T05:39:34.770Z,1575697174.770 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-12-07T05:39:34.772Z,1575697174.772 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2019-12-07T05:39:34.773Z,1575697174.773 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2019-12-07T05:39:34.773Z,1575697174.773 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2019-12-07T05:39:34.773Z,1575697174.773 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2019-12-07T05:39:34.774Z,1575697174.774 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2019-12-07T05:39:34.774Z,1575697174.774 [BuoyancyServo](INFO): Powering down 2019-12-07T05:39:34.785Z,1575697174.785 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2019-12-07T05:39:34.785Z,1575697174.785 [ElevatorServo](INFO): Powering down 2019-12-07T05:39:34.786Z,1575697174.786 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-12-07T05:39:34.786Z,1575697174.786 [MassServo](INFO): Powering down 2019-12-07T05:39:34.786Z,1575697174.786 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-12-07T05:39:34.787Z,1575697174.787 [RudderServo](INFO): Powering down 2019-12-07T05:39:34.787Z,1575697174.787 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2019-12-07T05:39:34.787Z,1575697174.787 [ThrusterServo](INFO): Powering down 2019-12-07T05:39:34.788Z,1575697174.788 [SBIT](DEBUG): Uninitialize SBIT Component. 2019-12-07T05:39:34.788Z,1575697174.788 [IBIT](DEBUG): Uninitialize IBIT Component. 2019-12-07T05:39:34.789Z,1575697174.789 [CBIT](DEBUG): Uninitialize CBIT Component. 2019-12-07T05:39:34.789Z,1575697174.789 [CBIT](DEBUG): Powering off loads. 2019-12-07T05:39:34.801Z,1575697174.801 [CBIT](DEBUG): Disabling WDT. 2019-12-07T05:39:34.813Z,1575697174.813 [CBIT](DEBUG): Opening all GF detection circuits. 2019-12-07T05:39:34.814Z,1575697174.814 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:34.862Z,1575697174.862 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:34.942Z,1575697174.942 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:35.005Z,1575697175.005 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:35.010Z,1575697175.010 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:35.066Z,1575697175.066 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-12-07T05:39:35.126Z,1575697175.126 [logger ThreadHandler](INFO): Thread cancelled.