2019-09-23T09:48:03.400Z,1569232083.400 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-09-23T09:48:03.469Z,1569232083.469 [CommandLine](IMPORTANT): got command restart logs 2019-09-23T09:48:03.784Z,1569232083.784 [MissionManager](IMPORTANT): Started mission Default 2019-09-23T09:48:03.784Z,1569232083.784 [Default] Running Loop=1 2019-09-23T09:48:03.784Z,1569232083.784 [Default](DEBUG): Aggregate::initialize Default 2019-09-23T09:48:03.784Z,1569232083.784 [Default:B.GoToSurface] Running Loop=1 2019-09-23T09:48:03.784Z,1569232083.784 [Default:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent. 2019-09-23T09:48:03.785Z,1569232083.785 [Default:B.GoToSurface](DEBUG): No depth rate setting specified. Using default value of nan m/s. 2019-09-23T09:48:03.785Z,1569232083.785 [Default:B.GoToSurface](DEBUG): No pitch setting specified. Using default value of nan degrees. 2019-09-23T09:48:03.785Z,1569232083.785 [Default:B.GoToSurface](DEBUG): No speed setting specified. Using default value of 1.000000 m/s. 2019-09-23T09:48:03.786Z,1569232083.786 [Default:B.GoToSurface](DEBUG): No surface timeout specified. Using default value of 1000.000000 seconds. 2019-09-23T09:48:03.786Z,1569232083.786 [Default:B.GoToSurface](INFO): Received pitch timeout configuration 60.000000 seconds. 2019-09-23T09:48:03.786Z,1569232083.786 [Default:A.Wait] Running Loop=1 2019-09-23T09:48:03.786Z,1569232083.786 [Default:A.Wait](DEBUG): Initialize Wait Component. 2019-09-23T09:48:17.115Z,1569232097.115 [Default:A.Wait](INFO): Done Waiting. 2019-09-23T09:48:17.115Z,1569232097.115 [Default:A.Wait] Stopped 2019-09-23T09:48:17.115Z,1569232097.115 [Default:A.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T09:48:17.578Z,1569232097.578 [Default:CheckIn] Running Loop=1 2019-09-23T09:48:17.579Z,1569232097.579 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T09:48:17.579Z,1569232097.579 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T09:48:19.097Z,1569232099.097 [NAL9602](DEBUG): Fix Requested 2019-09-23T09:48:19.488Z,1569232099.488 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,094724.00,A,3648.16270,N,12147.29304,W,0.078,338.36,230919,,,A*74 2019-09-23T09:48:19.490Z,1569232099.490 [NAL9602](INFO): GPS fix at 20190923T094724: (36.802712, -121.788217) 2019-09-23T09:48:19.565Z,1569232099.565 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T09:48:19.565Z,1569232099.565 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T09:48:31.784Z,1569232111.784 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20190922T044358/Courier0864.lzma 2019-09-23T09:48:33.791Z,1569232113.791 [DataOverHttps](INFO): Moved sent file to Logs/20190922T044358/Courier0864.lzma.bak 2019-09-23T09:48:33.791Z,1569232113.791 [DataOverHttps](INFO): SBD MOMSN=11802777 2019-09-23T09:48:56.989Z,1569232136.989 [DataOverHttps](INFO): Sending 213 bytes from file Logs/20190923T094803/Courier0000.lzma 2019-09-23T09:48:58.994Z,1569232138.994 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Courier0000.lzma.bak 2019-09-23T09:48:58.994Z,1569232138.994 [DataOverHttps](INFO): SBD MOMSN=11802779 2019-09-23T09:49:19.605Z,1569232159.605 [DataOverHttps](INFO): Sending 172 bytes from file Logs/20190922T044358/Express0865.lzma 2019-09-23T09:49:21.611Z,1569232161.611 [DataOverHttps](INFO): Moved sent file to Logs/20190922T044358/Express0865.lzma.bak 2019-09-23T09:49:21.611Z,1569232161.611 [DataOverHttps](INFO): SBD MOMSN=11802783 2019-09-23T09:49:44.905Z,1569232184.905 [DataOverHttps](INFO): Sending 301 bytes from file Logs/20190923T094803/Express0001.lzma 2019-09-23T09:49:46.910Z,1569232186.910 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Express0001.lzma.bak 2019-09-23T09:49:46.911Z,1569232186.911 [DataOverHttps](INFO): SBD MOMSN=11802787 2019-09-23T09:49:50.856Z,1569232190.856 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T09:49:50.856Z,1569232190.856 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T09:49:50.856Z,1569232190.856 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T09:49:58.104Z,1569232198.104 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2019-09-23T09:49:58.114Z,1569232198.114 [BPC1](INFO): Received data from all battery sticks. 2019-09-23T09:53:21.679Z,1569232401.679 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2019-09-23T09:53:52.392Z,1569232432.392 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T09:54:51.441Z,1569232491.441 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T09:54:51.442Z,1569232491.442 [Default:CheckIn:C.Wait] Stopped 2019-09-23T09:54:51.442Z,1569232491.442 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T09:54:51.442Z,1569232491.442 [Default:CheckIn:D] Running Loop=1 2019-09-23T09:54:51.816Z,1569232491.816 [Default:CheckIn:D] Stopped 2019-09-23T09:54:51.816Z,1569232491.816 [Default:CheckIn:E] Running Loop=1 2019-09-23T09:54:52.226Z,1569232492.226 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 6.800505 min 2019-09-23T09:54:52.227Z,1569232492.227 [Default:CheckIn:E] Stopped 2019-09-23T09:54:52.227Z,1569232492.227 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T09:54:52.227Z,1569232492.227 [Default:CheckIn] Stopped 2019-09-23T09:54:52.227Z,1569232492.227 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T09:54:52.227Z,1569232492.227 [Default:CheckIn](INFO): Running loop #2 2019-09-23T09:54:52.227Z,1569232492.227 [Default:CheckIn] Running Loop=2 2019-09-23T09:54:52.227Z,1569232492.227 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T09:54:52.227Z,1569232492.227 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T09:54:53.817Z,1569232493.817 [NAL9602](DEBUG): Fix Requested 2019-09-23T09:54:54.208Z,1569232494.208 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,095359.00,A,3648.16382,N,12147.27945,W,0.233,267.10,230919,,,A*74 2019-09-23T09:54:54.210Z,1569232494.210 [NAL9602](INFO): GPS fix at 20190923T095359: (36.802730, -121.787991) 2019-09-23T09:54:54.259Z,1569232494.259 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T09:54:54.259Z,1569232494.259 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T09:55:06.789Z,1569232506.789 [DataOverHttps](INFO): Sending 222 bytes from file Logs/20190923T094803/Courier0003.lzma 2019-09-23T09:55:08.794Z,1569232508.794 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Courier0003.lzma.bak 2019-09-23T09:55:08.795Z,1569232508.795 [DataOverHttps](INFO): SBD MOMSN=11802808 2019-09-23T09:55:24.914Z,1569232524.914 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2019-09-23T09:55:24.997Z,1569232524.997 [NAL9602](FAULT): received: +CSQ:0 OK14, 2, 0, 0, 0 OK 2019-09-23T09:55:24.997Z,1569232524.997 [NAL9602] Data Fault, FailCount= 1 2019-09-23T09:55:24.997Z,1569232524.997 [NAL9602](ERROR): Data Fault 2019-09-23T09:55:25.146Z,1569232525.146 [CBIT](ERROR): Data Fault in component: NAL9602 2019-09-23T09:55:25.314Z,1569232525.314 [NAL9602](INFO): Powering down 2019-09-23T09:55:26.221Z,1569232526.221 [CBIT](INFO): Clearing failed state for component NAL9602 2019-09-23T09:55:26.221Z,1569232526.221 [NAL9602] No Fault, FailCount= 1 2019-09-23T09:55:30.078Z,1569232530.078 [DataOverHttps](INFO): Sending 237 bytes from file Logs/20190923T094803/Express0004.lzma 2019-09-23T09:55:32.082Z,1569232532.082 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Express0004.lzma.bak 2019-09-23T09:55:32.082Z,1569232532.082 [DataOverHttps](INFO): SBD MOMSN=11802811 2019-09-23T09:55:35.891Z,1569232535.891 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T09:55:35.891Z,1569232535.891 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T09:55:35.892Z,1569232535.892 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T09:55:55.634Z,1569232555.634 [NAL9602](INFO): Powering up NAL9602 2019-09-23T09:56:06.538Z,1569232566.538 [NAL9602](INFO): NAL9602 initialized 2019-09-23T09:56:37.642Z,1569232597.642 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T10:00:36.447Z,1569232836.447 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T10:00:36.447Z,1569232836.447 [Default:CheckIn:C.Wait] Stopped 2019-09-23T10:00:36.447Z,1569232836.447 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T10:00:36.448Z,1569232836.448 [Default:CheckIn:D] Running Loop=1 2019-09-23T10:00:36.858Z,1569232836.858 [Default:CheckIn:D] Stopped 2019-09-23T10:00:36.858Z,1569232836.858 [Default:CheckIn:E] Running Loop=1 2019-09-23T10:00:37.261Z,1569232837.261 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 12.551222 min 2019-09-23T10:00:37.261Z,1569232837.261 [Default:CheckIn:E] Stopped 2019-09-23T10:00:37.262Z,1569232837.262 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T10:00:37.262Z,1569232837.262 [Default:CheckIn] Stopped 2019-09-23T10:00:37.262Z,1569232837.262 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T10:00:37.262Z,1569232837.262 [Default:CheckIn](INFO): Running loop #3 2019-09-23T10:00:37.262Z,1569232837.262 [Default:CheckIn] Running Loop=3 2019-09-23T10:00:37.262Z,1569232837.262 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T10:00:37.262Z,1569232837.262 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T10:00:38.841Z,1569232838.841 [NAL9602](DEBUG): Fix Requested 2019-09-23T10:00:39.240Z,1569232839.240 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,095943.00,A,3648.17159,N,12147.28919,W,1.030,65.39,230919,,,A*4D 2019-09-23T10:00:39.246Z,1569232839.246 [NAL9602](INFO): GPS fix at 20190923T095943: (36.802860, -121.788153) 2019-09-23T10:00:39.323Z,1569232839.323 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T10:00:39.323Z,1569232839.323 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T10:00:41.402Z,1569232841.402 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2019-09-23T10:00:43.243Z,1569232843.243 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190923T094803/Courier0006.lzma 2019-09-23T10:00:45.254Z,1569232845.254 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Courier0006.lzma.bak 2019-09-23T10:00:45.254Z,1569232845.254 [DataOverHttps](INFO): SBD MOMSN=11802826 2019-09-23T10:01:05.781Z,1569232865.781 [DataOverHttps](INFO): Sending 160 bytes from file Logs/20190923T094803/Express0007.lzma 2019-09-23T10:01:07.786Z,1569232867.786 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Express0007.lzma.bak 2019-09-23T10:01:07.786Z,1569232867.786 [DataOverHttps](INFO): SBD MOMSN=11802829 2019-09-23T10:01:11.756Z,1569232871.756 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T10:01:11.756Z,1569232871.756 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T10:01:11.756Z,1569232871.756 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T10:01:12.097Z,1569232872.097 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T10:06:12.346Z,1569233172.346 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T10:06:12.346Z,1569233172.346 [Default:CheckIn:C.Wait] Stopped 2019-09-23T10:06:12.346Z,1569233172.346 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T10:06:12.346Z,1569233172.346 [Default:CheckIn:D] Running Loop=1 2019-09-23T10:06:12.721Z,1569233172.721 [Default:CheckIn:D] Stopped 2019-09-23T10:06:12.721Z,1569233172.721 [Default:CheckIn:E] Running Loop=1 2019-09-23T10:06:13.129Z,1569233173.129 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 18.148950 min 2019-09-23T10:06:13.129Z,1569233173.129 [Default:CheckIn:E] Stopped 2019-09-23T10:06:13.129Z,1569233173.129 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T10:06:13.130Z,1569233173.130 [Default:CheckIn] Stopped 2019-09-23T10:06:13.130Z,1569233173.130 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T10:06:13.130Z,1569233173.130 [Default:CheckIn](INFO): Running loop #4 2019-09-23T10:06:13.130Z,1569233173.130 [Default:CheckIn] Running Loop=4 2019-09-23T10:06:13.130Z,1569233173.130 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T10:06:13.130Z,1569233173.130 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T10:06:14.705Z,1569233174.705 [NAL9602](DEBUG): Fix Requested 2019-09-23T10:06:15.101Z,1569233175.101 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,100519.00,A,3648.16727,N,12147.28358,W,0.389,133.61,230919,,,A*7D 2019-09-23T10:06:15.103Z,1569233175.103 [NAL9602](INFO): GPS fix at 20190923T100519: (36.802788, -121.788060) 2019-09-23T10:06:15.136Z,1569233175.136 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T10:06:15.136Z,1569233175.136 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T10:06:25.132Z,1569233185.132 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190923T094803/Courier0009.lzma 2019-09-23T10:06:27.138Z,1569233187.138 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Courier0009.lzma.bak 2019-09-23T10:06:27.138Z,1569233187.138 [DataOverHttps](INFO): SBD MOMSN=11802840 2019-09-23T10:06:49.970Z,1569233209.970 [DataOverHttps](INFO): Sending 195 bytes from file Logs/20190923T094803/Express0010.lzma 2019-09-23T10:06:51.974Z,1569233211.974 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Express0010.lzma.bak 2019-09-23T10:06:51.974Z,1569233211.974 [DataOverHttps](INFO): SBD MOMSN=11802843 2019-09-23T10:06:55.963Z,1569233215.963 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T10:06:55.964Z,1569233215.964 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T10:06:55.964Z,1569233215.964 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T10:06:59.950Z,1569233219.950 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2019-09-23T10:06:59.951Z,1569233219.951 [DropWeight] Hardware Fault, FailCount= 1 2019-09-23T10:06:59.951Z,1569233219.951 [DropWeight](ERROR): Hardware Fault 2019-09-23T10:07:00.114Z,1569233220.114 [CBIT](INFO): Critical error at 20190923T100659 2019-09-23T10:07:00.135Z,1569233220.135 [CBIT](ERROR): Hardware Fault in component: DropWeight 2019-09-23T10:07:00.136Z,1569233220.136 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2019-09-23T10:07:00.447Z,1569233220.447 [CBIT](INFO): Critical error at 20190923T100700 2019-09-23T10:10:07.807Z,1569233407.807 [NAL9602](INFO): SBD MO Status=2, MOMSN=1514, MT Status=2, MTMSN=0 2019-09-23T10:10:07.808Z,1569233407.808 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T10:11:00.330Z,1569233460.330 [NAL9602](INFO): SBD MO Status=2, MOMSN=1514, MT Status=2, MTMSN=0 2019-09-23T10:11:00.330Z,1569233460.330 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T10:11:17.298Z,1569233477.298 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2019-09-23T10:11:48.006Z,1569233508.006 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T10:11:56.535Z,1569233516.535 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T10:11:56.535Z,1569233516.535 [Default:CheckIn:C.Wait] Stopped 2019-09-23T10:11:56.535Z,1569233516.535 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T10:11:56.536Z,1569233516.536 [Default:CheckIn:D] Running Loop=1 2019-09-23T10:11:56.991Z,1569233516.991 [Default:CheckIn:D] Stopped 2019-09-23T10:11:56.991Z,1569233516.991 [Default:CheckIn:E] Running Loop=1 2019-09-23T10:11:57.365Z,1569233517.365 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 23.886780 min 2019-09-23T10:11:57.365Z,1569233517.365 [Default:CheckIn:E] Stopped 2019-09-23T10:11:57.365Z,1569233517.365 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T10:11:57.366Z,1569233517.366 [Default:CheckIn] Stopped 2019-09-23T10:11:57.366Z,1569233517.366 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T10:11:57.366Z,1569233517.366 [Default:CheckIn](INFO): Running loop #5 2019-09-23T10:11:57.366Z,1569233517.366 [Default:CheckIn] Running Loop=5 2019-09-23T10:11:57.366Z,1569233517.366 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T10:11:57.366Z,1569233517.366 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T10:11:58.933Z,1569233518.933 [NAL9602](DEBUG): Fix Requested 2019-09-23T10:11:59.324Z,1569233519.324 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,101104.00,A,3648.16848,N,12147.27830,W,0.097,75.98,230919,,,A*41 2019-09-23T10:11:59.326Z,1569233519.326 [NAL9602](INFO): GPS fix at 20190923T101104: (36.802808, -121.787972) 2019-09-23T10:11:59.391Z,1569233519.391 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T10:11:59.391Z,1569233519.391 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T10:12:09.789Z,1569233529.789 [DataOverHttps](INFO): Sending 172 bytes from file Logs/20190923T094803/Courier0012.lzma 2019-09-23T10:12:11.794Z,1569233531.794 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Courier0012.lzma.bak 2019-09-23T10:12:11.795Z,1569233531.795 [DataOverHttps](INFO): SBD MOMSN=11802859 2019-09-23T10:12:30.023Z,1569233550.023 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2019-09-23T10:12:30.101Z,1569233550.101 [NAL9602](FAULT): received: +CSQ:0 OK14, 2, 0, 0, 0 OK 2019-09-23T10:12:30.101Z,1569233550.101 [NAL9602] Data Fault, FailCount= 1 2019-09-23T10:12:30.101Z,1569233550.101 [NAL9602](ERROR): Data Fault 2019-09-23T10:12:30.257Z,1569233550.257 [CBIT](ERROR): Data Fault in component: NAL9602 2019-09-23T10:12:30.426Z,1569233550.426 [NAL9602](INFO): Powering down 2019-09-23T10:12:31.330Z,1569233551.330 [CBIT](INFO): Clearing failed state for component NAL9602 2019-09-23T10:12:31.330Z,1569233551.330 [NAL9602] No Fault, FailCount= 1 2019-09-23T10:12:32.499Z,1569233552.499 [DataOverHttps](INFO): Sending 196 bytes from file Logs/20190923T094803/Express0013.lzma 2019-09-23T10:12:34.502Z,1569233554.502 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Express0013.lzma.bak 2019-09-23T10:12:34.503Z,1569233554.503 [DataOverHttps](INFO): SBD MOMSN=11802864 2019-09-23T10:12:38.613Z,1569233558.613 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T10:12:38.613Z,1569233558.613 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T10:12:38.613Z,1569233558.613 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T10:13:00.723Z,1569233580.723 [NAL9602](INFO): Powering up NAL9602 2019-09-23T10:13:11.642Z,1569233591.642 [NAL9602](INFO): NAL9602 initialized 2019-09-23T10:13:42.746Z,1569233622.746 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T10:17:39.170Z,1569233859.170 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T10:17:39.171Z,1569233859.171 [Default:CheckIn:C.Wait] Stopped 2019-09-23T10:17:39.171Z,1569233859.171 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T10:17:39.171Z,1569233859.171 [Default:CheckIn:D] Running Loop=1 2019-09-23T10:17:39.562Z,1569233859.562 [Default:CheckIn:D] Stopped 2019-09-23T10:17:39.562Z,1569233859.562 [Default:CheckIn:E] Running Loop=1 2019-09-23T10:17:39.988Z,1569233859.988 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 29.596299 min 2019-09-23T10:17:39.997Z,1569233859.997 [Default:CheckIn:E] Stopped 2019-09-23T10:17:39.997Z,1569233859.997 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T10:17:39.997Z,1569233859.997 [Default:CheckIn] Stopped 2019-09-23T10:17:39.997Z,1569233859.997 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T10:17:39.997Z,1569233859.997 [Default:CheckIn](INFO): Running loop #6 2019-09-23T10:17:39.998Z,1569233859.998 [Default:CheckIn] Running Loop=6 2019-09-23T10:17:39.998Z,1569233859.998 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T10:17:39.998Z,1569233859.998 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T10:17:41.525Z,1569233861.525 [NAL9602](DEBUG): Fix Requested 2019-09-23T10:17:41.922Z,1569233861.922 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,101646.00,A,3648.16094,N,12147.27309,W,0.233,0.00,230919,,,A*77 2019-09-23T10:17:41.924Z,1569233861.924 [NAL9602](INFO): GPS fix at 20190923T101646: (36.802682, -121.787885) 2019-09-23T10:17:41.955Z,1569233861.955 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T10:17:41.955Z,1569233861.955 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T10:17:44.338Z,1569233864.338 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2019-09-23T10:17:55.052Z,1569233875.052 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190923T094803/Courier0015.lzma 2019-09-23T10:17:57.058Z,1569233877.058 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Courier0015.lzma.bak 2019-09-23T10:17:57.059Z,1569233877.059 [DataOverHttps](INFO): SBD MOMSN=11802874 2019-09-23T10:18:15.046Z,1569233895.046 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T10:18:19.165Z,1569233899.165 [DataOverHttps](INFO): Sending 161 bytes from file Logs/20190923T094803/Express0016.lzma 2019-09-23T10:18:21.170Z,1569233901.170 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Express0016.lzma.bak 2019-09-23T10:18:21.170Z,1569233901.170 [DataOverHttps](INFO): SBD MOMSN=11802877 2019-09-23T10:18:24.802Z,1569233904.802 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T10:18:24.802Z,1569233904.802 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T10:18:24.802Z,1569233904.802 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T10:22:00.153Z,1569234120.153 [CBIT](INFO): Clearing failed state for component DropWeight 2019-09-23T10:22:00.153Z,1569234120.153 [DropWeight] No Fault, FailCount= 1 2019-09-23T10:23:25.422Z,1569234205.422 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T10:23:25.422Z,1569234205.422 [Default:CheckIn:C.Wait] Stopped 2019-09-23T10:23:25.422Z,1569234205.422 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T10:23:25.423Z,1569234205.423 [Default:CheckIn:D] Running Loop=1 2019-09-23T10:23:25.827Z,1569234205.827 [Default:CheckIn:D] Stopped 2019-09-23T10:23:25.827Z,1569234205.827 [Default:CheckIn:E] Running Loop=1 2019-09-23T10:23:26.231Z,1569234206.231 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 35.367375 min 2019-09-23T10:23:26.231Z,1569234206.231 [Default:CheckIn:E] Stopped 2019-09-23T10:23:26.231Z,1569234206.231 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T10:23:26.231Z,1569234206.231 [Default:CheckIn] Stopped 2019-09-23T10:23:26.232Z,1569234206.232 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T10:23:26.232Z,1569234206.232 [Default:CheckIn](INFO): Running loop #7 2019-09-23T10:23:26.232Z,1569234206.232 [Default:CheckIn] Running Loop=7 2019-09-23T10:23:26.232Z,1569234206.232 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T10:23:26.232Z,1569234206.232 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T10:23:27.789Z,1569234207.789 [NAL9602](DEBUG): Fix Requested 2019-09-23T10:23:28.176Z,1569234208.176 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,102233.00,A,3648.17029,N,12147.28645,W,0.039,0.00,230919,,,A*7F 2019-09-23T10:23:28.178Z,1569234208.178 [NAL9602](INFO): GPS fix at 20190923T102233: (36.802838, -121.788107) 2019-09-23T10:23:28.238Z,1569234208.238 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T10:23:28.238Z,1569234208.238 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T10:23:40.752Z,1569234220.752 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190923T094803/Courier0018.lzma 2019-09-23T10:23:42.761Z,1569234222.761 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Courier0018.lzma.bak 2019-09-23T10:23:42.761Z,1569234222.761 [DataOverHttps](INFO): SBD MOMSN=11802896 2019-09-23T10:24:06.721Z,1569234246.721 [DataOverHttps](INFO): Sending 195 bytes from file Logs/20190923T094803/Express0019.lzma 2019-09-23T10:24:08.726Z,1569234248.726 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Express0019.lzma.bak 2019-09-23T10:24:08.727Z,1569234248.727 [DataOverHttps](INFO): SBD MOMSN=11802899 2019-09-23T10:24:12.681Z,1569234252.681 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T10:24:12.681Z,1569234252.681 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T10:24:12.681Z,1569234252.681 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T10:26:31.600Z,1569234391.600 [NAL9602](INFO): SBD MO Status=2, MOMSN=1514, MT Status=2, MTMSN=0 2019-09-23T10:26:31.600Z,1569234391.600 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T10:26:54.620Z,1569234414.620 [NAL9602](INFO): SBD MO Status=2, MOMSN=1514, MT Status=2, MTMSN=0 2019-09-23T10:26:54.620Z,1569234414.620 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T10:27:33.003Z,1569234453.003 [NAL9602](INFO): SBD MO Status=2, MOMSN=1514, MT Status=2, MTMSN=0 2019-09-23T10:27:33.004Z,1569234453.004 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T10:28:09.367Z,1569234489.367 [NAL9602](INFO): SBD MO Status=2, MOMSN=1514, MT Status=2, MTMSN=0 2019-09-23T10:28:09.368Z,1569234489.368 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T10:28:25.924Z,1569234505.924 [NAL9602](INFO): SBD MO Status=2, MOMSN=1514, MT Status=2, MTMSN=0 2019-09-23T10:28:25.924Z,1569234505.924 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T10:28:30.367Z,1569234510.367 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2019-09-23T10:29:01.078Z,1569234541.078 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T10:29:13.246Z,1569234553.246 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T10:29:13.246Z,1569234553.246 [Default:CheckIn:C.Wait] Stopped 2019-09-23T10:29:13.246Z,1569234553.246 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T10:29:13.247Z,1569234553.247 [Default:CheckIn:D] Running Loop=1 2019-09-23T10:29:13.638Z,1569234553.638 [Default:CheckIn:D] Stopped 2019-09-23T10:29:13.639Z,1569234553.639 [Default:CheckIn:E] Running Loop=1 2019-09-23T10:29:14.045Z,1569234554.045 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 41.164237 min 2019-09-23T10:29:14.045Z,1569234554.045 [Default:CheckIn:E] Stopped 2019-09-23T10:29:14.045Z,1569234554.045 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T10:29:14.046Z,1569234554.046 [Default:CheckIn] Stopped 2019-09-23T10:29:14.046Z,1569234554.046 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T10:29:14.046Z,1569234554.046 [Default:CheckIn](INFO): Running loop #8 2019-09-23T10:29:14.046Z,1569234554.046 [Default:CheckIn] Running Loop=8 2019-09-23T10:29:14.046Z,1569234554.046 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T10:29:14.046Z,1569234554.046 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T10:29:15.625Z,1569234555.625 [NAL9602](DEBUG): Fix Requested 2019-09-23T10:29:16.024Z,1569234556.024 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,102821.00,A,3648.16265,N,12147.27603,W,0.156,197.70,230919,,,A*70 2019-09-23T10:29:16.026Z,1569234556.026 [NAL9602](INFO): GPS fix at 20190923T102821: (36.802711, -121.787934) 2019-09-23T10:29:16.091Z,1569234556.091 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T10:29:16.091Z,1569234556.091 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T10:29:28.596Z,1569234568.596 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190923T094803/Courier0021.lzma 2019-09-23T10:29:30.602Z,1569234570.602 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Courier0021.lzma.bak 2019-09-23T10:29:30.602Z,1569234570.602 [DataOverHttps](INFO): SBD MOMSN=11802912 2019-09-23T10:29:46.730Z,1569234586.730 [NAL9602](ERROR): Failed to receive proper response when querying signal strength for MT queue check. 2019-09-23T10:29:46.809Z,1569234586.809 [NAL9602](FAULT): received: +SBDI: 2, 1514, 2, 0, 0, 0 OK 2019-09-23T10:29:46.809Z,1569234586.809 [NAL9602] Data Fault, FailCount= 1 2019-09-23T10:29:46.809Z,1569234586.809 [NAL9602](ERROR): Data Fault 2019-09-23T10:29:46.903Z,1569234586.903 [CBIT](ERROR): Data Fault in component: NAL9602 2019-09-23T10:29:47.134Z,1569234587.134 [NAL9602](INFO): Powering down 2019-09-23T10:29:48.005Z,1569234588.005 [CBIT](INFO): Clearing failed state for component NAL9602 2019-09-23T10:29:48.005Z,1569234588.005 [NAL9602] No Fault, FailCount= 1 2019-09-23T10:29:54.497Z,1569234594.497 [DataOverHttps](INFO): Sending 195 bytes from file Logs/20190923T094803/Express0022.lzma 2019-09-23T10:29:56.502Z,1569234596.502 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Express0022.lzma.bak 2019-09-23T10:29:56.503Z,1569234596.503 [DataOverHttps](INFO): SBD MOMSN=11802915 2019-09-23T10:30:00.527Z,1569234600.527 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T10:30:00.527Z,1569234600.527 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T10:30:00.527Z,1569234600.527 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T10:30:17.434Z,1569234617.434 [NAL9602](INFO): Powering up NAL9602 2019-09-23T10:30:28.348Z,1569234628.348 [NAL9602](INFO): NAL9602 initialized 2019-09-23T10:30:59.451Z,1569234659.451 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T10:35:01.099Z,1569234901.099 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T10:35:01.099Z,1569234901.099 [Default:CheckIn:C.Wait] Stopped 2019-09-23T10:35:01.100Z,1569234901.100 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T10:35:01.105Z,1569234901.105 [Default:CheckIn:D] Running Loop=1 2019-09-23T10:35:01.515Z,1569234901.515 [Default:CheckIn:D] Stopped 2019-09-23T10:35:01.515Z,1569234901.515 [Default:CheckIn:E] Running Loop=1 2019-09-23T10:35:01.919Z,1569234901.919 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 46.962179 min 2019-09-23T10:35:01.919Z,1569234901.919 [Default:CheckIn:E] Stopped 2019-09-23T10:35:01.919Z,1569234901.919 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T10:35:01.919Z,1569234901.919 [Default:CheckIn] Stopped 2019-09-23T10:35:01.920Z,1569234901.920 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T10:35:01.920Z,1569234901.920 [Default:CheckIn](INFO): Running loop #9 2019-09-23T10:35:01.920Z,1569234901.920 [Default:CheckIn] Running Loop=9 2019-09-23T10:35:01.920Z,1569234901.920 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T10:35:01.920Z,1569234901.920 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T10:35:03.477Z,1569234903.477 [NAL9602](DEBUG): Fix Requested 2019-09-23T10:35:03.872Z,1569234903.872 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,103409.00,A,3648.17266,N,12147.28569,W,1.477,142.83,230919,,,A*76 2019-09-23T10:35:03.874Z,1569234903.874 [NAL9602](INFO): GPS fix at 20190923T103409: (36.802878, -121.788095) 2019-09-23T10:35:03.947Z,1569234903.947 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T10:35:03.947Z,1569234903.947 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T10:35:06.239Z,1569234906.239 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190923T094803/Courier0024.lzma 2019-09-23T10:35:06.306Z,1569234906.306 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2019-09-23T10:35:08.250Z,1569234908.250 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Courier0024.lzma.bak 2019-09-23T10:35:08.250Z,1569234908.250 [DataOverHttps](INFO): SBD MOMSN=11802930 2019-09-23T10:35:28.901Z,1569234928.901 [DataOverHttps](INFO): Sending 164 bytes from file Logs/20190923T094803/Express0025.lzma 2019-09-23T10:35:30.906Z,1569234930.906 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Express0025.lzma.bak 2019-09-23T10:35:30.906Z,1569234930.906 [DataOverHttps](INFO): SBD MOMSN=11802933 2019-09-23T10:35:34.661Z,1569234934.661 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T10:35:34.661Z,1569234934.661 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T10:35:34.662Z,1569234934.662 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T10:35:37.010Z,1569234937.010 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T10:40:35.251Z,1569235235.251 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T10:40:35.251Z,1569235235.251 [Default:CheckIn:C.Wait] Stopped 2019-09-23T10:40:35.251Z,1569235235.251 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T10:40:35.251Z,1569235235.251 [Default:CheckIn:D] Running Loop=1 2019-09-23T10:40:35.676Z,1569235235.676 [Default:CheckIn:D] Stopped 2019-09-23T10:40:35.676Z,1569235235.676 [Default:CheckIn:E] Running Loop=1 2019-09-23T10:40:36.127Z,1569235236.127 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 52.531531 min 2019-09-23T10:40:36.127Z,1569235236.127 [Default:CheckIn:E] Stopped 2019-09-23T10:40:36.127Z,1569235236.127 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T10:40:36.127Z,1569235236.127 [Default:CheckIn] Stopped 2019-09-23T10:40:36.127Z,1569235236.127 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T10:40:36.128Z,1569235236.128 [Default:CheckIn](INFO): Running loop #10 2019-09-23T10:40:36.128Z,1569235236.128 [Default:CheckIn] Running Loop=10 2019-09-23T10:40:36.128Z,1569235236.128 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T10:40:36.128Z,1569235236.128 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T10:40:37.633Z,1569235237.633 [NAL9602](DEBUG): Fix Requested 2019-09-23T10:40:38.032Z,1569235238.032 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,103943.00,A,3648.16745,N,12147.28034,W,0.797,163.20,230919,,,A*7B 2019-09-23T10:40:38.034Z,1569235238.034 [NAL9602](INFO): GPS fix at 20190923T103943: (36.802791, -121.788006) 2019-09-23T10:40:38.103Z,1569235238.103 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T10:40:38.103Z,1569235238.103 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T10:40:41.271Z,1569235241.271 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20190923T094803/Courier0027.lzma 2019-09-23T10:40:43.282Z,1569235243.282 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Courier0027.lzma.bak 2019-09-23T10:40:43.282Z,1569235243.282 [DataOverHttps](INFO): SBD MOMSN=11802948 2019-09-23T10:41:04.086Z,1569235264.086 [DataOverHttps](INFO): Sending 192 bytes from file Logs/20190923T094803/Express0028.lzma 2019-09-23T10:41:06.090Z,1569235266.090 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Express0028.lzma.bak 2019-09-23T10:41:06.091Z,1569235266.091 [DataOverHttps](INFO): SBD MOMSN=11802951 2019-09-23T10:41:10.135Z,1569235270.135 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T10:41:10.135Z,1569235270.135 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T10:41:10.135Z,1569235270.135 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T10:42:35.311Z,1569235355.311 [NAL9602](INFO): SBD MO Status=2, MOMSN=1514, MT Status=2, MTMSN=0 2019-09-23T10:42:35.312Z,1569235355.312 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T10:43:10.060Z,1569235390.060 [NAL9602](INFO): SBD MO Status=2, MOMSN=1514, MT Status=2, MTMSN=0 2019-09-23T10:43:10.060Z,1569235390.060 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T10:43:34.707Z,1569235414.707 [NAL9602](INFO): SBD MO Status=2, MOMSN=1514, MT Status=2, MTMSN=0 2019-09-23T10:43:34.708Z,1569235414.708 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T10:44:01.771Z,1569235441.771 [NAL9602](INFO): SBD MO Status=2, MOMSN=1514, MT Status=2, MTMSN=0 2019-09-23T10:44:01.772Z,1569235441.772 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T10:44:35.308Z,1569235475.308 [NAL9602](INFO): SBD MO Status=0, MOMSN=1514, MT Status=0, MTMSN=0 2019-09-23T10:44:35.308Z,1569235475.308 [NAL9602](INFO): No messages in MT queue 2019-09-23T10:45:06.010Z,1569235506.010 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T10:46:10.682Z,1569235570.682 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T10:46:10.683Z,1569235570.683 [Default:CheckIn:C.Wait] Stopped 2019-09-23T10:46:10.683Z,1569235570.683 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T10:46:10.683Z,1569235570.683 [Default:CheckIn:D] Running Loop=1 2019-09-23T10:46:11.096Z,1569235571.096 [Default:CheckIn:D] Stopped 2019-09-23T10:46:11.096Z,1569235571.096 [Default:CheckIn:E] Running Loop=1 2019-09-23T10:46:11.517Z,1569235571.517 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 58.121859 min 2019-09-23T10:46:11.517Z,1569235571.517 [Default:CheckIn:E] Stopped 2019-09-23T10:46:11.518Z,1569235571.518 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T10:46:11.518Z,1569235571.518 [Default:CheckIn] Stopped 2019-09-23T10:46:11.518Z,1569235571.518 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T10:46:11.518Z,1569235571.518 [Default:CheckIn](INFO): Running loop #11 2019-09-23T10:46:11.518Z,1569235571.518 [Default:CheckIn] Running Loop=11 2019-09-23T10:46:11.518Z,1569235571.518 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T10:46:11.518Z,1569235571.518 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T10:46:13.085Z,1569235573.085 [NAL9602](DEBUG): Fix Requested 2019-09-23T10:46:13.473Z,1569235573.473 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,104518.00,A,3648.16857,N,12147.28146,W,0.350,163.20,230919,,,A*79 2019-09-23T10:46:13.475Z,1569235573.475 [NAL9602](INFO): GPS fix at 20190923T104518: (36.802810, -121.788024) 2019-09-23T10:46:13.506Z,1569235573.506 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T10:46:13.506Z,1569235573.506 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T10:46:22.876Z,1569235582.876 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190923T094803/Courier0030.lzma 2019-09-23T10:46:24.882Z,1569235584.882 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Courier0030.lzma.bak 2019-09-23T10:46:24.883Z,1569235584.883 [DataOverHttps](INFO): SBD MOMSN=11802970 2019-09-23T10:46:38.523Z,1569235598.523 [NAL9602](INFO): SBD MO Status=2, MOMSN=1515, MT Status=2, MTMSN=0 2019-09-23T10:46:38.524Z,1569235598.524 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T10:46:45.888Z,1569235605.888 [DataOverHttps](INFO): Sending 120 bytes from file Logs/20190923T094803/Express0031.lzma 2019-09-23T10:46:47.894Z,1569235607.894 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Express0031.lzma.bak 2019-09-23T10:46:47.895Z,1569235607.895 [DataOverHttps](INFO): SBD MOMSN=11802973 2019-09-23T10:46:51.925Z,1569235611.925 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T10:46:51.925Z,1569235611.925 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T10:46:51.926Z,1569235611.926 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T10:46:56.304Z,1569235616.304 [NAL9602](INFO): SBD MO Status=0, MOMSN=1515, MT Status=0, MTMSN=0 2019-09-23T10:46:56.304Z,1569235616.304 [NAL9602](INFO): No messages in MT queue 2019-09-23T10:47:27.002Z,1569235647.002 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T10:51:52.468Z,1569235912.468 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T10:51:52.468Z,1569235912.468 [Default:CheckIn:C.Wait] Stopped 2019-09-23T10:51:52.468Z,1569235912.468 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T10:51:52.468Z,1569235912.468 [Default:CheckIn:D] Running Loop=1 2019-09-23T10:51:52.868Z,1569235912.868 [Default:CheckIn:D] Stopped 2019-09-23T10:51:52.868Z,1569235912.868 [Default:CheckIn:E] Running Loop=1 2019-09-23T10:51:53.279Z,1569235913.279 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 63.818058 min 2019-09-23T10:51:53.280Z,1569235913.280 [Default:CheckIn:E] Stopped 2019-09-23T10:51:53.280Z,1569235913.280 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T10:51:53.280Z,1569235913.280 [Default:CheckIn] Stopped 2019-09-23T10:51:53.280Z,1569235913.280 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T10:51:53.280Z,1569235913.280 [Default:CheckIn](INFO): Running loop #12 2019-09-23T10:51:53.280Z,1569235913.280 [Default:CheckIn] Running Loop=12 2019-09-23T10:51:53.280Z,1569235913.280 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T10:51:53.280Z,1569235913.280 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T10:51:54.865Z,1569235914.865 [NAL9602](DEBUG): Fix Requested 2019-09-23T10:51:55.256Z,1569235915.256 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,105100.00,A,3648.16427,N,12147.28396,W,0.933,163.20,230919,,,A*7E 2019-09-23T10:51:55.258Z,1569235915.258 [NAL9602](INFO): GPS fix at 20190923T105100: (36.802738, -121.788066) 2019-09-23T10:51:55.322Z,1569235915.322 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T10:51:55.322Z,1569235915.322 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T10:52:01.718Z,1569235921.718 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2019-09-23T10:52:01.718Z,1569235921.718 [DropWeight] Hardware Fault, FailCount= 1 2019-09-23T10:52:01.718Z,1569235921.718 [DropWeight](ERROR): Hardware Fault 2019-09-23T10:52:01.841Z,1569235921.841 [CBIT](INFO): Critical error at 20190923T105201 2019-09-23T10:52:01.844Z,1569235921.844 [CBIT](ERROR): Hardware Fault in component: DropWeight 2019-09-23T10:52:01.844Z,1569235921.844 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2019-09-23T10:52:02.209Z,1569235922.209 [CBIT](INFO): Critical error at 20190923T105201 2019-09-23T10:52:04.812Z,1569235924.812 [DataOverHttps](INFO): Sending 63 bytes from file Logs/20190923T094803/Courier0033.lzma 2019-09-23T10:52:06.818Z,1569235926.818 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Courier0033.lzma.bak 2019-09-23T10:52:06.819Z,1569235926.819 [DataOverHttps](INFO): SBD MOMSN=11802985 2019-09-23T10:52:28.369Z,1569235948.369 [DataOverHttps](INFO): Sending 119 bytes from file Logs/20190923T094803/Express0034.lzma 2019-09-23T10:52:30.374Z,1569235950.374 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Express0034.lzma.bak 2019-09-23T10:52:30.375Z,1569235950.375 [DataOverHttps](INFO): SBD MOMSN=11802994 2019-09-23T10:52:34.535Z,1569235954.535 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T10:52:34.535Z,1569235954.535 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T10:52:34.535Z,1569235954.535 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T10:52:35.678Z,1569235955.678 [NAL9602](INFO): SBD MO Status=2, MOMSN=1516, MT Status=2, MTMSN=0 2019-09-23T10:52:35.678Z,1569235955.678 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T10:53:11.639Z,1569235991.639 [NAL9602](INFO): SBD MO Status=2, MOMSN=1516, MT Status=2, MTMSN=0 2019-09-23T10:53:11.640Z,1569235991.640 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T10:53:54.455Z,1569236034.455 [NAL9602](INFO): SBD MO Status=2, MOMSN=1516, MT Status=2, MTMSN=0 2019-09-23T10:53:54.455Z,1569236034.455 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T10:54:06.979Z,1569236046.979 [NAL9602](INFO): SBD MO Status=2, MOMSN=1516, MT Status=2, MTMSN=0 2019-09-23T10:54:06.979Z,1569236046.979 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T10:56:02.111Z,1569236162.111 [NAL9602](INFO): SBD MO Status=2, MOMSN=1516, MT Status=2, MTMSN=0 2019-09-23T10:56:02.111Z,1569236162.111 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T10:56:21.142Z,1569236181.142 [NAL9602](INFO): SBD MO Status=0, MOMSN=1516, MT Status=0, MTMSN=0 2019-09-23T10:56:21.142Z,1569236181.142 [NAL9602](INFO): No messages in MT queue 2019-09-23T10:56:51.802Z,1569236211.802 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T10:57:28.187Z,1569236248.187 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2019-09-23T10:57:28.189Z,1569236248.189 [BPC1](INFO): Received data from all battery sticks. 2019-09-23T10:57:35.099Z,1569236255.099 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T10:57:35.099Z,1569236255.099 [Default:CheckIn:C.Wait] Stopped 2019-09-23T10:57:35.099Z,1569236255.099 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T10:57:35.100Z,1569236255.100 [Default:CheckIn:D] Running Loop=1 2019-09-23T10:57:35.479Z,1569236255.479 [Default:CheckIn:D] Stopped 2019-09-23T10:57:35.479Z,1569236255.479 [Default:CheckIn:E] Running Loop=1 2019-09-23T10:57:35.911Z,1569236255.911 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 69.528239 min 2019-09-23T10:57:35.911Z,1569236255.911 [Default:CheckIn:E] Stopped 2019-09-23T10:57:35.912Z,1569236255.912 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T10:57:35.912Z,1569236255.912 [Default:CheckIn] Stopped 2019-09-23T10:57:35.912Z,1569236255.912 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T10:57:35.912Z,1569236255.912 [Default:CheckIn](INFO): Running loop #13 2019-09-23T10:57:35.912Z,1569236255.912 [Default:CheckIn] Running Loop=13 2019-09-23T10:57:35.912Z,1569236255.912 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T10:57:35.912Z,1569236255.912 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T10:57:37.485Z,1569236257.485 [NAL9602](DEBUG): Fix Requested 2019-09-23T10:57:37.869Z,1569236257.869 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,105643.00,A,3648.16072,N,12147.28740,W,0.894,0.00,230919,,,A*7F 2019-09-23T10:57:37.871Z,1569236257.871 [NAL9602](INFO): GPS fix at 20190923T105643: (36.802679, -121.788123) 2019-09-23T10:57:37.983Z,1569236257.983 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T10:57:37.983Z,1569236257.983 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T10:57:42.069Z,1569236262.069 [DataOverHttps](INFO): Sending 159 bytes from file Logs/20190923T094803/Courier0036.lzma 2019-09-23T10:57:44.079Z,1569236264.079 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Courier0036.lzma.bak 2019-09-23T10:57:44.080Z,1569236264.080 [DataOverHttps](INFO): SBD MOMSN=11803008 2019-09-23T10:58:04.784Z,1569236284.784 [DataOverHttps](INFO): Sending 119 bytes from file Logs/20190923T094803/Express0037.lzma 2019-09-23T10:58:06.790Z,1569236286.790 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Express0037.lzma.bak 2019-09-23T10:58:06.791Z,1569236286.791 [DataOverHttps](INFO): SBD MOMSN=11803013 2019-09-23T10:58:10.616Z,1569236290.616 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T10:58:10.616Z,1569236290.616 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T10:58:10.616Z,1569236290.616 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T11:00:08.107Z,1569236408.107 [NAL9602](INFO): SBD MO Status=2, MOMSN=1517, MT Status=2, MTMSN=0 2019-09-23T11:00:08.108Z,1569236408.108 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:01:26.075Z,1569236486.075 [NAL9602](INFO): SBD MO Status=2, MOMSN=1517, MT Status=2, MTMSN=0 2019-09-23T11:01:26.076Z,1569236486.076 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:01:30.621Z,1569236490.621 [CBIT](IMPORTANT): Beginning ground fault scan 2019-09-23T11:01:41.495Z,1569236501.495 [CBIT](IMPORTANT): No ground fault detected mA: CHAN A0 (Batt): -0.017128 CHAN A1 (24V): -0.029399 CHAN A2 (12V): -0.005466 CHAN A3 (5V): -0.005839 CHAN B0 (3.3V): -0.002350 CHAN B1 (3.15aV): -0.001867 CHAN B2 (3.15bV): -0.001670 CHAN B3 (GND): -0.005294 OPEN: 0.004967 Full Scale Calc: 4.765 mA, -1.589 mA 2019-09-23T11:01:53.951Z,1569236513.951 [NAL9602](INFO): SBD MO Status=2, MOMSN=1517, MT Status=2, MTMSN=0 2019-09-23T11:01:53.952Z,1569236513.952 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:02:09.307Z,1569236529.307 [NAL9602](INFO): SBD MO Status=2, MOMSN=1517, MT Status=2, MTMSN=0 2019-09-23T11:02:09.308Z,1569236529.308 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:02:16.179Z,1569236536.179 [NAL9602](INFO): SBD MO Status=0, MOMSN=1517, MT Status=0, MTMSN=0 2019-09-23T11:02:16.179Z,1569236536.179 [NAL9602](INFO): No messages in MT queue 2019-09-23T11:02:46.872Z,1569236566.872 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T11:03:11.184Z,1569236591.184 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T11:03:11.184Z,1569236591.184 [Default:CheckIn:C.Wait] Stopped 2019-09-23T11:03:11.184Z,1569236591.184 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T11:03:11.189Z,1569236591.189 [Default:CheckIn:D] Running Loop=1 2019-09-23T11:03:11.594Z,1569236591.594 [Default:CheckIn:D] Stopped 2019-09-23T11:03:11.594Z,1569236591.594 [Default:CheckIn:E] Running Loop=1 2019-09-23T11:03:11.970Z,1569236591.970 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 75.130168 min 2019-09-23T11:03:11.970Z,1569236591.970 [Default:CheckIn:E] Stopped 2019-09-23T11:03:11.970Z,1569236591.970 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T11:03:11.970Z,1569236591.970 [Default:CheckIn] Stopped 2019-09-23T11:03:11.970Z,1569236591.970 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T11:03:11.971Z,1569236591.971 [Default:CheckIn](INFO): Running loop #14 2019-09-23T11:03:11.971Z,1569236591.971 [Default:CheckIn] Running Loop=14 2019-09-23T11:03:11.971Z,1569236591.971 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T11:03:11.971Z,1569236591.971 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T11:03:13.549Z,1569236593.549 [NAL9602](DEBUG): Fix Requested 2019-09-23T11:03:13.947Z,1569236593.947 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,110219.00,A,3648.16419,N,12147.28212,W,0.311,0.00,230919,,,A*7D 2019-09-23T11:03:13.950Z,1569236593.950 [NAL9602](INFO): GPS fix at 20190923T110219: (36.802737, -121.788035) 2019-09-23T11:03:14.027Z,1569236594.027 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T11:03:14.027Z,1569236594.027 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T11:03:16.830Z,1569236596.830 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190923T094803/Courier0039.lzma 2019-09-23T11:03:18.838Z,1569236598.838 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Courier0039.lzma.bak 2019-09-23T11:03:18.838Z,1569236598.838 [DataOverHttps](INFO): SBD MOMSN=11803027 2019-09-23T11:03:39.155Z,1569236619.155 [NAL9602](INFO): SBD MO Status=2, MOMSN=1518, MT Status=2, MTMSN=0 2019-09-23T11:03:39.155Z,1569236619.155 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:03:43.626Z,1569236623.626 [DataOverHttps](INFO): Sending 331 bytes from file Logs/20190923T094803/Express0040.lzma 2019-09-23T11:03:45.630Z,1569236625.630 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Express0040.lzma.bak 2019-09-23T11:03:45.631Z,1569236625.631 [DataOverHttps](INFO): SBD MOMSN=11803030 2019-09-23T11:03:49.707Z,1569236629.707 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T11:03:49.707Z,1569236629.707 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T11:03:49.707Z,1569236629.707 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T11:04:30.035Z,1569236670.035 [NAL9602](INFO): SBD MO Status=2, MOMSN=1518, MT Status=2, MTMSN=0 2019-09-23T11:04:30.035Z,1569236670.035 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:04:43.768Z,1569236683.768 [NAL9602](INFO): SBD MO Status=0, MOMSN=1518, MT Status=0, MTMSN=0 2019-09-23T11:04:43.768Z,1569236683.768 [NAL9602](INFO): No messages in MT queue 2019-09-23T11:05:14.480Z,1569236714.480 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T11:07:01.989Z,1569236821.989 [CBIT](INFO): Clearing failed state for component DropWeight 2019-09-23T11:07:01.989Z,1569236821.989 [DropWeight] No Fault, FailCount= 1 2019-09-23T11:08:50.253Z,1569236930.253 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T11:08:50.253Z,1569236930.253 [Default:CheckIn:C.Wait] Stopped 2019-09-23T11:08:50.253Z,1569236930.253 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T11:08:50.253Z,1569236930.253 [Default:CheckIn:D] Running Loop=1 2019-09-23T11:08:50.659Z,1569236930.659 [Default:CheckIn:D] Stopped 2019-09-23T11:08:50.659Z,1569236930.659 [Default:CheckIn:E] Running Loop=1 2019-09-23T11:08:51.070Z,1569236931.070 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 80.781250 min 2019-09-23T11:08:51.070Z,1569236931.070 [Default:CheckIn:E] Stopped 2019-09-23T11:08:51.071Z,1569236931.071 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T11:08:51.071Z,1569236931.071 [Default:CheckIn] Stopped 2019-09-23T11:08:51.071Z,1569236931.071 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T11:08:51.071Z,1569236931.071 [Default:CheckIn](INFO): Running loop #15 2019-09-23T11:08:51.071Z,1569236931.071 [Default:CheckIn] Running Loop=15 2019-09-23T11:08:51.071Z,1569236931.071 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T11:08:51.071Z,1569236931.071 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T11:08:52.641Z,1569236932.641 [NAL9602](DEBUG): Fix Requested 2019-09-23T11:08:53.044Z,1569236933.044 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,110758.00,A,3648.16001,N,12147.27644,W,0.505,160.15,230919,,,A*78 2019-09-23T11:08:53.050Z,1569236933.050 [NAL9602](INFO): GPS fix at 20190923T110758: (36.802667, -121.787941) 2019-09-23T11:08:53.127Z,1569236933.127 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T11:08:53.127Z,1569236933.127 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T11:08:57.351Z,1569236937.351 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190923T094803/Courier0042.lzma 2019-09-23T11:08:59.362Z,1569236939.362 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Courier0042.lzma.bak 2019-09-23T11:08:59.362Z,1569236939.362 [DataOverHttps](INFO): SBD MOMSN=11803044 2019-09-23T11:09:20.232Z,1569236960.232 [DataOverHttps](INFO): Sending 122 bytes from file Logs/20190923T094803/Express0043.lzma 2019-09-23T11:09:22.238Z,1569236962.238 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Express0043.lzma.bak 2019-09-23T11:09:22.239Z,1569236962.239 [DataOverHttps](INFO): SBD MOMSN=11803048 2019-09-23T11:09:25.951Z,1569236965.951 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T11:09:25.951Z,1569236965.951 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T11:09:25.951Z,1569236965.951 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T11:10:13.552Z,1569237013.552 [NAL9602](INFO): SBD MO Status=0, MOMSN=1519, MT Status=0, MTMSN=0 2019-09-23T11:10:13.552Z,1569237013.552 [NAL9602](INFO): No messages in MT queue 2019-09-23T11:10:44.250Z,1569237044.250 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T11:14:26.519Z,1569237266.519 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T11:14:26.519Z,1569237266.519 [Default:CheckIn:C.Wait] Stopped 2019-09-23T11:14:26.519Z,1569237266.519 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T11:14:26.519Z,1569237266.519 [Default:CheckIn:D] Running Loop=1 2019-09-23T11:14:26.929Z,1569237266.929 [Default:CheckIn:D] Stopped 2019-09-23T11:14:26.929Z,1569237266.929 [Default:CheckIn:E] Running Loop=1 2019-09-23T11:14:27.343Z,1569237267.343 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 86.385343 min 2019-09-23T11:14:27.343Z,1569237267.343 [Default:CheckIn:E] Stopped 2019-09-23T11:14:27.343Z,1569237267.343 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T11:14:27.343Z,1569237267.343 [Default:CheckIn] Stopped 2019-09-23T11:14:27.344Z,1569237267.344 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T11:14:27.344Z,1569237267.344 [Default:CheckIn](INFO): Running loop #16 2019-09-23T11:14:27.344Z,1569237267.344 [Default:CheckIn] Running Loop=16 2019-09-23T11:14:27.344Z,1569237267.344 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T11:14:27.344Z,1569237267.344 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T11:14:28.893Z,1569237268.893 [NAL9602](DEBUG): Fix Requested 2019-09-23T11:14:29.288Z,1569237269.288 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,111334.00,A,3648.16540,N,12147.27979,W,0.292,151.69,230919,,,A*76 2019-09-23T11:14:29.290Z,1569237269.290 [NAL9602](INFO): GPS fix at 20190923T111334: (36.802757, -121.787997) 2019-09-23T11:14:29.378Z,1569237269.378 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T11:14:29.378Z,1569237269.378 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T11:14:32.174Z,1569237272.174 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190923T094803/Courier0045.lzma 2019-09-23T11:14:34.182Z,1569237274.182 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Courier0045.lzma.bak 2019-09-23T11:14:34.183Z,1569237274.183 [DataOverHttps](INFO): SBD MOMSN=11803065 2019-09-23T11:14:55.252Z,1569237295.252 [NAL9602](INFO): SBD MO Status=2, MOMSN=1520, MT Status=2, MTMSN=0 2019-09-23T11:14:55.252Z,1569237295.252 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:14:56.764Z,1569237296.764 [DataOverHttps](INFO): Sending 119 bytes from file Logs/20190923T094803/Express0046.lzma 2019-09-23T11:14:58.770Z,1569237298.770 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Express0046.lzma.bak 2019-09-23T11:14:58.771Z,1569237298.771 [DataOverHttps](INFO): SBD MOMSN=11803068 2019-09-23T11:15:03.004Z,1569237303.004 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T11:15:03.004Z,1569237303.004 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T11:15:03.004Z,1569237303.004 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T11:15:17.472Z,1569237317.472 [NAL9602](INFO): SBD MO Status=2, MOMSN=1520, MT Status=2, MTMSN=0 2019-09-23T11:15:17.472Z,1569237317.472 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:15:33.635Z,1569237333.635 [NAL9602](INFO): SBD MO Status=0, MOMSN=1520, MT Status=0, MTMSN=0 2019-09-23T11:15:33.636Z,1569237333.636 [NAL9602](INFO): No messages in MT queue 2019-09-23T11:16:04.341Z,1569237364.341 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T11:20:03.571Z,1569237603.571 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T11:20:03.572Z,1569237603.572 [Default:CheckIn:C.Wait] Stopped 2019-09-23T11:20:03.572Z,1569237603.572 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T11:20:03.572Z,1569237603.572 [Default:CheckIn:D] Running Loop=1 2019-09-23T11:20:03.956Z,1569237603.956 [Default:CheckIn:D] Stopped 2019-09-23T11:20:03.956Z,1569237603.956 [Default:CheckIn:E] Running Loop=1 2019-09-23T11:20:04.406Z,1569237604.406 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 92.002865 min 2019-09-23T11:20:04.406Z,1569237604.406 [Default:CheckIn:E] Stopped 2019-09-23T11:20:04.406Z,1569237604.406 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T11:20:04.406Z,1569237604.406 [Default:CheckIn] Stopped 2019-09-23T11:20:04.406Z,1569237604.406 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T11:20:04.407Z,1569237604.407 [Default:CheckIn](INFO): Running loop #17 2019-09-23T11:20:04.407Z,1569237604.407 [Default:CheckIn] Running Loop=17 2019-09-23T11:20:04.407Z,1569237604.407 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T11:20:04.407Z,1569237604.407 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T11:20:05.937Z,1569237605.937 [NAL9602](DEBUG): Fix Requested 2019-09-23T11:20:06.336Z,1569237606.336 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,111911.00,A,3648.16343,N,12147.28646,W,0.233,151.69,230919,,,A*79 2019-09-23T11:20:06.338Z,1569237606.338 [NAL9602](INFO): GPS fix at 20190923T111911: (36.802724, -121.788108) 2019-09-23T11:20:06.405Z,1569237606.405 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T11:20:06.405Z,1569237606.405 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T11:20:16.960Z,1569237616.960 [DataOverHttps](INFO): Sending 64 bytes from file Logs/20190923T094803/Courier0048.lzma 2019-09-23T11:20:18.966Z,1569237618.966 [DataOverHttps](INFO): Moved sent file to Logs/20190923T094803/Courier0048.lzma.bak 2019-09-23T11:20:18.967Z,1569237618.967 [DataOverHttps](INFO): SBD MOMSN=11803081 2019-09-23T11:20:41.891Z,1569237641.891 [NAL9602](INFO): SBD MO Status=2, MOMSN=1521, MT Status=2, MTMSN=0 2019-09-23T11:20:41.892Z,1569237641.892 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:20:56.835Z,1569237656.835 [NAL9602](INFO): SBD MO Status=0, MOMSN=1521, MT Status=0, MTMSN=0 2019-09-23T11:20:56.836Z,1569237656.836 [NAL9602](INFO): No messages in MT queue 2019-09-23T11:21:27.542Z,1569237687.542 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T11:21:32.030Z,1569237692.030 [DataOverHttps](INFO): setting unavailable, lastComms_.elapsed()=60.339905 2019-09-23T11:22:03.173Z,1569237723.173 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:22:08.483Z,1569237728.483 [NAL9602](INFO): SBD MO Status=2, MOMSN=1522, MT Status=2, MTMSN=0 2019-09-23T11:22:08.484Z,1569237728.484 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:22:38.345Z,1569237758.345 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:23:13.485Z,1569237793.485 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:23:26.647Z,1569237806.647 [NAL9602](INFO): SBD MO Status=2, MOMSN=1522, MT Status=2, MTMSN=0 2019-09-23T11:23:26.648Z,1569237806.648 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:23:48.633Z,1569237828.633 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:24:08.376Z,1569237848.376 [NAL9602](INFO): SBD MO Status=1, MOMSN=1522, MT Status=0, MTMSN=0 2019-09-23T11:24:08.429Z,1569237848.429 [NAL9602](INFO): Sent 119 bytes from file Logs/20190923T094803/Express0049.lzma 2019-09-23T11:24:08.429Z,1569237848.429 [NAL9602](INFO): Packets left to send: 0 2019-09-23T11:24:18.884Z,1569237858.884 [NAL9602](INFO): SBD MO Status=0, MOMSN=1523, MT Status=0, MTMSN=0 2019-09-23T11:24:19.007Z,1569237859.007 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T11:24:19.007Z,1569237859.007 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T11:24:19.007Z,1569237859.007 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T11:24:23.805Z,1569237863.805 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:24:49.580Z,1569237889.580 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T11:24:58.977Z,1569237898.977 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:25:34.125Z,1569237934.125 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:26:09.265Z,1569237969.265 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:26:44.405Z,1569238004.405 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:27:19.545Z,1569238039.545 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:27:54.721Z,1569238074.721 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:28:29.861Z,1569238109.861 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:29:05.001Z,1569238145.001 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:29:19.500Z,1569238159.500 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T11:29:19.500Z,1569238159.500 [Default:CheckIn:C.Wait] Stopped 2019-09-23T11:29:19.500Z,1569238159.500 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T11:29:19.500Z,1569238159.500 [Default:CheckIn:D] Running Loop=1 2019-09-23T11:29:19.905Z,1569238159.905 [Default:CheckIn:D] Stopped 2019-09-23T11:29:19.905Z,1569238159.905 [Default:CheckIn:E] Running Loop=1 2019-09-23T11:29:20.326Z,1569238160.326 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 101.268408 min 2019-09-23T11:29:20.326Z,1569238160.326 [Default:CheckIn:E] Stopped 2019-09-23T11:29:20.326Z,1569238160.326 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T11:29:20.326Z,1569238160.326 [Default:CheckIn] Stopped 2019-09-23T11:29:20.326Z,1569238160.326 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T11:29:20.326Z,1569238160.326 [Default:CheckIn](INFO): Running loop #18 2019-09-23T11:29:20.327Z,1569238160.327 [Default:CheckIn] Running Loop=18 2019-09-23T11:29:20.327Z,1569238160.327 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T11:29:20.327Z,1569238160.327 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T11:29:21.894Z,1569238161.894 [NAL9602](DEBUG): Fix Requested 2019-09-23T11:29:22.284Z,1569238162.284 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,112827.00,A,3648.16105,N,12147.28798,W,0.194,0.00,230919,,,A*78 2019-09-23T11:29:22.286Z,1569238162.286 [NAL9602](INFO): GPS fix at 20190923T112827: (36.802684, -121.788133) 2019-09-23T11:29:22.354Z,1569238162.354 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T11:29:22.354Z,1569238162.354 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T11:29:40.145Z,1569238180.145 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:29:42.127Z,1569238182.127 [NAL9602](INFO): SBD MO Status=2, MOMSN=1524, MT Status=2, MTMSN=0 2019-09-23T11:29:42.127Z,1569238182.127 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:29:55.032Z,1569238195.032 [NAL9602](INFO): SBD MO Status=1, MOMSN=1524, MT Status=0, MTMSN=0 2019-09-23T11:29:55.081Z,1569238195.081 [NAL9602](INFO): Sent 64 bytes from file Logs/20190923T094803/Courier0051.lzma 2019-09-23T11:29:55.081Z,1569238195.081 [NAL9602](INFO): Packets left to send: 0 2019-09-23T11:30:14.740Z,1569238214.740 [NAL9602](INFO): SBD MO Status=2, MOMSN=1525, MT Status=2, MTMSN=0 2019-09-23T11:30:14.740Z,1569238214.740 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:30:15.301Z,1569238215.301 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:30:45.924Z,1569238245.924 [NAL9602](INFO): SBD MO Status=1, MOMSN=1525, MT Status=0, MTMSN=0 2019-09-23T11:30:45.977Z,1569238245.977 [NAL9602](INFO): Sent 121 bytes from file Logs/20190923T094803/Express0052.lzma 2019-09-23T11:30:45.977Z,1569238245.977 [NAL9602](INFO): Packets left to send: 0 2019-09-23T11:30:50.441Z,1569238250.441 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:31:04.524Z,1569238264.524 [NAL9602](INFO): SBD MO Status=2, MOMSN=1526, MT Status=2, MTMSN=0 2019-09-23T11:31:04.524Z,1569238264.524 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:31:11.259Z,1569238271.259 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:31:14.859Z,1569238274.859 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:31:25.581Z,1569238285.581 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:31:30.010Z,1569238290.010 [NAL9602](INFO): SBD MO Status=2, MOMSN=1526, MT Status=2, MTMSN=0 2019-09-23T11:31:30.011Z,1569238290.011 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:31:36.805Z,1569238296.805 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:31:40.493Z,1569238300.493 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:31:44.489Z,1569238304.489 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:32:00.730Z,1569238320.730 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:32:06.768Z,1569238326.768 [NAL9602](INFO): SBD MO Status=2, MOMSN=1526, MT Status=2, MTMSN=0 2019-09-23T11:32:06.768Z,1569238326.768 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:32:30.896Z,1569238350.896 [NAL9602](INFO): SBD MO Status=2, MOMSN=1526, MT Status=2, MTMSN=0 2019-09-23T11:32:30.896Z,1569238350.896 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:32:35.881Z,1569238355.881 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:32:37.606Z,1569238357.606 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:32:49.249Z,1569238369.249 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:32:53.662Z,1569238373.662 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:33:02.493Z,1569238382.493 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:33:10.893Z,1569238390.893 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:33:11.029Z,1569238391.029 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:33:15.348Z,1569238395.348 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:33:19.726Z,1569238399.726 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:33:29.006Z,1569238409.006 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:33:46.213Z,1569238426.213 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:33:55.667Z,1569238435.667 [NAL9602](INFO): SBD MO Status=2, MOMSN=1526, MT Status=2, MTMSN=0 2019-09-23T11:33:55.668Z,1569238435.668 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:34:13.090Z,1569238453.090 [NAL9602](INFO): SBD MO Status=2, MOMSN=1526, MT Status=2, MTMSN=0 2019-09-23T11:34:13.091Z,1569238453.091 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:34:19.867Z,1569238459.867 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:34:21.353Z,1569238461.353 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:34:23.489Z,1569238463.489 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:34:27.484Z,1569238467.484 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:34:31.455Z,1569238471.455 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:34:42.733Z,1569238482.733 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:34:47.103Z,1569238487.103 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:34:52.334Z,1569238492.334 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:34:56.493Z,1569238496.493 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:35:04.395Z,1569238504.395 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:35:08.793Z,1569238508.793 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:35:31.472Z,1569238531.472 [NAL9602](INFO): SBD MO Status=2, MOMSN=1526, MT Status=2, MTMSN=0 2019-09-23T11:35:31.472Z,1569238531.472 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:35:31.633Z,1569238531.633 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:35:38.171Z,1569238538.171 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:35:48.623Z,1569238548.623 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:36:04.804Z,1569238564.804 [NAL9602](INFO): SBD MO Status=2, MOMSN=1526, MT Status=2, MTMSN=0 2019-09-23T11:36:04.804Z,1569238564.804 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:36:06.789Z,1569238566.789 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:36:29.424Z,1569238589.424 [NAL9602](INFO): SBD MO Status=2, MOMSN=1526, MT Status=2, MTMSN=0 2019-09-23T11:36:29.424Z,1569238589.424 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:36:35.745Z,1569238595.745 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:36:39.349Z,1569238599.349 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:36:41.937Z,1569238601.937 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:36:43.748Z,1569238603.748 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:36:47.384Z,1569238607.384 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:36:51.781Z,1569238611.781 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:36:55.349Z,1569238615.349 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:36:59.770Z,1569238619.770 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:37:03.506Z,1569238623.506 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2019-09-23T11:37:03.506Z,1569238623.506 [DropWeight] Hardware Fault, FailCount= 1 2019-09-23T11:37:03.506Z,1569238623.506 [DropWeight](ERROR): Hardware Fault 2019-09-23T11:37:03.578Z,1569238623.578 [CBIT](INFO): Critical error at 20190923T113703 2019-09-23T11:37:03.580Z,1569238623.580 [CBIT](ERROR): Hardware Fault in component: DropWeight 2019-09-23T11:37:03.585Z,1569238623.585 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2019-09-23T11:37:04.005Z,1569238624.005 [CBIT](INFO): Critical error at 20190923T113703 2019-09-23T11:37:09.442Z,1569238629.442 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:37:17.077Z,1569238637.077 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:37:21.164Z,1569238641.164 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:37:25.132Z,1569238645.132 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:37:35.358Z,1569238655.358 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:37:39.421Z,1569238659.421 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:37:43.852Z,1569238663.852 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:37:47.436Z,1569238667.436 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:37:52.229Z,1569238672.229 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:38:00.547Z,1569238680.547 [NAL9602](INFO): SBD MO Status=2, MOMSN=1526, MT Status=2, MTMSN=0 2019-09-23T11:38:00.547Z,1569238680.547 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:38:07.454Z,1569238687.454 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:38:17.082Z,1569238697.082 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:38:25.552Z,1569238705.552 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:38:27.369Z,1569238707.369 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:38:29.995Z,1569238709.995 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:38:34.380Z,1569238714.380 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:38:37.948Z,1569238717.948 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:38:42.753Z,1569238722.753 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:38:52.396Z,1569238732.396 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:38:56.957Z,1569238736.957 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:39:02.509Z,1569238742.509 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:39:05.368Z,1569238745.368 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:39:09.761Z,1569238749.761 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:39:14.151Z,1569238754.151 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:39:22.577Z,1569238762.577 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:39:26.910Z,1569238766.910 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:39:37.350Z,1569238777.350 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:39:37.653Z,1569238777.653 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:39:57.940Z,1569238797.940 [NAL9602](INFO): SBD MO Status=2, MOMSN=1526, MT Status=2, MTMSN=0 2019-09-23T11:39:57.940Z,1569238797.940 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:40:04.751Z,1569238804.751 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:40:08.329Z,1569238808.329 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:40:12.697Z,1569238812.697 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:40:12.793Z,1569238812.793 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:40:16.288Z,1569238816.288 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:40:19.888Z,1569238819.888 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:40:30.399Z,1569238830.399 [NAL9602](INFO): SBD MO Status=2, MOMSN=1526, MT Status=2, MTMSN=0 2019-09-23T11:40:30.399Z,1569238830.399 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:40:37.353Z,1569238837.353 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:40:47.942Z,1569238847.942 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:40:48.590Z,1569238848.590 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:40:52.952Z,1569238852.952 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:40:57.400Z,1569238857.400 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:41:01.359Z,1569238861.359 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:41:10.200Z,1569238870.200 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:41:20.730Z,1569238880.730 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:41:23.081Z,1569238883.081 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:41:25.070Z,1569238885.070 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:41:29.463Z,1569238889.463 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:41:33.768Z,1569238893.768 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:41:38.085Z,1569238898.085 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:41:42.422Z,1569238902.422 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:41:50.859Z,1569238910.859 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:41:55.190Z,1569238915.190 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:41:58.221Z,1569238918.221 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:41:59.683Z,1569238919.683 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:42:03.192Z,1569238923.192 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:42:07.534Z,1569238927.534 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:42:11.090Z,1569238931.090 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:42:15.445Z,1569238935.445 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:42:18.990Z,1569238938.990 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:42:23.365Z,1569238943.365 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:42:26.919Z,1569238946.919 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:42:31.231Z,1569238951.231 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:42:33.361Z,1569238953.361 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:42:34.827Z,1569238954.827 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:42:39.173Z,1569238959.173 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:42:42.706Z,1569238962.706 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:42:47.111Z,1569238967.111 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:42:58.368Z,1569238978.368 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:43:07.223Z,1569238987.223 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:43:08.502Z,1569238988.502 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:43:11.208Z,1569238991.208 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:43:15.602Z,1569238995.602 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:43:19.190Z,1569238999.190 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:43:23.620Z,1569239003.620 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:43:27.193Z,1569239007.193 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:43:31.176Z,1569239011.176 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:43:40.083Z,1569239020.083 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:43:43.642Z,1569239023.642 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:43:50.236Z,1569239030.236 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:44:01.872Z,1569239041.872 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:44:09.900Z,1569239049.900 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:44:18.578Z,1569239058.578 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:44:18.781Z,1569239058.781 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:44:36.127Z,1569239076.127 [NAL9602](INFO): SBD MO Status=0, MOMSN=1526, MT Status=0, MTMSN=0 2019-09-23T11:44:36.223Z,1569239076.223 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T11:44:36.223Z,1569239076.223 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T11:44:36.223Z,1569239076.223 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T11:44:53.929Z,1569239093.929 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:45:06.838Z,1569239106.838 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T11:45:29.069Z,1569239129.069 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:46:04.214Z,1569239164.214 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:46:39.354Z,1569239199.354 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:47:14.514Z,1569239234.514 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:47:49.662Z,1569239269.662 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:48:24.809Z,1569239304.809 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:48:59.957Z,1569239339.957 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:49:35.105Z,1569239375.105 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:49:36.749Z,1569239376.749 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T11:49:36.749Z,1569239376.749 [Default:CheckIn:C.Wait] Stopped 2019-09-23T11:49:36.749Z,1569239376.749 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T11:49:36.749Z,1569239376.749 [Default:CheckIn:D] Running Loop=1 2019-09-23T11:49:37.154Z,1569239377.154 [Default:CheckIn:D] Stopped 2019-09-23T11:49:37.154Z,1569239377.154 [Default:CheckIn:E] Running Loop=1 2019-09-23T11:49:37.564Z,1569239377.564 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 121.556152 min 2019-09-23T11:49:37.564Z,1569239377.564 [Default:CheckIn:E] Stopped 2019-09-23T11:49:37.564Z,1569239377.564 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T11:49:37.564Z,1569239377.564 [Default:CheckIn] Stopped 2019-09-23T11:49:37.564Z,1569239377.564 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T11:49:37.565Z,1569239377.565 [Default:CheckIn](INFO): Running loop #19 2019-09-23T11:49:37.565Z,1569239377.565 [Default:CheckIn] Running Loop=19 2019-09-23T11:49:37.565Z,1569239377.565 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T11:49:37.565Z,1569239377.565 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T11:49:39.137Z,1569239379.137 [NAL9602](DEBUG): Fix Requested 2019-09-23T11:49:39.539Z,1569239379.539 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,114844.00,A,3648.16322,N,12147.27771,W,0.194,0.00,230919,,,A*74 2019-09-23T11:49:39.541Z,1569239379.541 [NAL9602](INFO): GPS fix at 20190923T114844: (36.802720, -121.787962) 2019-09-23T11:49:39.575Z,1569239379.575 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T11:49:39.575Z,1569239379.575 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T11:50:10.249Z,1569239410.249 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:50:45.389Z,1569239445.389 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:51:02.911Z,1569239462.911 [NAL9602](INFO): SBD MO Status=2, MOMSN=1527, MT Status=2, MTMSN=0 2019-09-23T11:51:02.912Z,1569239462.912 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:51:20.529Z,1569239480.529 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:51:42.697Z,1569239502.697 [NAL9602](INFO): SBD MO Status=1, MOMSN=1527, MT Status=0, MTMSN=0 2019-09-23T11:51:42.749Z,1569239502.749 [NAL9602](INFO): Sent 141 bytes from file Logs/20190923T094803/Courier0054.lzma 2019-09-23T11:51:42.749Z,1569239502.749 [NAL9602](INFO): Packets left to send: 0 2019-09-23T11:51:55.693Z,1569239515.693 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:51:58.943Z,1569239518.943 [NAL9602](INFO): SBD MO Status=2, MOMSN=1528, MT Status=2, MTMSN=0 2019-09-23T11:51:58.943Z,1569239518.943 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:52:05.702Z,1569239525.702 [CBIT](INFO): Clearing failed state for component DropWeight 2019-09-23T11:52:05.702Z,1569239525.702 [DropWeight] No Fault, FailCount= 1 2019-09-23T11:52:30.833Z,1569239550.833 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:52:45.632Z,1569239565.632 [NAL9602](INFO): SBD MO Status=2, MOMSN=1528, MT Status=2, MTMSN=0 2019-09-23T11:52:45.632Z,1569239565.632 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:53:05.973Z,1569239585.973 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:53:22.383Z,1569239602.383 [NAL9602](INFO): SBD MO Status=1, MOMSN=1528, MT Status=0, MTMSN=0 2019-09-23T11:53:22.441Z,1569239602.441 [NAL9602](INFO): Sent 121 bytes from file Logs/20190923T094803/Express0055.lzma 2019-09-23T11:53:22.441Z,1569239602.441 [NAL9602](INFO): Packets left to send: 0 2019-09-23T11:53:41.113Z,1569239621.113 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:53:41.271Z,1569239621.271 [NAL9602](INFO): SBD MO Status=2, MOMSN=1529, MT Status=2, MTMSN=0 2019-09-23T11:53:41.272Z,1569239621.272 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:53:56.991Z,1569239636.991 [NAL9602](INFO): SBD MO Status=2, MOMSN=1529, MT Status=2, MTMSN=0 2019-09-23T11:53:56.991Z,1569239636.991 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T11:54:03.988Z,1569239643.988 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:54:15.657Z,1569239655.657 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:54:16.253Z,1569239656.253 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:54:24.571Z,1569239664.571 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:54:36.783Z,1569239676.783 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:54:40.394Z,1569239680.394 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T11:54:51.405Z,1569239691.405 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:54:54.106Z,1569239694.106 [NAL9602](INFO): SBD MO Status=0, MOMSN=1529, MT Status=0, MTMSN=0 2019-09-23T11:54:54.227Z,1569239694.227 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T11:54:54.227Z,1569239694.227 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T11:54:54.227Z,1569239694.227 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T11:55:24.796Z,1569239724.796 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T11:55:26.545Z,1569239726.545 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:56:01.693Z,1569239761.693 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:56:36.833Z,1569239796.833 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:57:11.973Z,1569239831.973 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:57:47.113Z,1569239867.113 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:58:22.308Z,1569239902.308 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:58:57.445Z,1569239937.445 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:59:32.599Z,1569239972.599 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T11:59:54.718Z,1569239994.718 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T11:59:54.718Z,1569239994.718 [Default:CheckIn:C.Wait] Stopped 2019-09-23T11:59:54.718Z,1569239994.718 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T11:59:54.718Z,1569239994.718 [Default:CheckIn:D] Running Loop=1 2019-09-23T11:59:55.110Z,1569239995.110 [Default:CheckIn:D] Stopped 2019-09-23T11:59:55.110Z,1569239995.110 [Default:CheckIn:E] Running Loop=1 2019-09-23T11:59:55.527Z,1569239995.527 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 131.855428 min 2019-09-23T11:59:55.528Z,1569239995.528 [Default:CheckIn:E] Stopped 2019-09-23T11:59:55.528Z,1569239995.528 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T11:59:55.528Z,1569239995.528 [Default:CheckIn] Stopped 2019-09-23T11:59:55.528Z,1569239995.528 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T11:59:55.528Z,1569239995.528 [Default:CheckIn](INFO): Running loop #20 2019-09-23T11:59:55.528Z,1569239995.528 [Default:CheckIn] Running Loop=20 2019-09-23T11:59:55.528Z,1569239995.528 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T11:59:55.528Z,1569239995.528 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T11:59:57.109Z,1569239997.109 [NAL9602](DEBUG): Fix Requested 2019-09-23T11:59:57.504Z,1569239997.504 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,115902.00,A,3648.16695,N,12147.28059,W,0.253,2.14,230919,,,A*72 2019-09-23T11:59:57.506Z,1569239997.506 [NAL9602](INFO): GPS fix at 20190923T115902: (36.802782, -121.788010) 2019-09-23T11:59:57.606Z,1569239997.606 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T11:59:57.606Z,1569239997.606 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T12:00:07.737Z,1569240007.737 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:00:42.889Z,1569240042.889 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:01:18.029Z,1569240078.029 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:01:18.320Z,1569240078.320 [NAL9602](INFO): SBD MO Status=2, MOMSN=1530, MT Status=2, MTMSN=0 2019-09-23T12:01:18.321Z,1569240078.321 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:01:53.169Z,1569240113.169 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:01:56.340Z,1569240116.340 [NAL9602](INFO): SBD MO Status=2, MOMSN=1530, MT Status=2, MTMSN=0 2019-09-23T12:01:56.340Z,1569240116.340 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:02:28.309Z,1569240148.309 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:02:33.188Z,1569240153.188 [NAL9602](INFO): SBD MO Status=1, MOMSN=1530, MT Status=0, MTMSN=0 2019-09-23T12:02:33.241Z,1569240153.241 [NAL9602](INFO): Sent 64 bytes from file Logs/20190923T094803/Courier0057.lzma 2019-09-23T12:02:33.241Z,1569240153.241 [NAL9602](INFO): Packets left to send: 0 2019-09-23T12:02:45.013Z,1569240165.013 [NAL9602](INFO): SBD MO Status=2, MOMSN=1531, MT Status=2, MTMSN=0 2019-09-23T12:02:45.013Z,1569240165.013 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:03:03.449Z,1569240183.449 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:03:16.268Z,1569240196.268 [NAL9602](INFO): SBD MO Status=2, MOMSN=1531, MT Status=2, MTMSN=0 2019-09-23T12:03:16.268Z,1569240196.268 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:03:38.589Z,1569240218.589 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:03:53.927Z,1569240233.927 [NAL9602](INFO): SBD MO Status=2, MOMSN=1531, MT Status=2, MTMSN=0 2019-09-23T12:03:53.928Z,1569240233.928 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:04:13.749Z,1569240253.749 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:04:36.036Z,1569240276.036 [NAL9602](INFO): SBD MO Status=2, MOMSN=1531, MT Status=2, MTMSN=0 2019-09-23T12:04:36.036Z,1569240276.036 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:04:48.890Z,1569240288.890 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:04:56.967Z,1569240296.967 [NAL9602](INFO): SBD MO Status=1, MOMSN=1531, MT Status=0, MTMSN=0 2019-09-23T12:04:57.021Z,1569240297.021 [NAL9602](INFO): Sent 121 bytes from file Logs/20190923T094803/Express0058.lzma 2019-09-23T12:04:57.021Z,1569240297.021 [NAL9602](INFO): Packets left to send: 0 2019-09-23T12:04:59.607Z,1569240299.607 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2019-09-23T12:04:59.617Z,1569240299.617 [BPC1](INFO): Received data from all battery sticks. 2019-09-23T12:05:06.015Z,1569240306.015 [NAL9602](INFO): SBD MO Status=2, MOMSN=1532, MT Status=2, MTMSN=0 2019-09-23T12:05:06.016Z,1569240306.016 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:05:24.053Z,1569240324.053 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:05:29.779Z,1569240329.779 [NAL9602](INFO): SBD MO Status=2, MOMSN=1532, MT Status=2, MTMSN=0 2019-09-23T12:05:29.780Z,1569240329.780 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:05:36.539Z,1569240336.539 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:05:40.138Z,1569240340.138 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:05:44.259Z,1569240344.259 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:05:56.322Z,1569240356.322 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:05:59.193Z,1569240359.193 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:06:04.832Z,1569240364.832 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:06:14.024Z,1569240374.024 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:06:24.109Z,1569240384.109 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:06:28.469Z,1569240388.469 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:06:34.333Z,1569240394.333 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:06:37.366Z,1569240397.366 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:06:49.128Z,1569240409.128 [NAL9602](INFO): SBD MO Status=2, MOMSN=1532, MT Status=2, MTMSN=0 2019-09-23T12:06:49.128Z,1569240409.128 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:06:55.863Z,1569240415.863 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:07:07.551Z,1569240427.551 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:07:09.485Z,1569240429.485 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:07:11.618Z,1569240431.618 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:07:16.046Z,1569240436.046 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:07:20.434Z,1569240440.434 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:07:28.946Z,1569240448.946 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:07:37.772Z,1569240457.772 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:07:41.788Z,1569240461.788 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:07:44.625Z,1569240464.625 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:07:50.604Z,1569240470.604 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:07:54.978Z,1569240474.978 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:07:59.392Z,1569240479.392 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:08:08.310Z,1569240488.310 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:08:12.443Z,1569240492.443 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:08:16.494Z,1569240496.494 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:08:19.765Z,1569240499.765 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:08:20.078Z,1569240500.078 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:08:24.064Z,1569240504.064 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:08:36.114Z,1569240516.114 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:08:40.519Z,1569240520.519 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:08:54.921Z,1569240534.921 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:09:00.759Z,1569240540.759 [NAL9602](INFO): SBD MO Status=2, MOMSN=1532, MT Status=2, MTMSN=0 2019-09-23T12:09:00.760Z,1569240540.760 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:09:07.576Z,1569240547.576 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:09:19.395Z,1569240559.395 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:09:30.061Z,1569240570.061 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:09:41.743Z,1569240581.743 [NAL9602](INFO): SBD MO Status=2, MOMSN=1532, MT Status=2, MTMSN=0 2019-09-23T12:09:41.744Z,1569240581.744 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:09:48.458Z,1569240588.458 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:09:58.913Z,1569240598.913 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:10:05.201Z,1569240605.201 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:10:06.546Z,1569240606.546 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:10:15.370Z,1569240615.370 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:10:19.738Z,1569240619.738 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T12:10:40.341Z,1569240640.341 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:10:42.434Z,1569240642.434 [NAL9602](INFO): SBD MO Status=2, MOMSN=1532, MT Status=2, MTMSN=0 2019-09-23T12:10:42.435Z,1569240642.435 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:11:04.976Z,1569240664.976 [NAL9602](INFO): SBD MO Status=2, MOMSN=1532, MT Status=2, MTMSN=0 2019-09-23T12:11:04.976Z,1569240664.976 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:11:15.055Z,1569240675.055 [NAL9602](INFO): SBD MO Status=0, MOMSN=1532, MT Status=0, MTMSN=0 2019-09-23T12:11:15.157Z,1569240675.157 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T12:11:15.157Z,1569240675.157 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T12:11:15.157Z,1569240675.157 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T12:11:15.481Z,1569240675.481 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:11:45.752Z,1569240705.752 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T12:11:50.637Z,1569240710.637 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:12:25.821Z,1569240745.821 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:13:00.997Z,1569240780.997 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:13:36.145Z,1569240816.145 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:14:11.285Z,1569240851.285 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:14:46.425Z,1569240886.425 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:15:21.589Z,1569240921.589 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:15:56.753Z,1569240956.753 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:16:15.668Z,1569240975.668 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T12:16:15.668Z,1569240975.668 [Default:CheckIn:C.Wait] Stopped 2019-09-23T12:16:15.668Z,1569240975.668 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T12:16:15.668Z,1569240975.668 [Default:CheckIn:D] Running Loop=1 2019-09-23T12:16:16.084Z,1569240976.084 [Default:CheckIn:D] Stopped 2019-09-23T12:16:16.084Z,1569240976.084 [Default:CheckIn:E] Running Loop=1 2019-09-23T12:16:16.488Z,1569240976.488 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 148.204997 min 2019-09-23T12:16:16.493Z,1569240976.493 [Default:CheckIn:E] Stopped 2019-09-23T12:16:16.493Z,1569240976.493 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T12:16:16.493Z,1569240976.493 [Default:CheckIn] Stopped 2019-09-23T12:16:16.493Z,1569240976.493 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T12:16:16.493Z,1569240976.493 [Default:CheckIn](INFO): Running loop #21 2019-09-23T12:16:16.494Z,1569240976.494 [Default:CheckIn] Running Loop=21 2019-09-23T12:16:16.494Z,1569240976.494 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T12:16:16.494Z,1569240976.494 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T12:16:18.065Z,1569240978.065 [NAL9602](DEBUG): Fix Requested 2019-09-23T12:16:18.460Z,1569240978.460 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,121523.00,A,3648.17426,N,12147.27558,W,0.467,36.19,230919,,,A*41 2019-09-23T12:16:18.470Z,1569240978.470 [NAL9602](INFO): GPS fix at 20190923T121523: (36.802904, -121.787926) 2019-09-23T12:16:18.516Z,1569240978.516 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T12:16:18.516Z,1569240978.516 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T12:16:31.901Z,1569240991.901 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:17:07.061Z,1569241027.061 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:17:42.201Z,1569241062.201 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:18:17.343Z,1569241097.343 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:18:52.501Z,1569241132.501 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:19:08.880Z,1569241148.880 [NAL9602](INFO): SBD MO Status=1, MOMSN=1533, MT Status=0, MTMSN=0 2019-09-23T12:19:08.929Z,1569241148.929 [NAL9602](INFO): Sent 82 bytes from file Logs/20190923T094803/Courier0060.lzma 2019-09-23T12:19:08.929Z,1569241148.929 [NAL9602](INFO): Packets left to send: 0 2019-09-23T12:19:24.824Z,1569241164.824 [NAL9602](INFO): SBD MO Status=2, MOMSN=1534, MT Status=2, MTMSN=0 2019-09-23T12:19:24.824Z,1569241164.824 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:19:27.649Z,1569241167.649 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:19:49.280Z,1569241189.280 [NAL9602](INFO): SBD MO Status=2, MOMSN=1534, MT Status=2, MTMSN=0 2019-09-23T12:19:49.280Z,1569241189.280 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:20:02.789Z,1569241202.789 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:20:20.184Z,1569241220.184 [NAL9602](INFO): SBD MO Status=1, MOMSN=1534, MT Status=0, MTMSN=0 2019-09-23T12:20:20.233Z,1569241220.233 [NAL9602](INFO): Sent 123 bytes from file Logs/20190923T094803/Express0061.lzma 2019-09-23T12:20:20.233Z,1569241220.233 [NAL9602](INFO): Packets left to send: 0 2019-09-23T12:20:28.236Z,1569241228.236 [NAL9602](INFO): SBD MO Status=0, MOMSN=1535, MT Status=0, MTMSN=0 2019-09-23T12:20:28.345Z,1569241228.345 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T12:20:28.345Z,1569241228.345 [Default:CheckIn:C.Wait] Running Loop=1 2019-09-23T12:20:28.345Z,1569241228.345 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-09-23T12:20:37.929Z,1569241237.929 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:20:58.938Z,1569241258.938 [NAL9602](INFO): Not Powering down - fast GPS 2019-09-23T12:21:13.069Z,1569241273.069 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:21:48.209Z,1569241308.209 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:22:06.806Z,1569241326.806 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2019-09-23T12:22:06.806Z,1569241326.806 [DropWeight] Hardware Fault, FailCount= 1 2019-09-23T12:22:06.806Z,1569241326.806 [DropWeight](ERROR): Hardware Fault 2019-09-23T12:22:06.887Z,1569241326.887 [CBIT](INFO): Critical error at 20190923T122206 2019-09-23T12:22:06.894Z,1569241326.894 [CBIT](ERROR): Hardware Fault in component: DropWeight 2019-09-23T12:22:06.894Z,1569241326.894 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2019-09-23T12:22:07.263Z,1569241327.263 [CBIT](INFO): Critical error at 20190923T122206 2019-09-23T12:22:23.357Z,1569241343.357 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:22:58.516Z,1569241378.516 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:23:33.666Z,1569241413.666 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:24:08.805Z,1569241448.805 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:24:43.953Z,1569241483.953 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:25:19.105Z,1569241519.105 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:25:28.848Z,1569241528.848 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-09-23T12:25:28.848Z,1569241528.848 [Default:CheckIn:C.Wait] Stopped 2019-09-23T12:25:28.848Z,1569241528.848 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-09-23T12:25:28.848Z,1569241528.848 [Default:CheckIn:D] Running Loop=1 2019-09-23T12:25:29.261Z,1569241529.261 [Default:CheckIn:D] Stopped 2019-09-23T12:25:29.262Z,1569241529.262 [Default:CheckIn:E] Running Loop=1 2019-09-23T12:25:29.647Z,1569241529.647 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 157.424544 min 2019-09-23T12:25:29.647Z,1569241529.647 [Default:CheckIn:E] Stopped 2019-09-23T12:25:29.648Z,1569241529.648 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-09-23T12:25:29.648Z,1569241529.648 [Default:CheckIn] Stopped 2019-09-23T12:25:29.648Z,1569241529.648 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T12:25:29.648Z,1569241529.648 [Default:CheckIn](INFO): Running loop #22 2019-09-23T12:25:29.648Z,1569241529.648 [Default:CheckIn] Running Loop=22 2019-09-23T12:25:29.648Z,1569241529.648 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-09-23T12:25:29.648Z,1569241529.648 [Default:CheckIn:Read_GPS] Running Loop=1 2019-09-23T12:25:31.245Z,1569241531.245 [NAL9602](DEBUG): Fix Requested 2019-09-23T12:25:31.636Z,1569241531.636 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,122436.00,A,3648.16913,N,12147.28023,W,0.078,0.00,230919,,,A*7C 2019-09-23T12:25:31.649Z,1569241531.649 [NAL9602](INFO): GPS fix at 20190923T122436: (36.802819, -121.788004) 2019-09-23T12:25:31.683Z,1569241531.683 [Default:CheckIn:Read_GPS] Stopped 2019-09-23T12:25:31.683Z,1569241531.683 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-09-23T12:25:54.265Z,1569241554.265 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:26:29.405Z,1569241589.405 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:27:04.545Z,1569241624.545 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:27:06.107Z,1569241626.107 [NAL9602](INFO): SBD MO Status=2, MOMSN=1536, MT Status=2, MTMSN=0 2019-09-23T12:27:06.107Z,1569241626.107 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:27:33.278Z,1569241653.278 [NAL9602](INFO): SBD MO Status=2, MOMSN=1536, MT Status=2, MTMSN=0 2019-09-23T12:27:33.278Z,1569241653.278 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:27:39.701Z,1569241659.701 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:28:03.371Z,1569241683.371 [NAL9602](INFO): SBD MO Status=2, MOMSN=1536, MT Status=2, MTMSN=0 2019-09-23T12:28:03.372Z,1569241683.372 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:28:14.849Z,1569241694.849 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:28:49.989Z,1569241729.989 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:28:57.307Z,1569241737.307 [NAL9602](INFO): SBD MO Status=2, MOMSN=1536, MT Status=2, MTMSN=0 2019-09-23T12:28:57.308Z,1569241737.308 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:29:17.479Z,1569241757.479 [NAL9602](INFO): SBD MO Status=1, MOMSN=1536, MT Status=0, MTMSN=0 2019-09-23T12:29:17.533Z,1569241757.533 [NAL9602](INFO): Sent 140 bytes from file Logs/20190923T094803/Courier0063.lzma 2019-09-23T12:29:17.533Z,1569241757.533 [NAL9602](INFO): Packets left to send: 0 2019-09-23T12:29:25.129Z,1569241765.129 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:29:32.919Z,1569241772.919 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T12:29:32.919Z,1569241772.919 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:30:00.269Z,1569241800.269 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:30:24.392Z,1569241824.392 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T12:30:24.392Z,1569241824.392 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:30:35.425Z,1569241835.425 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:30:56.788Z,1569241856.788 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T12:30:56.788Z,1569241856.788 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:31:10.565Z,1569241870.565 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:31:45.717Z,1569241905.717 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:32:20.861Z,1569241940.861 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:32:55.245Z,1569241975.245 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T12:32:55.245Z,1569241975.245 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:32:56.001Z,1569241976.001 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:33:31.145Z,1569242011.145 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:34:06.289Z,1569242046.289 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:34:41.429Z,1569242081.429 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:35:16.569Z,1569242116.569 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:35:51.709Z,1569242151.709 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:36:26.851Z,1569242186.851 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:37:01.997Z,1569242221.997 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:37:07.335Z,1569242227.335 [CBIT](INFO): Clearing failed state for component DropWeight 2019-09-23T12:37:07.335Z,1569242227.335 [DropWeight] No Fault, FailCount= 1 2019-09-23T12:37:27.188Z,1569242247.188 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T12:37:27.189Z,1569242247.189 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:37:37.137Z,1569242257.137 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:38:12.277Z,1569242292.277 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:38:22.887Z,1569242302.887 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T12:38:22.887Z,1569242302.887 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:38:47.429Z,1569242327.429 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:39:22.569Z,1569242362.569 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:39:33.828Z,1569242373.828 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T12:39:33.828Z,1569242373.828 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:39:55.740Z,1569242395.740 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T12:39:55.740Z,1569242395.740 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:39:57.710Z,1569242397.710 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:40:32.849Z,1569242432.849 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:40:42.830Z,1569242442.830 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T12:40:42.830Z,1569242442.830 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:41:07.993Z,1569242467.993 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:41:43.133Z,1569242503.133 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:42:18.273Z,1569242538.273 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:42:53.413Z,1569242573.413 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:43:28.553Z,1569242608.553 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:44:03.693Z,1569242643.693 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:44:38.841Z,1569242678.841 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:45:13.981Z,1569242713.981 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:45:49.129Z,1569242749.129 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:46:24.269Z,1569242784.269 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:46:59.409Z,1569242819.409 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:47:34.549Z,1569242854.549 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:48:02.671Z,1569242882.671 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T12:48:02.672Z,1569242882.672 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:48:09.713Z,1569242889.713 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:48:20.000Z,1569242901.000 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T12:48:20.000Z,1569242901.000 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T12:48:44.853Z,1569242924.853 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:49:19.993Z,1569242959.993 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:49:55.133Z,1569242995.133 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:50:30.285Z,1569243030.285 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:51:05.425Z,1569243065.425 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:51:40.565Z,1569243100.565 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:52:15.705Z,1569243135.705 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:52:50.845Z,1569243170.845 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:53:25.985Z,1569243205.985 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:54:01.125Z,1569243241.125 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:54:36.281Z,1569243276.281 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:55:11.421Z,1569243311.421 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:55:46.561Z,1569243346.561 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:56:21.701Z,1569243381.701 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:56:56.842Z,1569243416.842 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:57:31.981Z,1569243451.981 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:58:07.133Z,1569243487.133 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:58:42.273Z,1569243522.273 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:59:17.413Z,1569243557.413 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T12:59:52.553Z,1569243592.553 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:00:04.911Z,1569243604.911 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T13:00:04.912Z,1569243604.912 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:00:27.693Z,1569243627.693 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:01:02.841Z,1569243662.841 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:01:37.981Z,1569243697.981 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:02:13.125Z,1569243733.125 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:02:48.282Z,1569243768.282 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:03:23.429Z,1569243803.429 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:03:58.569Z,1569243838.569 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:04:33.709Z,1569243873.709 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:05:08.857Z,1569243908.857 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:05:43.999Z,1569243943.999 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:06:19.145Z,1569243979.145 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:06:54.313Z,1569244014.313 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:07:08.366Z,1569244028.366 [DropWeight](CRITICAL): DROP WEIGHT MISSING. 2019-09-23T13:07:08.366Z,1569244028.366 [DropWeight] Hardware Fault, FailCount= 1 2019-09-23T13:07:08.366Z,1569244028.366 [DropWeight](ERROR): Hardware Fault 2019-09-23T13:07:08.454Z,1569244028.454 [CBIT](INFO): Critical error at 20190923T130708 2019-09-23T13:07:08.456Z,1569244028.456 [CBIT](ERROR): Hardware Fault in component: DropWeight 2019-09-23T13:07:08.457Z,1569244028.457 [CBIT](CRITICAL): Hardware Fault in component: DropWeight 2019-09-23T13:07:08.840Z,1569244028.840 [CBIT](INFO): Critical error at 20190923T130708 2019-09-23T13:07:29.463Z,1569244049.463 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:08:04.601Z,1569244084.601 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:08:39.741Z,1569244119.741 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:09:14.937Z,1569244154.937 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:09:43.655Z,1569244183.655 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T13:09:43.655Z,1569244183.655 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:09:50.085Z,1569244190.085 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:10:25.227Z,1569244225.227 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:11:00.385Z,1569244260.385 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:11:35.525Z,1569244295.525 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:12:10.665Z,1569244330.665 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:12:28.660Z,1569244348.660 [BPC1](INFO): Calculating totals. Valid battery stick count: 56. Valid reserve battery stick count: 6. 2019-09-23T13:12:28.667Z,1569244348.667 [BPC1](INFO): Received data from all battery sticks. 2019-09-23T13:12:45.805Z,1569244365.805 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:13:20.953Z,1569244400.953 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:13:56.093Z,1569244436.093 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:14:31.233Z,1569244471.233 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:15:06.373Z,1569244506.373 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:15:41.521Z,1569244541.521 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:16:16.669Z,1569244576.669 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:16:51.817Z,1569244611.817 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:17:26.965Z,1569244646.965 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:18:02.105Z,1569244682.105 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:18:09.547Z,1569244689.547 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T13:18:09.547Z,1569244689.547 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:18:37.245Z,1569244717.245 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:18:44.111Z,1569244724.111 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T13:18:44.112Z,1569244724.112 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:19:12.385Z,1569244752.385 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:19:29.119Z,1569244769.119 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T13:19:29.119Z,1569244769.119 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:19:47.525Z,1569244787.525 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:20:08.239Z,1569244808.239 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T13:20:08.239Z,1569244808.239 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:20:22.665Z,1569244822.665 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:20:38.375Z,1569244838.375 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T13:20:38.375Z,1569244838.375 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:20:57.807Z,1569244857.807 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:21:32.945Z,1569244892.945 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:22:08.086Z,1569244928.086 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:22:09.580Z,1569244929.580 [CBIT](INFO): Clearing failed state for component DropWeight 2019-09-23T13:22:09.580Z,1569244929.580 [DropWeight] No Fault, FailCount= 1 2019-09-23T13:22:43.233Z,1569244963.233 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:23:18.373Z,1569244998.373 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:23:53.521Z,1569245033.521 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:24:28.661Z,1569245068.661 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:25:03.801Z,1569245103.801 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:25:38.949Z,1569245138.949 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:26:14.105Z,1569245174.105 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:26:49.261Z,1569245209.261 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:27:24.409Z,1569245244.409 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:27:39.791Z,1569245259.791 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T13:27:39.792Z,1569245259.792 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:27:59.550Z,1569245279.550 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:28:06.558Z,1569245286.558 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T13:28:06.559Z,1569245286.559 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:28:33.711Z,1569245313.711 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T13:28:33.712Z,1569245313.712 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:28:34.693Z,1569245314.693 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:28:59.423Z,1569245339.423 [NAL9602](INFO): SBD MO Status=2, MOMSN=1537, MT Status=2, MTMSN=0 2019-09-23T13:28:59.424Z,1569245339.424 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:29:09.849Z,1569245349.849 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:29:20.103Z,1569245360.103 [NAL9602](INFO): SBD MO Status=1, MOMSN=1537, MT Status=0, MTMSN=0 2019-09-23T13:29:20.165Z,1569245360.165 [NAL9602](INFO): Sent 120 bytes from file Logs/20190923T094803/Express0064.lzma 2019-09-23T13:29:20.165Z,1569245360.165 [NAL9602](INFO): Packets left to send: 0 2019-09-23T13:29:36.552Z,1569245376.552 [NAL9602](INFO): SBD MO Status=2, MOMSN=1538, MT Status=2, MTMSN=0 2019-09-23T13:29:36.552Z,1569245376.552 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:29:43.275Z,1569245383.275 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:29:44.989Z,1569245384.989 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:29:52.478Z,1569245392.478 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:30:04.188Z,1569245404.188 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:30:08.562Z,1569245408.562 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:30:12.985Z,1569245412.985 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:30:17.552Z,1569245417.552 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:30:20.129Z,1569245420.129 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:30:21.576Z,1569245421.576 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:30:30.021Z,1569245430.021 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:30:34.586Z,1569245434.586 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:30:39.067Z,1569245439.067 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:30:42.642Z,1569245442.642 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:30:46.738Z,1569245446.738 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:30:55.269Z,1569245455.269 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:30:57.624Z,1569245457.624 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:31:02.036Z,1569245462.036 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:31:10.466Z,1569245470.466 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:31:14.822Z,1569245474.822 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:31:19.191Z,1569245479.191 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:31:23.079Z,1569245483.079 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:31:27.152Z,1569245487.152 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:31:30.421Z,1569245490.421 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:31:30.763Z,1569245490.763 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:31:34.752Z,1569245494.752 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:31:38.307Z,1569245498.307 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:31:42.311Z,1569245502.311 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:31:45.978Z,1569245505.978 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:31:49.963Z,1569245509.963 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:31:53.538Z,1569245513.538 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:31:58.449Z,1569245518.449 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:32:02.166Z,1569245522.166 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:32:05.561Z,1569245525.561 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:32:06.558Z,1569245526.558 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:32:10.120Z,1569245530.120 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:32:14.512Z,1569245534.512 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:32:18.551Z,1569245538.551 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:32:22.118Z,1569245542.118 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:32:26.514Z,1569245546.514 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:32:38.580Z,1569245558.580 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:32:40.701Z,1569245560.701 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:32:42.612Z,1569245562.612 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:32:51.441Z,1569245571.441 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:32:55.835Z,1569245575.835 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:32:59.816Z,1569245579.816 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:33:03.446Z,1569245583.446 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:33:07.510Z,1569245587.510 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:33:11.496Z,1569245591.496 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:33:15.464Z,1569245595.464 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:33:15.845Z,1569245595.845 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:33:19.062Z,1569245599.062 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:33:23.503Z,1569245603.503 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:33:27.112Z,1569245607.112 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:33:31.484Z,1569245611.484 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:33:35.203Z,1569245615.203 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:33:39.276Z,1569245619.276 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:33:42.855Z,1569245622.855 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:33:47.159Z,1569245627.159 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:33:50.857Z,1569245630.857 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:33:50.993Z,1569245630.993 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:33:55.316Z,1569245635.316 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:33:58.865Z,1569245638.865 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:34:03.218Z,1569245643.218 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:34:06.972Z,1569245646.972 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:34:10.972Z,1569245650.972 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:34:14.517Z,1569245654.517 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:34:18.837Z,1569245658.837 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:34:26.133Z,1569245666.133 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:34:29.008Z,1569245669.008 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:34:32.558Z,1569245672.558 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:34:36.912Z,1569245676.912 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:34:40.656Z,1569245680.656 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:34:44.696Z,1569245684.696 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:34:54.364Z,1569245694.364 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:34:58.341Z,1569245698.341 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:35:01.285Z,1569245701.285 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:35:14.965Z,1569245714.965 [NAL9602](INFO): SBD MO Status=2, MOMSN=1538, MT Status=2, MTMSN=0 2019-09-23T13:35:14.965Z,1569245714.965 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:35:21.303Z,1569245721.303 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:35:33.049Z,1569245733.049 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:35:36.433Z,1569245736.433 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:35:37.428Z,1569245737.428 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:35:46.012Z,1569245746.012 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:35:50.509Z,1569245750.509 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:35:54.523Z,1569245754.523 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:36:03.475Z,1569245763.475 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:36:07.515Z,1569245767.515 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:36:11.637Z,1569245771.637 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:36:11.911Z,1569245771.911 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:36:20.730Z,1569245780.730 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:36:29.162Z,1569245789.162 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:36:33.582Z,1569245793.582 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:36:42.043Z,1569245802.043 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:36:46.456Z,1569245806.456 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:36:46.793Z,1569245806.793 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:36:55.318Z,1569245815.318 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:37:03.354Z,1569245823.354 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:37:07.901Z,1569245827.901 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:37:12.409Z,1569245832.409 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:37:16.416Z,1569245836.416 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:37:20.844Z,1569245840.844 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:37:21.945Z,1569245841.945 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:37:24.601Z,1569245844.601 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:37:41.647Z,1569245861.647 [NAL9602](INFO): SBD MO Status=2, MOMSN=1538, MT Status=2, MTMSN=0 2019-09-23T13:37:41.648Z,1569245861.648 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:37:54.907Z,1569245874.907 [NAL9602](INFO): SBD MO Status=2, MOMSN=1538, MT Status=2, MTMSN=0 2019-09-23T13:37:54.908Z,1569245874.908 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:37:57.117Z,1569245877.117 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:38:12.688Z,1569245892.688 [NAL9602](INFO): SBD MO Status=2, MOMSN=1538, MT Status=2, MTMSN=0 2019-09-23T13:38:12.688Z,1569245892.688 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:38:19.472Z,1569245899.472 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:38:32.277Z,1569245912.277 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:38:44.768Z,1569245924.768 [NAL9602](INFO): SBD MO Status=2, MOMSN=1538, MT Status=2, MTMSN=0 2019-09-23T13:38:44.768Z,1569245924.768 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:38:51.532Z,1569245931.532 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:39:01.182Z,1569245941.182 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:39:07.441Z,1569245947.441 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:39:16.188Z,1569245956.188 [NAL9602](INFO): SBD MO Status=2, MOMSN=1538, MT Status=2, MTMSN=0 2019-09-23T13:39:16.188Z,1569245956.188 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:39:29.104Z,1569245969.104 [NAL9602](INFO): SBD MO Status=2, MOMSN=1538, MT Status=2, MTMSN=0 2019-09-23T13:39:29.105Z,1569245969.105 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:39:35.837Z,1569245975.837 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:39:42.593Z,1569245982.593 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:40:04.951Z,1569246004.951 [NAL9602](INFO): SBD MO Status=2, MOMSN=1538, MT Status=2, MTMSN=0 2019-09-23T13:40:04.952Z,1569246004.952 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-09-23T13:40:11.694Z,1569246011.694 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:40:17.734Z,1569246017.734 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:40:23.363Z,1569246023.363 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:40:27.764Z,1569246027.764 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:40:32.103Z,1569246032.103 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:40:40.882Z,1569246040.882 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:40:44.473Z,1569246044.473 [CommandLine](IMPORTANT): got command failComponent 2019-09-23T13:40:44.474Z,1569246044.474 [CommandLine](IMPORTANT): Failed components: 2019-09-23T13:40:44.474Z,1569246044.474 [CommandLine](IMPORTANT): No failed Components. 2019-09-23T13:40:45.410Z,1569246045.410 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:40:49.407Z,1569246049.407 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:40:52.873Z,1569246052.873 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:40:53.025Z,1569246053.025 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:40:57.027Z,1569246057.027 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:41:00.671Z,1569246060.671 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:41:04.645Z,1569246064.645 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:41:08.281Z,1569246068.281 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:41:12.786Z,1569246072.786 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:41:16.380Z,1569246076.380 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:41:20.760Z,1569246080.760 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:41:24.453Z,1569246084.453 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:41:28.013Z,1569246088.013 [DataOverHttps](INFO): Exceeded connect timeout, disconnecting. 2019-09-23T13:41:28.479Z,1569246088.479 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:41:32.126Z,1569246092.126 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:41:36.186Z,1569246096.186 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:41:45.380Z,1569246105.380 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0 2019-09-23T13:41:48.374Z,1569246108.374 [CommandLine](IMPORTANT): got command restart application 2019-09-23T13:41:49.385Z,1569246109.385 [CommandLine ThreadHandler](INFO): Uninitializing protected caller thread. 2019-09-23T13:41:49.385Z,1569246109.385 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:49.409Z,1569246109.409 [Supervisor](DEBUG): Uninitializing supervisor and starting cleanup. Bye! 2019-09-23T13:41:49.409Z,1569246109.409 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:49.410Z,1569246109.410 [CommandLine](INFO): Join timeout helper Thread ID is 3818 2019-09-23T13:41:49.410Z,1569246109.410 [ComponentRegistry](INFO): Shutting down NavChartDb ThreadHandler 2019-09-23T13:41:49.410Z,1569246109.410 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:49.411Z,1569246109.411 [NavChartDb](INFO): Join timeout helper Thread ID is 3819 2019-09-23T13:41:49.757Z,1569246109.757 [NavChartDb ThreadHandler](INFO): Uninitializing protected caller thread. 2019-09-23T13:41:49.757Z,1569246109.757 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:49.777Z,1569246109.777 [ComponentRegistry](INFO): Shutting down WetLabsBB2FL ThreadHandler 2019-09-23T13:41:49.777Z,1569246109.777 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:49.777Z,1569246109.777 [WetLabsBB2FL](INFO): Join timeout helper Thread ID is 3820 2019-09-23T13:41:50.197Z,1569246110.197 [WetLabsBB2FL ThreadHandler](INFO): Uninitializing protected caller thread. 2019-09-23T13:41:50.197Z,1569246110.197 [WetLabsBB2FL](INFO): Powering down 2019-09-23T13:41:50.198Z,1569246110.198 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:50.201Z,1569246110.201 [ComponentRegistry](INFO): Shutting down CTD_Seabird ThreadHandler 2019-09-23T13:41:50.201Z,1569246110.201 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:50.201Z,1569246110.201 [CTD_Seabird](INFO): Join timeout helper Thread ID is 3821 2019-09-23T13:41:50.329Z,1569246110.329 [CTD_Seabird](INFO): Powering down 2019-09-23T13:41:50.341Z,1569246110.341 [CTD_Seabird ThreadHandler](INFO): Uninitializing protected caller thread. 2019-09-23T13:41:50.341Z,1569246110.341 [CTD_Seabird](INFO): Powering down 2019-09-23T13:41:50.353Z,1569246110.353 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:50.365Z,1569246110.365 [ComponentRegistry](INFO): Shutting down Radio_Surface ThreadHandler 2019-09-23T13:41:50.365Z,1569246110.365 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:50.365Z,1569246110.365 [Radio_Surface](INFO): Join timeout helper Thread ID is 3822 2019-09-23T13:41:50.381Z,1569246110.381 [Radio_Surface](INFO): Powering down 2019-09-23T13:41:50.382Z,1569246110.382 [Radio_Surface ThreadHandler](INFO): Uninitializing protected caller thread. 2019-09-23T13:41:50.382Z,1569246110.382 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:50.390Z,1569246110.390 [ComponentRegistry](INFO): Shutting down DataOverHttps ThreadHandler 2019-09-23T13:41:50.390Z,1569246110.390 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:50.390Z,1569246110.390 [DataOverHttps](INFO): Join timeout helper Thread ID is 3823 2019-09-23T13:41:51.105Z,1569246111.105 [DataOverHttps ThreadHandler](INFO): Uninitializing protected caller thread. 2019-09-23T13:41:51.105Z,1569246111.105 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:51.112Z,1569246111.112 [ComponentRegistry](INFO): Shutting down logger ThreadHandler 2019-09-23T13:41:51.112Z,1569246111.112 [logger ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:51.113Z,1569246111.113 [logger](INFO): Join timeout helper Thread ID is 3824 2019-09-23T13:41:51.113Z,1569246111.113 [logger ThreadHandler](INFO): Uninitializing protected caller thread. 2019-09-23T13:41:51.113Z,1569246111.113 [logger ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:51.118Z,1569246111.118 [ComponentRegistry](INFO): Shutting down CommandLine ThreadHandler 2019-09-23T13:41:51.118Z,1569246111.118 [CommandLine ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:51.118Z,1569246111.118 [ComponentRegistry](INFO): Shutting down controlThread ThreadHandler 2019-09-23T13:41:51.118Z,1569246111.118 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:51.118Z,1569246111.118 [controlThread](INFO): Join timeout helper Thread ID is 3825 2019-09-23T13:41:51.163Z,1569246111.163 [controlThread ThreadHandler](INFO): Uninitializing protected caller thread. 2019-09-23T13:41:51.163Z,1569246111.163 [controlThread](DEBUG): Uninitializing ControlThread 2019-09-23T13:41:51.163Z,1569246111.163 [AHRS_M2](INFO): Powering down 2019-09-23T13:41:51.233Z,1569246111.233 [NAL9602](INFO): Powering down 2019-09-23T13:41:51.235Z,1569246111.235 [DAT](INFO): Powering down 2019-09-23T13:41:51.353Z,1569246111.353 [BR_Ping1D](INFO): Powering down 2019-09-23T13:41:51.426Z,1569246111.426 [DepthRateCalculator](DEBUG): Uninitializing DepthRateCalculator. 2019-09-23T13:41:51.426Z,1569246111.426 [ElevatorOffsetCalculator](DEBUG): Uninitializing ElevatorOffsetCalculator. 2019-09-23T13:41:51.427Z,1569246111.427 [NavChart](DEBUG): Uninitialize NavChart Navigation. 2019-09-23T13:41:51.427Z,1569246111.427 [MissionManager](INFO): Uninitializing Mission Default 2019-09-23T13:41:51.427Z,1569246111.427 [Default] Stopped 2019-09-23T13:41:51.428Z,1569246111.428 [Default](DEBUG): Aggregate::uninitialize Default 2019-09-23T13:41:51.428Z,1569246111.428 [Default:B.GoToSurface] Stopped 2019-09-23T13:41:51.428Z,1569246111.428 [Default:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent. 2019-09-23T13:41:51.428Z,1569246111.428 [Default:CheckIn] Stopped 2019-09-23T13:41:51.428Z,1569246111.428 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-09-23T13:41:51.428Z,1569246111.428 [Default:CheckIn:Read_Iridium] Stopped 2019-09-23T13:41:51.431Z,1569246111.431 [VerticalControl](DEBUG): Uninitialize VerticalControlComponent. 2019-09-23T13:41:51.431Z,1569246111.431 [HorizontalControl](DEBUG): Uninitialize HorizontalControlComponent. 2019-09-23T13:41:51.431Z,1569246111.431 [SpeedControl](DEBUG): Uninitialize SpeedControlComponent. 2019-09-23T13:41:51.432Z,1569246111.432 [LoopControl](DEBUG): Uninitialize LoopControlComponent. 2019-09-23T13:41:51.432Z,1569246111.432 [BuoyancyServo](DEBUG): Uninitialize Buoyancy Servo. 2019-09-23T13:41:51.432Z,1569246111.432 [BuoyancyServo](INFO): Powering down 2019-09-23T13:41:51.445Z,1569246111.445 [ElevatorServo](DEBUG): Uninitialize Elevator Servo. 2019-09-23T13:41:51.445Z,1569246111.445 [ElevatorServo](INFO): Powering down 2019-09-23T13:41:51.446Z,1569246111.446 [MassServo](DEBUG): Uninitialize Mass Servo. 2019-09-23T13:41:51.446Z,1569246111.446 [MassServo](INFO): Powering down 2019-09-23T13:41:51.447Z,1569246111.447 [RudderServo](DEBUG): Uninitialize Rudder Servo. 2019-09-23T13:41:51.447Z,1569246111.447 [RudderServo](INFO): Powering down 2019-09-23T13:41:51.447Z,1569246111.447 [ThrusterServo](DEBUG): Uninitialize Thruster Servo. 2019-09-23T13:41:51.448Z,1569246111.448 [ThrusterServo](INFO): Powering down 2019-09-23T13:41:51.448Z,1569246111.448 [SBIT](DEBUG): Uninitialize SBIT Component. 2019-09-23T13:41:51.449Z,1569246111.449 [IBIT](DEBUG): Uninitialize IBIT Component. 2019-09-23T13:41:51.449Z,1569246111.449 [CBIT](DEBUG): Uninitialize CBIT Component. 2019-09-23T13:41:51.449Z,1569246111.449 [CBIT](DEBUG): Powering off loads. 2019-09-23T13:41:51.461Z,1569246111.461 [CBIT](DEBUG): Disabling WDT. 2019-09-23T13:41:51.473Z,1569246111.473 [CBIT](DEBUG): Opening all GF detection circuits. 2019-09-23T13:41:51.474Z,1569246111.474 [controlThread ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:51.558Z,1569246111.558 [Radio_Surface ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:51.565Z,1569246111.565 [DataOverHttps ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:51.616Z,1569246111.616 [WetLabsBB2FL ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:51.619Z,1569246111.619 [CTD_Seabird ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:51.656Z,1569246111.656 [NavChartDb ThreadHandler](INFO): Thread cancelled. 2019-09-23T13:41:51.725Z,1569246111.725 [logger ThreadHandler](INFO): Thread cancelled.