2020-05-10T14:58:16.521Z,1589122696.521 [DataOverHttps](INFO): Received command:restart logs 2020-05-10T14:58:16.550Z,1589122696.550 [CommandLine](IMPORTANT): got command restart logs 2020-05-10T14:58:53.362Z,1589122733.362 [RDI_Pathfinder](ERROR): only read 0 of 1 data item for altitude 2020-05-10T14:59:12.359Z,1589122752.359 [RDI_Pathfinder](ERROR): only read 2 of 4 data items 2020-05-10T14:59:31.730Z,1589122771.730 [RDI_Pathfinder](ERROR): only read 3 of 4 data items 2020-05-10T15:00:12.972Z,1589122812.972 [DefaultWithUndock:CheckIn:C.Wait](INFO): Done Waiting. 2020-05-10T15:00:12.972Z,1589122812.972 [DefaultWithUndock:CheckIn:C.Wait] Stopped 2020-05-10T15:00:12.972Z,1589122812.972 [DefaultWithUndock:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2020-05-10T15:00:12.977Z,1589122812.977 [DefaultWithUndock:CheckIn:D] Running Loop=1 2020-05-10T15:00:13.401Z,1589122813.401 [DefaultWithUndock:CheckIn:D] Stopped 2020-05-10T15:00:13.401Z,1589122813.401 [DefaultWithUndock:CheckIn:E] Running Loop=1 2020-05-10T15:00:13.765Z,1589122813.765 [DefaultWithUndock:CheckIn:E](IMPORTANT): Default mission has been running for 11.574580 min 2020-05-10T15:00:13.765Z,1589122813.765 [DefaultWithUndock:CheckIn:E] Stopped 2020-05-10T15:00:13.766Z,1589122813.766 [DefaultWithUndock:CheckIn](INFO): Completed DefaultWithUndock:CheckIn 2020-05-10T15:00:13.766Z,1589122813.766 [DefaultWithUndock:CheckIn] Stopped 2020-05-10T15:00:13.766Z,1589122813.766 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:CheckIn 2020-05-10T15:00:13.766Z,1589122813.766 [DefaultWithUndock:CheckIn](INFO): Running loop #2 2020-05-10T15:00:13.766Z,1589122813.766 [DefaultWithUndock:CheckIn] Running Loop=2 2020-05-10T15:00:13.766Z,1589122813.766 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::initialize DefaultWithUndock:CheckIn 2020-05-10T15:00:13.766Z,1589122813.766 [DefaultWithUndock:CheckIn:Read_GPS] Running Loop=1 2020-05-10T15:00:15.362Z,1589122815.362 [NAL9602](FAULT): GPS failed to acquire within timeout. 2020-05-10T15:00:15.362Z,1589122815.362 [NAL9602] Data Fault, FailCount= 1 2020-05-10T15:00:15.362Z,1589122815.362 [NAL9602](ERROR): Data Fault 2020-05-10T15:00:15.490Z,1589122815.490 [CBIT](ERROR): Data Fault in component: NAL9602 2020-05-10T15:00:15.735Z,1589122815.735 [NAL9602](INFO): Powering down 2020-05-10T15:00:16.657Z,1589122816.657 [CBIT](INFO): Clearing failed state for component NAL9602 2020-05-10T15:00:16.657Z,1589122816.657 [NAL9602] No Fault, FailCount= 1 2020-05-10T15:00:46.035Z,1589122846.035 [NAL9602](INFO): Powering up NAL9602 2020-05-10T15:00:56.947Z,1589122856.947 [NAL9602](INFO): NAL9602 initialized 2020-05-10T15:01:13.917Z,1589122873.917 [NAL9602](INFO): SBD MO Status=0, MOMSN=11164, MT Status=0, MTMSN=0 2020-05-10T15:01:13.917Z,1589122873.917 [NAL9602](INFO): No messages in MT queue 2020-05-10T15:05:13.937Z,1589123113.937 [DefaultWithUndock:CheckIn:Read_GPS](INFO): Timed out from 2020-05-10T15:00:13.8Z 2020-05-10T15:05:13.937Z,1589123113.937 [DefaultWithUndock:CheckIn:Read_GPS] Stopped 2020-05-10T15:05:13.937Z,1589123113.937 [DefaultWithUndock:CheckIn:Read_Iridium] Running Loop=1 2020-05-10T15:05:18.266Z,1589123118.266 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200510T131136/Courier0015.lzma 2020-05-10T15:05:19.266Z,1589123119.266 [DataOverHttps](INFO): Moved sent file to Logs/20200510T131136/Courier0015.lzma.bak 2020-05-10T15:05:19.267Z,1589123119.267 [DataOverHttps](INFO): SBD MOMSN=14011 2020-05-10T15:05:28.304Z,1589123128.304 [DataOverHttps](INFO): Sending 151 bytes from file Logs/20200510T145816/Courier0000.lzma 2020-05-10T15:05:29.307Z,1589123129.307 [DataOverHttps](INFO): Moved sent file to Logs/20200510T145816/Courier0000.lzma.bak 2020-05-10T15:05:29.307Z,1589123129.307 [DataOverHttps](INFO): SBD MOMSN=14013 2020-05-10T15:05:34.330Z,1589123134.330 [DataOverHttps](IMPORTANT): SBD MTMSN=20200510T150502 2020-05-10T15:05:38.351Z,1589123138.351 [DataOverHttps](INFO): Sending 95 bytes from file Logs/20200510T131136/Express0017.lzma 2020-05-10T15:05:38.354Z,1589123138.354 [DataOverHttps](INFO): Received command:configSet RDI_PathfinderUp.loadAtStartup 1 bool persist 2020-05-10T15:05:38.695Z,1589123138.695 [CommandLine](IMPORTANT): got command configSet RDI_PathfinderUp.loadAtStartup 1.000000 bool persist 2020-05-10T15:05:38.695Z,1589123138.695 [CommandLine](IMPORTANT): configSet RDI_PathfinderUp.loadAtStartup requires a restart to take effect. 2020-05-10T15:05:39.767Z,1589123139.767 [DataOverHttps](INFO): Moved sent file to Logs/20200510T131136/Express0017.lzma.bak 2020-05-10T15:05:39.768Z,1589123139.768 [DataOverHttps](INFO): SBD MOMSN=14017 2020-05-10T15:05:44.595Z,1589123144.595 [NAL9602](INFO): Not Powering down - fast GPS 2020-05-10T15:05:48.388Z,1589123148.388 [DataOverHttps](INFO): Sending 39 bytes from file Logs/20200510T145816/Courier0006.lzma 2020-05-10T15:05:49.390Z,1589123149.390 [DataOverHttps](INFO): Moved sent file to Logs/20200510T145816/Courier0006.lzma.bak 2020-05-10T15:05:49.391Z,1589123149.391 [DataOverHttps](INFO): SBD MOMSN=14021 2020-05-10T15:05:58.429Z,1589123158.429 [DataOverHttps](INFO): Sending 389 bytes from file Logs/20200510T145816/Express0001.lzma 2020-05-10T15:05:59.431Z,1589123159.431 [DataOverHttps](INFO): Moved sent file to Logs/20200510T145816/Express0001.lzma.bak 2020-05-10T15:05:59.431Z,1589123159.431 [DataOverHttps](IMPORTANT): SBD MOMSN=14024, MTMSN=20200510T150527 2020-05-10T15:06:03.449Z,1589123163.449 [DataOverHttps](INFO): Received command:restart app 2020-05-10T15:06:03.474Z,1589123163.474 [CommandLine](IMPORTANT): got command restart application 2020-05-10T15:06:04.477Z,1589123164.477 [Supervisor](INFO): Stop Mission called by Supervisor::terminate 2020-05-10T15:06:04.477Z,1589123164.477 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2020-05-10T15:06:04.477Z,1589123164.477 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:04.633Z,1589123164.633 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2020-05-10T15:06:04.633Z,1589123164.633 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:04.638Z,1589123164.638 [CommandLine](INFO): Join timeout helper Thread ID is 4893 2020-05-10T15:06:04.655Z,1589123164.655 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2020-05-10T15:06:04.656Z,1589123164.656 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:04.656Z,1589123164.656 [NavChartDb](INFO): Join timeout helper Thread ID is 4894 2020-05-10T15:06:04.721Z,1589123164.721 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2020-05-10T15:06:04.721Z,1589123164.721 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:04.733Z,1589123164.733 [ComponentRegistry](INFO): Shutting down WetLabsSeaOWL_UV_A ThreadHandler 2020-05-10T15:06:04.733Z,1589123164.733 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:04.733Z,1589123164.733 [WetLabsSeaOWL_UV_A](INFO): Join timeout helper Thread ID is 4895 2020-05-10T15:06:04.785Z,1589123164.785 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Uninitializing protected caller thread. 2020-05-10T15:06:04.785Z,1589123164.785 [WetLabsSeaOWL_UV_A](INFO): Powering down 2020-05-10T15:06:04.786Z,1589123164.786 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:04.793Z,1589123164.793 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2020-05-10T15:06:04.793Z,1589123164.793 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:04.793Z,1589123164.793 [Radio_Surface](INFO): Join timeout helper Thread ID is 4896 2020-05-10T15:06:05.133Z,1589123165.133 [Radio_Surface](INFO): Powering down 2020-05-10T15:06:05.134Z,1589123165.134 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2020-05-10T15:06:05.134Z,1589123165.134 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:05.153Z,1589123165.153 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2020-05-10T15:06:05.153Z,1589123165.153 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:05.153Z,1589123165.153 [DataOverHttps](INFO): Join timeout helper Thread ID is 4897 2020-05-10T15:06:05.453Z,1589123165.453 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2020-05-10T15:06:05.453Z,1589123165.453 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:05.462Z,1589123165.462 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2020-05-10T15:06:05.462Z,1589123165.462 [logger ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:05.462Z,1589123165.462 [logger](INFO): Join timeout helper Thread ID is 4898 2020-05-10T15:06:05.473Z,1589123165.473 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2020-05-10T15:06:05.473Z,1589123165.473 [logger ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:05.481Z,1589123165.481 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2020-05-10T15:06:05.482Z,1589123165.482 [CommandLine ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:05.482Z,1589123165.482 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2020-05-10T15:06:05.482Z,1589123165.482 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:05.482Z,1589123165.482 [controlThread](INFO): Join timeout helper Thread ID is 4899 2020-05-10T15:06:05.581Z,1589123165.581 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2020-05-10T15:06:05.581Z,1589123165.581 [controlThread](DEBUG): Uninitializing ControlThread 2020-05-10T15:06:05.582Z,1589123165.582 [AHRS_M2](INFO): Powering down 2020-05-10T15:06:05.653Z,1589123165.653 [DDM](INFO): Powering down 2020-05-10T15:06:05.745Z,1589123165.745 [DUSBL_Hydroid](INFO): Powering down 2020-05-10T15:06:05.817Z,1589123165.817 [Micromodem](INFO): Powering down 2020-05-10T15:06:05.913Z,1589123165.913 [NAL9602](INFO): Powering down 2020-05-10T15:06:05.985Z,1589123165.985 [RDI_Pathfinder](INFO): Powering down 2020-05-10T15:06:05.986Z,1589123165.986 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2020-05-10T15:06:05.987Z,1589123165.987 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2020-05-10T15:06:05.988Z,1589123165.988 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2020-05-10T15:06:05.988Z,1589123165.988 [MissionManager](INFO): Uninitializing Mission DefaultWithUndock 2020-05-10T15:06:05.989Z,1589123165.989 [DefaultWithUndock] Stopped 2020-05-10T15:06:05.989Z,1589123165.989 [DefaultWithUndock](DEBUG): Aggregate::uninitialize DefaultWithUndock 2020-05-10T15:06:05.989Z,1589123165.989 [DefaultWithUndock:C.GoToSurface] Stopped 2020-05-10T15:06:05.989Z,1589123165.989 [DefaultWithUndock:C.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2020-05-10T15:06:05.989Z,1589123165.989 [DefaultWithUndock:CheckIn] Stopped 2020-05-10T15:06:05.989Z,1589123165.989 [DefaultWithUndock:CheckIn](DEBUG): Aggregate::uninitialize DefaultWithUndock:CheckIn 2020-05-10T15:06:05.989Z,1589123165.989 [DefaultWithUndock:CheckIn:Read_Iridium] Stopped 2020-05-10T15:06:05.992Z,1589123165.992 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2020-05-10T15:06:05.992Z,1589123165.992 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2020-05-10T15:06:05.993Z,1589123165.993 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2020-05-10T15:06:05.993Z,1589123165.993 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2020-05-10T15:06:05.993Z,1589123165.993 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2020-05-10T15:06:05.993Z,1589123165.993 [BuoyancyServo](INFO): Powering down 2020-05-10T15:06:06.005Z,1589123166.005 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2020-05-10T15:06:06.005Z,1589123166.005 [ElevatorServo](INFO): Powering down 2020-05-10T15:06:06.006Z,1589123166.006 [MassServo](DEBUG): Uninitialize Mass Servo. 2020-05-10T15:06:06.006Z,1589123166.006 [MassServo](INFO): Powering down 2020-05-10T15:06:06.007Z,1589123166.007 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2020-05-10T15:06:06.007Z,1589123166.007 [RudderServo](INFO): Powering down 2020-05-10T15:06:06.007Z,1589123166.007 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2020-05-10T15:06:06.008Z,1589123166.008 [ThrusterServo](INFO): Powering down 2020-05-10T15:06:06.008Z,1589123166.008 [SBIT](DEBUG): Uninitialize SBIT Component. 2020-05-10T15:06:06.009Z,1589123166.009 [IBIT](DEBUG): Uninitialize IBIT Component. 2020-05-10T15:06:06.009Z,1589123166.009 [CBIT](DEBUG): Uninitialize CBIT Component. 2020-05-10T15:06:06.009Z,1589123166.009 [CBIT](DEBUG): Powering off loads. 2020-05-10T15:06:06.021Z,1589123166.021 [CBIT](DEBUG): Disabling WDT. 2020-05-10T15:06:06.033Z,1589123166.033 [CBIT](DEBUG): Opening all GF detection circuits. 2020-05-10T15:06:06.033Z,1589123166.033 [controlThread ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:06.081Z,1589123166.081 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:06.093Z,1589123166.093 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:06.143Z,1589123166.143 [WetLabsSeaOWL_UV_A ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:06.206Z,1589123166.206 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2020-05-10T15:06:06.277Z,1589123166.277 [logger ThreadHandler](INFO): Thread cancelled.