2019-11-14T18:36:34.724Z,1573756594.724 [CommandLine](IMPORTANT): got command restart logs 2019-11-14T18:38:14.819Z,1573756694.819 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-11-14T18:38:14.819Z,1573756694.819 [Default:CheckIn:C.Wait] Stopped 2019-11-14T18:38:14.819Z,1573756694.819 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-11-14T18:38:14.819Z,1573756694.819 [Default:CheckIn:D] Running Loop=1 2019-11-14T18:38:15.195Z,1573756695.195 [Default:CheckIn:D] Stopped 2019-11-14T18:38:15.195Z,1573756695.195 [Default:CheckIn:E] Running Loop=1 2019-11-14T18:38:15.616Z,1573756695.616 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 20.748029 min 2019-11-14T18:38:15.616Z,1573756695.616 [Default:CheckIn:E] Stopped 2019-11-14T18:38:15.616Z,1573756695.616 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-11-14T18:38:15.616Z,1573756695.616 [Default:CheckIn] Stopped 2019-11-14T18:38:15.616Z,1573756695.616 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-11-14T18:38:15.616Z,1573756695.616 [Default:CheckIn](INFO): Running loop #4 2019-11-14T18:38:15.616Z,1573756695.616 [Default:CheckIn] Running Loop=4 2019-11-14T18:38:15.616Z,1573756695.616 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-11-14T18:38:15.616Z,1573756695.616 [Default:CheckIn:Read_GPS] Running Loop=1 2019-11-14T18:38:17.598Z,1573756697.598 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,183132.00,A,3648.48441,N,12149.91857,W,23.929,86.75,141119,,,D*78 2019-11-14T18:38:17.600Z,1573756697.600 [NAL9602](INFO): GPS fix at 20191114T183132: (36.808073, -121.831976) 2019-11-14T18:38:17.651Z,1573756697.651 [Default:CheckIn:Read_GPS] Stopped 2019-11-14T18:38:17.651Z,1573756697.651 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-11-14T18:38:25.370Z,1573756705.370 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20191114T151552/Courier0030.lzma 2019-11-14T18:38:27.377Z,1573756707.377 [DataOverHttps](INFO): Moved sent file to Logs/20191114T151552/Courier0030.lzma.bak 2019-11-14T18:38:27.377Z,1573756707.377 [DataOverHttps](INFO): SBD MOMSN=12018921 2019-11-14T18:39:20.217Z,1573756760.217 [NAL9602](INFO): SBD MO Status=2, MOMSN=17858, MT Status=2, MTMSN=0 2019-11-14T18:39:20.218Z,1573756760.218 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-11-14T18:40:02.987Z,1573756802.987 [DataOverHttps](INFO): Sending 212 bytes from file Logs/20191114T183634/Courier0000.lzma 2019-11-14T18:40:04.992Z,1573756804.992 [DataOverHttps](INFO): Moved sent file to Logs/20191114T183634/Courier0000.lzma.bak 2019-11-14T18:40:04.993Z,1573756804.993 [DataOverHttps](INFO): SBD MOMSN=12019241 2019-11-14T18:40:50.715Z,1573756850.715 [DataOverHttps](INFO): Sending 25 bytes from file Logs/20191114T183634/Courier0003.lzma 2019-11-14T18:40:52.720Z,1573756852.720 [DataOverHttps](INFO): Moved sent file to Logs/20191114T183634/Courier0003.lzma.bak 2019-11-14T18:40:52.721Z,1573756852.721 [DataOverHttps](INFO): SBD MOMSN=12019403 2019-11-14T18:41:38.455Z,1573756898.455 [DataOverHttps](INFO): Sending 190 bytes from file Logs/20191114T151552/Express0031.lzma 2019-11-14T18:41:40.461Z,1573756900.461 [DataOverHttps](INFO): Moved sent file to Logs/20191114T151552/Express0031.lzma.bak 2019-11-14T18:41:40.461Z,1573756900.461 [DataOverHttps](INFO): SBD MOMSN=12019562 2019-11-14T18:42:12.791Z,1573756932.791 [DataOverHttps](INFO): Sending 341 bytes from file Logs/20191114T183634/Express0001.lzma 2019-11-14T18:42:14.811Z,1573756934.811 [DataOverHttps](INFO): Moved sent file to Logs/20191114T183634/Express0001.lzma.bak 2019-11-14T18:42:14.811Z,1573756934.811 [DataOverHttps](INFO): SBD MOMSN=12019566 2019-11-14T18:42:31.875Z,1573756951.875 [DataOverHttps](INFO): Sending 62 bytes from file Logs/20191114T183634/Express0004.lzma 2019-11-14T18:42:33.880Z,1573756953.880 [DataOverHttps](INFO): Moved sent file to Logs/20191114T183634/Express0004.lzma.bak 2019-11-14T18:42:33.881Z,1573756953.881 [DataOverHttps](INFO): SBD MOMSN=12019570 2019-11-14T18:42:35.395Z,1573756955.395 [Default:CheckIn:Read_Iridium] Stopped 2019-11-14T18:42:35.396Z,1573756955.396 [Default:CheckIn:C.Wait] Running Loop=1 2019-11-14T18:42:35.396Z,1573756955.396 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-11-14T18:43:14.947Z,1573756994.947 [NAL9602](INFO): SBD MO Status=2, MOMSN=17858, MT Status=2, MTMSN=0 2019-11-14T18:43:14.948Z,1573756994.948 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2 2019-11-14T18:43:19.800Z,1573756999.800 [NAL9602](FAULT): MT Queue status failed to be acquired within timeout. Will not retry this session. 2019-11-14T18:43:50.500Z,1573757030.500 [NAL9602](INFO): Not Powering down - fast GPS 2019-11-14T18:47:35.966Z,1573757255.966 [Default:CheckIn:C.Wait](INFO): Done Waiting. 2019-11-14T18:47:35.966Z,1573757255.966 [Default:CheckIn:C.Wait] Stopped 2019-11-14T18:47:35.966Z,1573757255.966 [Default:CheckIn:C.Wait](DEBUG): Uninitialize Wait Component. 2019-11-14T18:47:35.967Z,1573757255.967 [Default:CheckIn:D] Running Loop=1 2019-11-14T18:47:36.368Z,1573757256.368 [Default:CheckIn:D] Stopped 2019-11-14T18:47:36.368Z,1573757256.368 [Default:CheckIn:E] Running Loop=1 2019-11-14T18:47:36.777Z,1573757256.777 [Default:CheckIn:E](IMPORTANT): Default mission has been running for 30.100903 min 2019-11-14T18:47:36.777Z,1573757256.777 [Default:CheckIn:E] Stopped 2019-11-14T18:47:36.777Z,1573757256.777 [Default:CheckIn](INFO): Completed Default:CheckIn 2019-11-14T18:47:36.777Z,1573757256.777 [Default:CheckIn] Stopped 2019-11-14T18:47:36.777Z,1573757256.777 [Default:CheckIn](DEBUG): Aggregate::uninitialize Default:CheckIn 2019-11-14T18:47:36.777Z,1573757256.777 [Default:CheckIn](INFO): Running loop #5 2019-11-14T18:47:36.777Z,1573757256.777 [Default:CheckIn] Running Loop=5 2019-11-14T18:47:36.778Z,1573757256.778 [Default:CheckIn](DEBUG): Aggregate::initialize Default:CheckIn 2019-11-14T18:47:36.778Z,1573757256.778 [Default:CheckIn:Read_GPS] Running Loop=1 2019-11-14T18:47:38.770Z,1573757258.770 [NAL9602](DEBUG): Parsing RMC sentence: $GPRMC,184052.00,A,3648.58628,N,12149.43867,W,1.069,316.30,141119,,,D*7E 2019-11-14T18:47:38.772Z,1573757258.772 [NAL9602](INFO): GPS fix at 20191114T184052: (36.809771, -121.823978) 2019-11-14T18:47:38.823Z,1573757258.823 [Default:CheckIn:Read_GPS] Stopped 2019-11-14T18:47:38.823Z,1573757258.823 [Default:CheckIn:Read_Iridium] Running Loop=1 2019-11-14T18:47:46.619Z,1573757266.619 [DataOverHttps](INFO): Sending 61 bytes from file Logs/20191114T183634/Courier0006.lzma 2019-11-14T18:47:48.624Z,1573757268.624 [DataOverHttps](INFO): Moved sent file to Logs/20191114T183634/Courier0006.lzma.bak 2019-11-14T18:47:48.625Z,1573757268.625 [DataOverHttps](INFO): SBD MOMSN=12019590 2019-11-14T18:48:05.731Z,1573757285.731 [DataOverHttps](INFO): Sending 235 bytes from file Logs/20191114T183634/Express0007.lzma 2019-11-14T18:48:07.736Z,1573757287.736 [DataOverHttps](INFO): Moved sent file to Logs/20191114T183634/Express0007.lzma.bak 2019-11-14T18:48:07.737Z,1573757287.737 [DataOverHttps](INFO): SBD MOMSN=12019593 2019-11-14T18:48:09.103Z,1573757289.103 [Default:CheckIn:Read_Iridium] Stopped 2019-11-14T18:48:09.103Z,1573757289.103 [Default:CheckIn:C.Wait] Running Loop=1 2019-11-14T18:48:09.103Z,1573757289.103 [Default:CheckIn:C.Wait](DEBUG): Initialize Wait Component. 2019-11-14T18:48:14.726Z,1573757294.726 [NAL9602](IMPORTANT): SBD MO Status=0, MOMSN=17858, MT Status=1, MTMSN=2166 2019-11-14T18:48:14.726Z,1573757294.726 [NAL9602](INFO): Data available in MT queue 2019-11-14T18:48:15.223Z,1573757295.223 [NAL9602](INFO): Received command:restart logs