2013-10-11T20:30:37.569Z,1381523437.569 [CommandLine](IMPORTANT): got command restart logs
2013-10-11T20:30:55.724Z,1381523455.724 [NAL9602](INFO): SBD MO Status=1, MOMSN=20192, MT Status=0, MTMSN=0
2013-10-11T20:30:55.773Z,1381523455.773 [NAL9602](INFO): Sent 209 bytes from file Logs/20131011T202939/Courier0000.lzma
2013-10-11T20:30:55.774Z,1381523455.774 [NAL9602](INFO): Packets left to send: 0
2013-10-11T20:30:55.779Z,1381523455.779 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T202939/Courier0000.lzma.parts/0000.sbd
2013-10-11T20:31:08.255Z,1381523468.255 [NAL9602](INFO): SBD MO Status=1, MOMSN=20193, MT Status=0, MTMSN=0
2013-10-11T20:31:08.317Z,1381523468.317 [NAL9602](INFO): Sent 237 bytes from file Logs/20131011T175257/Express0037.lzma
2013-10-11T20:31:08.317Z,1381523468.317 [NAL9602](INFO): Packets left to send: 0
2013-10-11T20:31:08.325Z,1381523468.325 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T175257/Express0037.lzma.parts/0000.sbd
2013-10-11T20:31:25.222Z,1381523485.222 [NAL9602](INFO): SBD MO Status=2, MOMSN=20194, MT Status=2, MTMSN=0
2013-10-11T20:31:25.222Z,1381523485.222 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T20:32:02.363Z,1381523522.363 [NAL9602](INFO): SBD MO Status=1, MOMSN=20194, MT Status=0, MTMSN=0
2013-10-11T20:32:02.419Z,1381523522.419 [NAL9602](INFO): Sent 332 bytes from file Logs/20131011T202939/Express0001.lzma
2013-10-11T20:32:02.419Z,1381523522.419 [NAL9602](INFO): Packets left to send: 1
2013-10-11T20:32:02.421Z,1381523522.421 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T202939/Express0001.lzma.parts/0001.sbd
2013-10-11T20:32:14.217Z,1381523534.217 [NAL9602](INFO): SBD MO Status=2, MOMSN=20195, MT Status=2, MTMSN=0
2013-10-11T20:32:14.218Z,1381523534.218 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T20:32:34.385Z,1381523554.385 [NAL9602](INFO): SBD MO Status=2, MOMSN=20195, MT Status=2, MTMSN=0
2013-10-11T20:32:34.385Z,1381523554.385 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T20:32:47.361Z,1381523567.361 [NAL9602](INFO): SBD MO Status=1, MOMSN=20195, MT Status=0, MTMSN=0
2013-10-11T20:32:47.416Z,1381523567.416 [NAL9602](INFO): Sent 86 bytes from file Logs/20131011T202939/Express0001.lzma
2013-10-11T20:32:47.416Z,1381523567.416 [NAL9602](INFO): Packets left to send: 0
2013-10-11T20:32:47.418Z,1381523567.418 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T202939/Express0001.lzma.parts/0000.sbd
2013-10-11T20:33:00.397Z,1381523580.397 [NAL9602](INFO): SBD MO Status=2, MOMSN=20196, MT Status=2, MTMSN=0
2013-10-11T20:33:00.398Z,1381523580.398 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T20:33:05.951Z,1381523585.951 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0
2013-10-11T20:33:08.538Z,1381523588.538 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0
2013-10-11T20:33:24.919Z,1381523604.919 [NAL9602](INFO): SBD MO Status=2, MOMSN=20196, MT Status=2, MTMSN=0
2013-10-11T20:33:24.919Z,1381523604.919 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T20:33:49.525Z,1381523629.525 [NAL9602](INFO): SBD MO Status=0, MOMSN=20196, MT Status=0, MTMSN=0
2013-10-11T20:34:17.725Z,1381523657.725 [NAL9602](INFO): SBD MO Status=2, MOMSN=20197, MT Status=2, MTMSN=0
2013-10-11T20:34:17.725Z,1381523657.725 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T20:34:48.293Z,1381523688.293 [NAL9602](INFO): SBD MO Status=1, MOMSN=20197, MT Status=0, MTMSN=0
2013-10-11T20:34:48.362Z,1381523688.362 [NAL9602](INFO): Sent 25 bytes from file Logs/20131011T203037/Courier0000.lzma
2013-10-11T20:34:48.362Z,1381523688.362 [NAL9602](INFO): Packets left to send: 0
2013-10-11T20:34:48.364Z,1381523688.364 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Courier0000.lzma.parts/0000.sbd
2013-10-11T20:35:04.069Z,1381523704.069 [NAL9602](INFO): SBD MO Status=2, MOMSN=20198, MT Status=2, MTMSN=0
2013-10-11T20:35:04.069Z,1381523704.069 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T20:35:28.619Z,1381523728.619 [NAL9602](INFO): SBD MO Status=2, MOMSN=20198, MT Status=2, MTMSN=0
2013-10-11T20:35:28.619Z,1381523728.619 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T20:35:50.333Z,1381523750.333 [NAL9602](INFO): SBD MO Status=2, MOMSN=20198, MT Status=2, MTMSN=0
2013-10-11T20:35:50.333Z,1381523750.333 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T20:36:25.968Z,1381523785.968 [NAL9602](INFO): SBD MO Status=2, MOMSN=20198, MT Status=2, MTMSN=0
2013-10-11T20:36:25.968Z,1381523785.968 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T20:36:44.136Z,1381523804.136 [NAL9602](INFO): SBD MO Status=2, MOMSN=20198, MT Status=2, MTMSN=0
2013-10-11T20:36:44.136Z,1381523804.136 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T20:37:26.193Z,1381523846.193 [NAL9602](INFO): SBD MO Status=2, MOMSN=20198, MT Status=2, MTMSN=0
2013-10-11T20:37:26.193Z,1381523846.193 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T20:37:47.486Z,1381523867.486 [NAL9602](INFO): SBD MO Status=1, MOMSN=20198, MT Status=0, MTMSN=0
2013-10-11T20:37:47.540Z,1381523867.540 [NAL9602](INFO): Sent 253 bytes from file Logs/20131011T203037/Express0001.lzma
2013-10-11T20:37:47.540Z,1381523867.540 [NAL9602](INFO): Packets left to send: 0
2013-10-11T20:37:47.542Z,1381523867.542 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Express0001.lzma.parts/0000.sbd
2013-10-11T20:37:57.334Z,1381523877.334 [NAL9602](INFO): SBD MO Status=0, MOMSN=20199, MT Status=0, MTMSN=0
2013-10-11T20:38:01.026Z,1381523881.026 [Default:Iridium:Read_Iridium] Stopped
2013-10-11T20:38:01.027Z,1381523881.027 [Default:Iridium](INFO): Completed Default:Iridium
2013-10-11T20:38:01.027Z,1381523881.027 [Default:Iridium] Stopped
2013-10-11T20:38:01.027Z,1381523881.027 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-10-11T20:38:01.027Z,1381523881.027 [Default:Iridium:A.SetSpeed] Stopped
2013-10-11T20:38:01.027Z,1381523881.027 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-10-11T20:38:01.290Z,1381523881.290 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-10-11T20:38:01.290Z,1381523881.290 [Default:CallIridium:B] Stopped
2013-10-11T20:38:01.291Z,1381523881.291 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-10-11T20:38:01.291Z,1381523881.291 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-10-11T20:38:01.291Z,1381523881.291 [Default:CallIridium] Stopped
2013-10-11T20:38:01.291Z,1381523881.291 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-10-11T20:38:11.248Z,1381523891.248 [NAL9602](INFO): Powering down
2013-10-11T20:43:01.271Z,1381524181.271 [Default:CallIridium] Running Loop=1
2013-10-11T20:43:01.271Z,1381524181.271 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-10-11T20:43:01.272Z,1381524181.272 [Default:CallIridium:A] Running Loop=1
2013-10-11T20:43:01.273Z,1381524181.273 [Default:CallIridium:A] Stopped
2013-10-11T20:43:01.273Z,1381524181.273 [Default:CallIridium:B] Running Loop=1
2013-10-11T20:43:01.273Z,1381524181.273 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-10-11T20:43:06.269Z,1381524186.269 [Default:Iridium] Running Loop=1
2013-10-11T20:43:06.269Z,1381524186.269 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-10-11T20:43:06.269Z,1381524186.269 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-10-11T20:43:06.269Z,1381524186.269 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-10-11T20:43:06.269Z,1381524186.269 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-10-11T20:43:06.269Z,1381524186.269 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-10-11T20:43:06.270Z,1381524186.270 [Default:Iridium:B.GoToSurface] Stopped
2013-10-11T20:43:06.270Z,1381524186.270 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-10-11T20:43:06.270Z,1381524186.270 [Default:Iridium:Read_Iridium] Running Loop=1
2013-10-11T20:43:06.271Z,1381524186.271 [Default:GPS] Running Loop=1
2013-10-11T20:43:06.271Z,1381524186.271 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-10-11T20:43:06.271Z,1381524186.271 [Default:GPS:A.SetSpeed] Running Loop=1
2013-10-11T20:43:06.271Z,1381524186.271 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-10-11T20:43:06.271Z,1381524186.271 [Default:GPS:B.GoToSurface] Running Loop=1
2013-10-11T20:43:06.271Z,1381524186.271 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-10-11T20:43:06.272Z,1381524186.272 [Default:GPS:B.GoToSurface] Stopped
2013-10-11T20:43:06.272Z,1381524186.272 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-10-11T20:43:06.272Z,1381524186.272 [Default:GPS:Read_GPS] Running Loop=1
2013-10-11T20:43:07.014Z,1381524187.014 [NAL9602](INFO): Powering up
2013-10-11T20:43:17.455Z,1381524197.455 [NAL9602](INFO): NAL9602 initialized
2013-10-11T20:43:35.049Z,1381524215.049 [NAL9602](INFO): SBD MO Status=1, MOMSN=20200, MT Status=0, MTMSN=0
2013-10-11T20:43:35.117Z,1381524215.117 [NAL9602](INFO): Sent 25 bytes from file Logs/20131011T203037/Courier0004.lzma
2013-10-11T20:43:35.117Z,1381524215.117 [NAL9602](INFO): Packets left to send: 0
2013-10-11T20:43:35.118Z,1381524215.118 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Courier0004.lzma.parts/0000.sbd
2013-10-11T20:43:46.858Z,1381524226.858 [NAL9602](INFO): SBD MO Status=1, MOMSN=20201, MT Status=0, MTMSN=0
2013-10-11T20:43:46.905Z,1381524226.905 [NAL9602](INFO): Sent 189 bytes from file Logs/20131011T203037/Express0005.lzma
2013-10-11T20:43:46.905Z,1381524226.905 [NAL9602](INFO): Packets left to send: 0
2013-10-11T20:43:46.908Z,1381524226.908 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Express0005.lzma.parts/0000.sbd
2013-10-11T20:43:58.333Z,1381524238.333 [NAL9602](INFO): SBD MO Status=0, MOMSN=20202, MT Status=0, MTMSN=0
2013-10-11T20:44:01.996Z,1381524241.996 [Default:Iridium:Read_Iridium] Stopped
2013-10-11T20:44:01.997Z,1381524241.997 [Default:Iridium](INFO): Completed Default:Iridium
2013-10-11T20:44:01.997Z,1381524241.997 [Default:Iridium] Stopped
2013-10-11T20:44:01.997Z,1381524241.997 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-10-11T20:44:01.997Z,1381524241.997 [Default:Iridium:A.SetSpeed] Stopped
2013-10-11T20:44:01.997Z,1381524241.997 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-10-11T20:44:02.272Z,1381524242.272 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-10-11T20:44:02.272Z,1381524242.272 [Default:CallIridium:B] Stopped
2013-10-11T20:44:02.272Z,1381524242.272 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-10-11T20:44:02.273Z,1381524242.273 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-10-11T20:44:02.273Z,1381524242.273 [Default:CallIridium] Stopped
2013-10-11T20:44:02.273Z,1381524242.273 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-10-11T20:48:01.432Z,1381524481.432 [NAL9602](IMPORTANT): GPS fix at: 1381524501.00
2013-10-11T20:48:01.450Z,1381524481.450 [Default:GPS:Read_GPS] Stopped
2013-10-11T20:48:01.450Z,1381524481.450 [Default:GPS:D] Running Loop=1
2013-10-11T20:48:01.857Z,1381524481.857 [Default:GPS:D] Stopped
2013-10-11T20:48:01.858Z,1381524481.858 [Default:GPS](INFO): Completed Default:GPS
2013-10-11T20:48:01.858Z,1381524481.858 [Default:GPS] Stopped
2013-10-11T20:48:01.858Z,1381524481.858 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-10-11T20:48:01.858Z,1381524481.858 [Default:GPS:A.SetSpeed] Stopped
2013-10-11T20:48:01.858Z,1381524481.858 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-10-11T20:48:22.261Z,1381524502.261 [NAL9602](INFO): Powering down
2013-10-11T20:49:02.277Z,1381524542.277 [Default:CallIridium] Running Loop=1
2013-10-11T20:49:02.277Z,1381524542.277 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-10-11T20:49:02.277Z,1381524542.277 [Default:CallIridium:A] Running Loop=1
2013-10-11T20:49:02.278Z,1381524542.278 [Default:CallIridium:A] Stopped
2013-10-11T20:49:02.278Z,1381524542.278 [Default:CallIridium:B] Running Loop=1
2013-10-11T20:49:02.278Z,1381524542.278 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-10-11T20:49:07.274Z,1381524547.274 [Default:Iridium] Running Loop=1
2013-10-11T20:49:07.275Z,1381524547.275 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-10-11T20:49:07.275Z,1381524547.275 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-10-11T20:49:07.275Z,1381524547.275 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-10-11T20:49:07.275Z,1381524547.275 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-10-11T20:49:07.275Z,1381524547.275 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-10-11T20:49:07.276Z,1381524547.276 [Default:Iridium:B.GoToSurface] Stopped
2013-10-11T20:49:07.276Z,1381524547.276 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-10-11T20:49:07.276Z,1381524547.276 [Default:Iridium:Read_Iridium] Running Loop=1
2013-10-11T20:49:07.276Z,1381524547.276 [Default:GPS] Running Loop=1
2013-10-11T20:49:07.276Z,1381524547.276 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-10-11T20:49:07.276Z,1381524547.276 [Default:GPS:A.SetSpeed] Running Loop=1
2013-10-11T20:49:07.276Z,1381524547.276 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-10-11T20:49:07.277Z,1381524547.277 [Default:GPS:B.GoToSurface] Running Loop=1
2013-10-11T20:49:07.277Z,1381524547.277 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-10-11T20:49:07.278Z,1381524547.278 [Default:GPS:B.GoToSurface] Stopped
2013-10-11T20:49:07.278Z,1381524547.278 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-10-11T20:49:07.278Z,1381524547.278 [Default:GPS:Read_GPS] Running Loop=1
2013-10-11T20:49:08.026Z,1381524548.026 [NAL9602](INFO): Powering up
2013-10-11T20:49:18.860Z,1381524558.860 [NAL9602](INFO): NAL9602 initialized
2013-10-11T20:49:36.365Z,1381524576.365 [NAL9602](INFO): SBD MO Status=1, MOMSN=20203, MT Status=0, MTMSN=0
2013-10-11T20:49:36.415Z,1381524576.415 [NAL9602](INFO): Sent 206 bytes from file Logs/20131011T203037/Courier0008.lzma
2013-10-11T20:49:36.415Z,1381524576.415 [NAL9602](INFO): Packets left to send: 0
2013-10-11T20:49:36.417Z,1381524576.417 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Courier0008.lzma.parts/0000.sbd
2013-10-11T20:49:46.916Z,1381524586.916 [NAL9602](INFO): SBD MO Status=1, MOMSN=20204, MT Status=0, MTMSN=0
2013-10-11T20:49:46.963Z,1381524586.963 [NAL9602](INFO): Sent 157 bytes from file Logs/20131011T203037/Express0009.lzma
2013-10-11T20:49:46.963Z,1381524586.963 [NAL9602](INFO): Packets left to send: 0
2013-10-11T20:49:46.965Z,1381524586.965 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Express0009.lzma.parts/0000.sbd
2013-10-11T20:49:55.179Z,1381524595.179 [NAL9602](INFO): SBD MO Status=0, MOMSN=20205, MT Status=0, MTMSN=0
2013-10-11T20:49:58.867Z,1381524598.867 [Default:Iridium:Read_Iridium] Stopped
2013-10-11T20:49:58.868Z,1381524598.868 [Default:Iridium](INFO): Completed Default:Iridium
2013-10-11T20:49:58.868Z,1381524598.868 [Default:Iridium] Stopped
2013-10-11T20:49:58.868Z,1381524598.868 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-10-11T20:49:58.868Z,1381524598.868 [Default:Iridium:A.SetSpeed] Stopped
2013-10-11T20:49:58.868Z,1381524598.868 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-10-11T20:49:59.133Z,1381524599.133 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-10-11T20:49:59.133Z,1381524599.133 [Default:CallIridium:B] Stopped
2013-10-11T20:49:59.134Z,1381524599.134 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-10-11T20:49:59.134Z,1381524599.134 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-10-11T20:49:59.134Z,1381524599.134 [Default:CallIridium] Stopped
2013-10-11T20:49:59.134Z,1381524599.134 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-10-11T20:50:11.473Z,1381524611.473 [NAL9602](IMPORTANT): GPS fix at: 1381524630.00
2013-10-11T20:50:11.492Z,1381524611.492 [Default:GPS:Read_GPS] Stopped
2013-10-11T20:50:11.492Z,1381524611.492 [Default:GPS:D] Running Loop=1
2013-10-11T20:50:11.891Z,1381524611.891 [Default:GPS:D] Stopped
2013-10-11T20:50:11.892Z,1381524611.892 [Default:GPS](INFO): Completed Default:GPS
2013-10-11T20:50:11.892Z,1381524611.892 [Default:GPS] Stopped
2013-10-11T20:50:11.892Z,1381524611.892 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-10-11T20:50:11.892Z,1381524611.892 [Default:GPS:A.SetSpeed] Stopped
2013-10-11T20:50:11.892Z,1381524611.892 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-10-11T20:50:32.303Z,1381524632.303 [NAL9602](INFO): Powering down
2013-10-11T20:54:57.326Z,1381524897.326 [Default:CallIridium] Running Loop=1
2013-10-11T20:54:57.326Z,1381524897.326 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-10-11T20:54:57.326Z,1381524897.326 [Default:CallIridium:A] Running Loop=1
2013-10-11T20:54:57.327Z,1381524897.327 [Default:CallIridium:A] Stopped
2013-10-11T20:54:57.327Z,1381524897.327 [Default:CallIridium:B] Running Loop=1
2013-10-11T20:54:57.327Z,1381524897.327 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-10-11T20:55:02.330Z,1381524902.330 [Default:Iridium] Running Loop=1
2013-10-11T20:55:02.331Z,1381524902.331 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-10-11T20:55:02.331Z,1381524902.331 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-10-11T20:55:02.331Z,1381524902.331 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-10-11T20:55:02.331Z,1381524902.331 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-10-11T20:55:02.331Z,1381524902.331 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-10-11T20:55:02.334Z,1381524902.334 [Default:Iridium:B.GoToSurface] Stopped
2013-10-11T20:55:02.334Z,1381524902.334 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-10-11T20:55:02.335Z,1381524902.335 [Default:Iridium:Read_Iridium] Running Loop=1
2013-10-11T20:55:02.335Z,1381524902.335 [Default:GPS] Running Loop=1
2013-10-11T20:55:02.335Z,1381524902.335 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-10-11T20:55:02.335Z,1381524902.335 [Default:GPS:A.SetSpeed] Running Loop=1
2013-10-11T20:55:02.335Z,1381524902.335 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-10-11T20:55:02.335Z,1381524902.335 [Default:GPS:B.GoToSurface] Running Loop=1
2013-10-11T20:55:02.335Z,1381524902.335 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-10-11T20:55:02.336Z,1381524902.336 [Default:GPS:B.GoToSurface] Stopped
2013-10-11T20:55:02.336Z,1381524902.336 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-10-11T20:55:02.336Z,1381524902.336 [Default:GPS:Read_GPS] Running Loop=1
2013-10-11T20:55:03.062Z,1381524903.062 [NAL9602](INFO): Powering up
2013-10-11T20:55:13.497Z,1381524913.497 [NAL9602](INFO): NAL9602 initialized
2013-10-11T20:55:28.674Z,1381524928.674 [NAL9602](INFO): SBD MO Status=1, MOMSN=20206, MT Status=0, MTMSN=0
2013-10-11T20:55:28.721Z,1381524928.721 [NAL9602](INFO): Sent 60 bytes from file Logs/20131011T203037/Courier0012.lzma
2013-10-11T20:55:28.721Z,1381524928.721 [NAL9602](INFO): Packets left to send: 0
2013-10-11T20:55:28.723Z,1381524928.723 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Courier0012.lzma.parts/0000.sbd
2013-10-11T20:55:38.038Z,1381524938.038 [NAL9602](INFO): SBD MO Status=1, MOMSN=20207, MT Status=0, MTMSN=0
2013-10-11T20:55:38.088Z,1381524938.088 [NAL9602](INFO): Sent 120 bytes from file Logs/20131011T203037/Express0013.lzma
2013-10-11T20:55:38.088Z,1381524938.088 [NAL9602](INFO): Packets left to send: 0
2013-10-11T20:55:38.091Z,1381524938.091 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Express0013.lzma.parts/0000.sbd
2013-10-11T20:55:46.347Z,1381524946.347 [NAL9602](INFO): SBD MO Status=0, MOMSN=20208, MT Status=0, MTMSN=0
2013-10-11T20:55:50.122Z,1381524950.122 [Default:Iridium:Read_Iridium] Stopped
2013-10-11T20:55:50.123Z,1381524950.123 [Default:Iridium](INFO): Completed Default:Iridium
2013-10-11T20:55:50.123Z,1381524950.123 [Default:Iridium] Stopped
2013-10-11T20:55:50.123Z,1381524950.123 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-10-11T20:55:50.123Z,1381524950.123 [Default:Iridium:A.SetSpeed] Stopped
2013-10-11T20:55:50.123Z,1381524950.123 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-10-11T20:55:50.370Z,1381524950.370 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-10-11T20:55:50.370Z,1381524950.370 [Default:CallIridium:B] Stopped
2013-10-11T20:55:50.370Z,1381524950.370 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-10-11T20:55:50.370Z,1381524950.370 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-10-11T20:55:50.370Z,1381524950.370 [Default:CallIridium] Stopped
2013-10-11T20:55:50.371Z,1381524950.371 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-10-11T20:55:51.124Z,1381524951.124 [NAL9602](IMPORTANT): GPS fix at: 1381524969.00
2013-10-11T20:55:51.142Z,1381524951.142 [Default:GPS:Read_GPS] Stopped
2013-10-11T20:55:51.142Z,1381524951.142 [Default:GPS:D] Running Loop=1
2013-10-11T20:55:51.556Z,1381524951.556 [Default:GPS:D] Stopped
2013-10-11T20:55:51.557Z,1381524951.557 [Default:GPS](INFO): Completed Default:GPS
2013-10-11T20:55:51.557Z,1381524951.557 [Default:GPS] Stopped
2013-10-11T20:55:51.557Z,1381524951.557 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-10-11T20:55:51.557Z,1381524951.557 [Default:GPS:A.SetSpeed] Stopped
2013-10-11T20:55:51.557Z,1381524951.557 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-10-11T20:56:11.957Z,1381524971.957 [NAL9602](INFO): Powering down
2013-10-11T21:00:46.963Z,1381525246.963 [Default:CallIridium] Running Loop=1
2013-10-11T21:00:46.964Z,1381525246.964 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-10-11T21:00:46.964Z,1381525246.964 [Default:CallIridium:A] Running Loop=1
2013-10-11T21:00:46.964Z,1381525246.964 [Default:CallIridium:A] Stopped
2013-10-11T21:00:46.964Z,1381525246.964 [Default:CallIridium:B] Running Loop=1
2013-10-11T21:00:46.964Z,1381525246.964 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-10-11T21:00:51.969Z,1381525251.969 [Default:Iridium] Running Loop=1
2013-10-11T21:00:51.969Z,1381525251.969 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-10-11T21:00:51.969Z,1381525251.969 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-10-11T21:00:51.969Z,1381525251.969 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-10-11T21:00:51.970Z,1381525251.970 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-10-11T21:00:51.970Z,1381525251.970 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-10-11T21:00:51.971Z,1381525251.971 [Default:Iridium:B.GoToSurface] Stopped
2013-10-11T21:00:51.971Z,1381525251.971 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-10-11T21:00:51.971Z,1381525251.971 [Default:Iridium:Read_Iridium] Running Loop=1
2013-10-11T21:00:51.971Z,1381525251.971 [Default:GPS] Running Loop=1
2013-10-11T21:00:51.971Z,1381525251.971 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-10-11T21:00:51.971Z,1381525251.971 [Default:GPS:A.SetSpeed] Running Loop=1
2013-10-11T21:00:51.971Z,1381525251.971 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-10-11T21:00:51.972Z,1381525251.972 [Default:GPS:B.GoToSurface] Running Loop=1
2013-10-11T21:00:51.972Z,1381525251.972 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-10-11T21:00:51.972Z,1381525251.972 [Default:GPS:B.GoToSurface] Stopped
2013-10-11T21:00:51.972Z,1381525251.972 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-10-11T21:00:51.973Z,1381525251.973 [Default:GPS:Read_GPS] Running Loop=1
2013-10-11T21:00:52.713Z,1381525252.713 [NAL9602](INFO): Powering up
2013-10-11T21:01:03.156Z,1381525263.156 [NAL9602](INFO): NAL9602 initialized
2013-10-11T21:01:20.221Z,1381525280.221 [NAL9602](INFO): SBD MO Status=1, MOMSN=20209, MT Status=0, MTMSN=0
2013-10-11T21:01:20.270Z,1381525280.270 [NAL9602](INFO): Sent 60 bytes from file Logs/20131011T203037/Courier0016.lzma
2013-10-11T21:01:20.270Z,1381525280.270 [NAL9602](INFO): Packets left to send: 0
2013-10-11T21:01:20.272Z,1381525280.272 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Courier0016.lzma.parts/0000.sbd
2013-10-11T21:01:31.562Z,1381525291.562 [NAL9602](INFO): SBD MO Status=1, MOMSN=20210, MT Status=0, MTMSN=0
2013-10-11T21:01:31.617Z,1381525291.617 [NAL9602](INFO): Sent 119 bytes from file Logs/20131011T203037/Express0017.lzma
2013-10-11T21:01:31.617Z,1381525291.617 [NAL9602](INFO): Packets left to send: 0
2013-10-11T21:01:31.619Z,1381525291.619 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Express0017.lzma.parts/0000.sbd
2013-10-11T21:01:39.842Z,1381525299.842 [NAL9602](INFO): SBD MO Status=0, MOMSN=20211, MT Status=0, MTMSN=0
2013-10-11T21:01:43.463Z,1381525303.463 [Default:Iridium:Read_Iridium] Stopped
2013-10-11T21:01:43.464Z,1381525303.464 [Default:Iridium](INFO): Completed Default:Iridium
2013-10-11T21:01:43.467Z,1381525303.467 [Default:Iridium] Stopped
2013-10-11T21:01:43.467Z,1381525303.467 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-10-11T21:01:43.467Z,1381525303.467 [Default:Iridium:A.SetSpeed] Stopped
2013-10-11T21:01:43.467Z,1381525303.467 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-10-11T21:01:43.746Z,1381525303.746 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-10-11T21:01:43.746Z,1381525303.746 [Default:CallIridium:B] Stopped
2013-10-11T21:01:43.746Z,1381525303.746 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-10-11T21:01:43.747Z,1381525303.747 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-10-11T21:01:43.747Z,1381525303.747 [Default:CallIridium] Stopped
2013-10-11T21:01:43.747Z,1381525303.747 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-10-11T21:02:14.466Z,1381525334.466 [NAL9602](IMPORTANT): GPS fix at: 1381525353.00
2013-10-11T21:02:14.484Z,1381525334.484 [Default:GPS:Read_GPS] Stopped
2013-10-11T21:02:14.484Z,1381525334.484 [Default:GPS:D] Running Loop=1
2013-10-11T21:02:14.898Z,1381525334.898 [Default:GPS:D] Stopped
2013-10-11T21:02:14.899Z,1381525334.899 [Default:GPS](INFO): Completed Default:GPS
2013-10-11T21:02:14.899Z,1381525334.899 [Default:GPS] Stopped
2013-10-11T21:02:14.900Z,1381525334.900 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-10-11T21:02:14.900Z,1381525334.900 [Default:GPS:A.SetSpeed] Stopped
2013-10-11T21:02:14.900Z,1381525334.900 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-10-11T21:02:35.332Z,1381525355.332 [NAL9602](INFO): Powering down
2013-10-11T21:06:40.329Z,1381525600.329 [Default:CallIridium] Running Loop=1
2013-10-11T21:06:40.330Z,1381525600.330 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-10-11T21:06:40.330Z,1381525600.330 [Default:CallIridium:A] Running Loop=1
2013-10-11T21:06:40.330Z,1381525600.330 [Default:CallIridium:A] Stopped
2013-10-11T21:06:40.331Z,1381525600.331 [Default:CallIridium:B] Running Loop=1
2013-10-11T21:06:40.331Z,1381525600.331 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-10-11T21:06:45.328Z,1381525605.328 [Default:Iridium] Running Loop=1
2013-10-11T21:06:45.328Z,1381525605.328 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-10-11T21:06:45.328Z,1381525605.328 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-10-11T21:06:45.328Z,1381525605.328 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-10-11T21:06:45.329Z,1381525605.329 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-10-11T21:06:45.329Z,1381525605.329 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-10-11T21:06:45.329Z,1381525605.329 [Default:Iridium:B.GoToSurface] Stopped
2013-10-11T21:06:45.330Z,1381525605.330 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-10-11T21:06:45.330Z,1381525605.330 [Default:Iridium:Read_Iridium] Running Loop=1
2013-10-11T21:06:45.330Z,1381525605.330 [Default:GPS] Running Loop=1
2013-10-11T21:06:45.330Z,1381525605.330 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-10-11T21:06:45.330Z,1381525605.330 [Default:GPS:A.SetSpeed] Running Loop=1
2013-10-11T21:06:45.330Z,1381525605.330 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-10-11T21:06:45.331Z,1381525605.331 [Default:GPS:B.GoToSurface] Running Loop=1
2013-10-11T21:06:45.331Z,1381525605.331 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-10-11T21:06:45.331Z,1381525605.331 [Default:GPS:B.GoToSurface] Stopped
2013-10-11T21:06:45.332Z,1381525605.332 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-10-11T21:06:45.332Z,1381525605.332 [Default:GPS:Read_GPS] Running Loop=1
2013-10-11T21:06:46.068Z,1381525606.068 [NAL9602](INFO): Powering up
2013-10-11T21:06:56.900Z,1381525616.900 [NAL9602](INFO): NAL9602 initialized
2013-10-11T21:07:11.970Z,1381525631.970 [NAL9602](INFO): SBD MO Status=1, MOMSN=20212, MT Status=0, MTMSN=0
2013-10-11T21:07:12.028Z,1381525632.028 [NAL9602](INFO): Sent 58 bytes from file Logs/20131011T203037/Courier0020.lzma
2013-10-11T21:07:12.028Z,1381525632.028 [NAL9602](INFO): Packets left to send: 0
2013-10-11T21:07:12.029Z,1381525632.029 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Courier0020.lzma.parts/0000.sbd
2013-10-11T21:07:19.314Z,1381525639.314 [NAL9602](INFO): SBD MO Status=1, MOMSN=20213, MT Status=0, MTMSN=0
2013-10-11T21:07:19.363Z,1381525639.363 [NAL9602](INFO): Sent 107 bytes from file Logs/20131011T203037/Express0021.lzma
2013-10-11T21:07:19.363Z,1381525639.363 [NAL9602](INFO): Packets left to send: 0
2013-10-11T21:07:19.365Z,1381525639.365 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Express0021.lzma.parts/0000.sbd
2013-10-11T21:07:28.131Z,1381525648.131 [NAL9602](INFO): SBD MO Status=0, MOMSN=20214, MT Status=0, MTMSN=0
2013-10-11T21:07:31.742Z,1381525651.742 [Default:Iridium:Read_Iridium] Stopped
2013-10-11T21:07:31.743Z,1381525651.743 [Default:Iridium](INFO): Completed Default:Iridium
2013-10-11T21:07:31.743Z,1381525651.743 [Default:Iridium] Stopped
2013-10-11T21:07:31.743Z,1381525651.743 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-10-11T21:07:31.743Z,1381525651.743 [Default:Iridium:A.SetSpeed] Stopped
2013-10-11T21:07:31.743Z,1381525651.743 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-10-11T21:07:32.002Z,1381525652.002 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-10-11T21:07:32.002Z,1381525652.002 [Default:CallIridium:B] Stopped
2013-10-11T21:07:32.003Z,1381525652.003 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-10-11T21:07:32.003Z,1381525652.003 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-10-11T21:07:32.003Z,1381525652.003 [Default:CallIridium] Stopped
2013-10-11T21:07:32.003Z,1381525652.003 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-10-11T21:07:44.346Z,1381525664.346 [NAL9602](IMPORTANT): GPS fix at: 1381525682.00
2013-10-11T21:07:44.364Z,1381525664.364 [Default:GPS:Read_GPS] Stopped
2013-10-11T21:07:44.364Z,1381525664.364 [Default:GPS:D] Running Loop=1
2013-10-11T21:07:44.768Z,1381525664.768 [Default:GPS:D] Stopped
2013-10-11T21:07:44.768Z,1381525664.768 [Default:GPS](INFO): Completed Default:GPS
2013-10-11T21:07:44.768Z,1381525664.768 [Default:GPS] Stopped
2013-10-11T21:07:44.768Z,1381525664.768 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-10-11T21:07:44.768Z,1381525664.768 [Default:GPS:A.SetSpeed] Stopped
2013-10-11T21:07:44.769Z,1381525664.769 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-10-11T21:08:05.177Z,1381525685.177 [NAL9602](INFO): Powering down
2013-10-11T21:12:30.192Z,1381525950.192 [Default:CallIridium] Running Loop=1
2013-10-11T21:12:30.192Z,1381525950.192 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-10-11T21:12:30.193Z,1381525950.193 [Default:CallIridium:A] Running Loop=1
2013-10-11T21:12:30.194Z,1381525950.194 [Default:CallIridium:A] Stopped
2013-10-11T21:12:30.194Z,1381525950.194 [Default:CallIridium:B] Running Loop=1
2013-10-11T21:12:30.194Z,1381525950.194 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-10-11T21:12:35.193Z,1381525955.193 [Default:Iridium] Running Loop=1
2013-10-11T21:12:35.193Z,1381525955.193 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-10-11T21:12:35.193Z,1381525955.193 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-10-11T21:12:35.193Z,1381525955.193 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-10-11T21:12:35.193Z,1381525955.193 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-10-11T21:12:35.194Z,1381525955.194 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-10-11T21:12:35.194Z,1381525955.194 [Default:Iridium:B.GoToSurface] Stopped
2013-10-11T21:12:35.194Z,1381525955.194 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-10-11T21:12:35.194Z,1381525955.194 [Default:Iridium:Read_Iridium] Running Loop=1
2013-10-11T21:12:35.195Z,1381525955.195 [Default:GPS] Running Loop=1
2013-10-11T21:12:35.195Z,1381525955.195 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-10-11T21:12:35.195Z,1381525955.195 [Default:GPS:A.SetSpeed] Running Loop=1
2013-10-11T21:12:35.195Z,1381525955.195 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-10-11T21:12:35.195Z,1381525955.195 [Default:GPS:B.GoToSurface] Running Loop=1
2013-10-11T21:12:35.195Z,1381525955.195 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-10-11T21:12:35.196Z,1381525955.196 [Default:GPS:B.GoToSurface] Stopped
2013-10-11T21:12:35.196Z,1381525955.196 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-10-11T21:12:35.196Z,1381525955.196 [Default:GPS:Read_GPS] Running Loop=1
2013-10-11T21:12:35.937Z,1381525955.937 [NAL9602](INFO): Powering up
2013-10-11T21:12:46.378Z,1381525966.378 [NAL9602](INFO): NAL9602 initialized
2013-10-11T21:13:11.123Z,1381525991.123 [NAL9602](INFO): SBD MO Status=1, MOMSN=20215, MT Status=0, MTMSN=0
2013-10-11T21:13:11.172Z,1381525991.172 [NAL9602](INFO): Sent 60 bytes from file Logs/20131011T203037/Courier0024.lzma
2013-10-11T21:13:11.172Z,1381525991.172 [NAL9602](INFO): Packets left to send: 0
2013-10-11T21:13:11.174Z,1381525991.174 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Courier0024.lzma.parts/0000.sbd
2013-10-11T21:13:20.493Z,1381526000.493 [NAL9602](INFO): SBD MO Status=1, MOMSN=20216, MT Status=0, MTMSN=0
2013-10-11T21:13:20.551Z,1381526000.551 [NAL9602](INFO): Sent 113 bytes from file Logs/20131011T203037/Express0025.lzma
2013-10-11T21:13:20.551Z,1381526000.551 [NAL9602](INFO): Packets left to send: 0
2013-10-11T21:13:20.553Z,1381526000.553 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Express0025.lzma.parts/0000.sbd
2013-10-11T21:13:28.329Z,1381526008.329 [NAL9602](INFO): SBD MO Status=0, MOMSN=20217, MT Status=0, MTMSN=0
2013-10-11T21:13:31.932Z,1381526011.932 [Default:Iridium:Read_Iridium] Stopped
2013-10-11T21:13:31.933Z,1381526011.933 [Default:Iridium](INFO): Completed Default:Iridium
2013-10-11T21:13:31.933Z,1381526011.933 [Default:Iridium] Stopped
2013-10-11T21:13:31.933Z,1381526011.933 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-10-11T21:13:31.933Z,1381526011.933 [Default:Iridium:A.SetSpeed] Stopped
2013-10-11T21:13:31.933Z,1381526011.933 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-10-11T21:13:32.170Z,1381526012.170 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-10-11T21:13:32.170Z,1381526012.170 [Default:CallIridium:B] Stopped
2013-10-11T21:13:32.170Z,1381526012.170 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-10-11T21:13:32.170Z,1381526012.170 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-10-11T21:13:32.170Z,1381526012.170 [Default:CallIridium] Stopped
2013-10-11T21:13:32.171Z,1381526012.171 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-10-11T21:13:32.930Z,1381526012.930 [NAL9602](IMPORTANT): GPS fix at: 1381526031.00
2013-10-11T21:13:32.948Z,1381526012.948 [Default:GPS:Read_GPS] Stopped
2013-10-11T21:13:32.948Z,1381526012.948 [Default:GPS:D] Running Loop=1
2013-10-11T21:13:33.355Z,1381526013.355 [Default:GPS:D] Stopped
2013-10-11T21:13:33.355Z,1381526013.355 [Default:GPS](INFO): Completed Default:GPS
2013-10-11T21:13:33.355Z,1381526013.355 [Default:GPS] Stopped
2013-10-11T21:13:33.355Z,1381526013.355 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-10-11T21:13:33.356Z,1381526013.356 [Default:GPS:A.SetSpeed] Stopped
2013-10-11T21:13:33.356Z,1381526013.356 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-10-11T21:13:53.767Z,1381526033.767 [NAL9602](INFO): Powering down
2013-10-11T21:18:28.777Z,1381526308.777 [Default:CallIridium] Running Loop=1
2013-10-11T21:18:28.777Z,1381526308.777 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-10-11T21:18:28.778Z,1381526308.778 [Default:CallIridium:A] Running Loop=1
2013-10-11T21:18:28.778Z,1381526308.778 [Default:CallIridium:A] Stopped
2013-10-11T21:18:28.778Z,1381526308.778 [Default:CallIridium:B] Running Loop=1
2013-10-11T21:18:28.778Z,1381526308.778 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-10-11T21:18:33.783Z,1381526313.783 [Default:Iridium] Running Loop=1
2013-10-11T21:18:33.783Z,1381526313.783 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-10-11T21:18:33.783Z,1381526313.783 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-10-11T21:18:33.783Z,1381526313.783 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-10-11T21:18:33.783Z,1381526313.783 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-10-11T21:18:33.783Z,1381526313.783 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-10-11T21:18:33.784Z,1381526313.784 [Default:Iridium:B.GoToSurface] Stopped
2013-10-11T21:18:33.784Z,1381526313.784 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-10-11T21:18:33.785Z,1381526313.785 [Default:Iridium:Read_Iridium] Running Loop=1
2013-10-11T21:18:33.785Z,1381526313.785 [Default:GPS] Running Loop=1
2013-10-11T21:18:33.785Z,1381526313.785 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-10-11T21:18:33.785Z,1381526313.785 [Default:GPS:A.SetSpeed] Running Loop=1
2013-10-11T21:18:33.785Z,1381526313.785 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-10-11T21:18:33.785Z,1381526313.785 [Default:GPS:B.GoToSurface] Running Loop=1
2013-10-11T21:18:33.785Z,1381526313.785 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-10-11T21:18:33.786Z,1381526313.786 [Default:GPS:B.GoToSurface] Stopped
2013-10-11T21:18:33.786Z,1381526313.786 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-10-11T21:18:33.786Z,1381526313.786 [Default:GPS:Read_GPS] Running Loop=1
2013-10-11T21:18:34.517Z,1381526314.517 [NAL9602](INFO): Powering up
2013-10-11T21:18:44.966Z,1381526324.966 [NAL9602](INFO): NAL9602 initialized
2013-10-11T21:19:06.386Z,1381526346.386 [NAL9602](INFO): SBD MO Status=2, MOMSN=20218, MT Status=2, MTMSN=0
2013-10-11T21:19:06.386Z,1381526346.386 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T21:19:12.731Z,1381526352.731 [NAL9602](IMPORTANT): GPS fix at: 1381526371.00
2013-10-11T21:19:12.750Z,1381526352.750 [Default:GPS:Read_GPS] Stopped
2013-10-11T21:19:12.750Z,1381526352.750 [Default:GPS:D] Running Loop=1
2013-10-11T21:19:13.161Z,1381526353.161 [Default:GPS:D] Stopped
2013-10-11T21:19:13.161Z,1381526353.161 [Default:GPS](INFO): Completed Default:GPS
2013-10-11T21:19:13.161Z,1381526353.161 [Default:GPS] Stopped
2013-10-11T21:19:13.162Z,1381526353.162 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-10-11T21:19:13.162Z,1381526353.162 [Default:GPS:A.SetSpeed] Stopped
2013-10-11T21:19:13.162Z,1381526353.162 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-10-11T21:19:37.282Z,1381526377.282 [NAL9602](INFO): SBD MO Status=2, MOMSN=20218, MT Status=2, MTMSN=0
2013-10-11T21:19:37.282Z,1381526377.282 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T21:19:55.458Z,1381526395.458 [NAL9602](INFO): SBD MO Status=2, MOMSN=20218, MT Status=2, MTMSN=0
2013-10-11T21:19:55.458Z,1381526395.458 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T21:20:16.823Z,1381526416.823 [NAL9602](INFO): SBD MO Status=2, MOMSN=20218, MT Status=2, MTMSN=0
2013-10-11T21:20:16.823Z,1381526416.823 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T21:20:32.579Z,1381526432.579 [NAL9602](INFO): SBD MO Status=1, MOMSN=20218, MT Status=0, MTMSN=0
2013-10-11T21:20:32.629Z,1381526432.629 [NAL9602](INFO): Sent 60 bytes from file Logs/20131011T203037/Courier0028.lzma
2013-10-11T21:20:32.629Z,1381526432.629 [NAL9602](INFO): Packets left to send: 0
2013-10-11T21:20:32.631Z,1381526432.631 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Courier0028.lzma.parts/0000.sbd
2013-10-11T21:20:43.517Z,1381526443.517 [NAL9602](INFO): SBD MO Status=1, MOMSN=20219, MT Status=0, MTMSN=0
2013-10-11T21:20:43.566Z,1381526443.566 [NAL9602](INFO): Sent 113 bytes from file Logs/20131011T203037/Express0029.lzma
2013-10-11T21:20:43.566Z,1381526443.566 [NAL9602](INFO): Packets left to send: 0
2013-10-11T21:20:43.568Z,1381526443.568 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Express0029.lzma.parts/0000.sbd
2013-10-11T21:20:53.372Z,1381526453.372 [NAL9602](INFO): SBD MO Status=0, MOMSN=20220, MT Status=0, MTMSN=0
2013-10-11T21:20:57.153Z,1381526457.153 [Default:Iridium:Read_Iridium] Stopped
2013-10-11T21:20:57.154Z,1381526457.154 [Default:Iridium](INFO): Completed Default:Iridium
2013-10-11T21:20:57.154Z,1381526457.154 [Default:Iridium] Stopped
2013-10-11T21:20:57.154Z,1381526457.154 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-10-11T21:20:57.154Z,1381526457.154 [Default:Iridium:A.SetSpeed] Stopped
2013-10-11T21:20:57.154Z,1381526457.154 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-10-11T21:20:57.396Z,1381526457.396 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-10-11T21:20:57.396Z,1381526457.396 [Default:CallIridium:B] Stopped
2013-10-11T21:20:57.397Z,1381526457.397 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-10-11T21:20:57.397Z,1381526457.397 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-10-11T21:20:57.397Z,1381526457.397 [Default:CallIridium] Stopped
2013-10-11T21:20:57.397Z,1381526457.397 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-10-11T21:21:07.378Z,1381526467.378 [NAL9602](INFO): Powering down
2013-10-11T21:25:57.397Z,1381526757.397 [Default:CallIridium] Running Loop=1
2013-10-11T21:25:57.397Z,1381526757.397 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-10-11T21:25:57.398Z,1381526757.398 [Default:CallIridium:A] Running Loop=1
2013-10-11T21:25:57.398Z,1381526757.398 [Default:CallIridium:A] Stopped
2013-10-11T21:25:57.399Z,1381526757.399 [Default:CallIridium:B] Running Loop=1
2013-10-11T21:25:57.399Z,1381526757.399 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-10-11T21:26:02.427Z,1381526762.427 [Default:Iridium] Running Loop=1
2013-10-11T21:26:02.427Z,1381526762.427 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-10-11T21:26:02.428Z,1381526762.428 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-10-11T21:26:02.428Z,1381526762.428 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-10-11T21:26:02.428Z,1381526762.428 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-10-11T21:26:02.428Z,1381526762.428 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-10-11T21:26:02.429Z,1381526762.429 [Default:Iridium:B.GoToSurface] Stopped
2013-10-11T21:26:02.429Z,1381526762.429 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-10-11T21:26:02.429Z,1381526762.429 [Default:Iridium:Read_Iridium] Running Loop=1
2013-10-11T21:26:02.429Z,1381526762.429 [Default:GPS] Running Loop=1
2013-10-11T21:26:02.429Z,1381526762.429 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-10-11T21:26:02.429Z,1381526762.429 [Default:GPS:A.SetSpeed] Running Loop=1
2013-10-11T21:26:02.429Z,1381526762.429 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-10-11T21:26:02.430Z,1381526762.430 [Default:GPS:B.GoToSurface] Running Loop=1
2013-10-11T21:26:02.430Z,1381526762.430 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-10-11T21:26:02.430Z,1381526762.430 [Default:GPS:B.GoToSurface] Stopped
2013-10-11T21:26:02.430Z,1381526762.430 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-10-11T21:26:02.431Z,1381526762.431 [Default:GPS:Read_GPS] Running Loop=1
2013-10-11T21:26:03.140Z,1381526763.140 [NAL9602](INFO): Powering up
2013-10-11T21:26:13.581Z,1381526773.581 [NAL9602](INFO): NAL9602 initialized
2013-10-11T21:26:44.928Z,1381526804.928 [NAL9602](INFO): SBD MO Status=1, MOMSN=20221, MT Status=0, MTMSN=0
2013-10-11T21:26:44.978Z,1381526804.978 [NAL9602](INFO): Sent 58 bytes from file Logs/20131011T203037/Courier0032.lzma
2013-10-11T21:26:44.978Z,1381526804.978 [NAL9602](INFO): Packets left to send: 0
2013-10-11T21:26:44.980Z,1381526804.980 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Courier0032.lzma.parts/0000.sbd
2013-10-11T21:27:04.735Z,1381526824.735 [NAL9602](INFO): SBD MO Status=1, MOMSN=20222, MT Status=0, MTMSN=0
2013-10-11T21:27:04.785Z,1381526824.785 [NAL9602](INFO): Sent 109 bytes from file Logs/20131011T203037/Express0033.lzma
2013-10-11T21:27:04.785Z,1381526824.785 [NAL9602](INFO): Packets left to send: 0
2013-10-11T21:27:04.787Z,1381526824.787 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Express0033.lzma.parts/0000.sbd
2013-10-11T21:27:16.618Z,1381526836.618 [NAL9602](INFO): SBD MO Status=0, MOMSN=20223, MT Status=0, MTMSN=0
2013-10-11T21:27:20.454Z,1381526840.454 [Default:Iridium:Read_Iridium] Stopped
2013-10-11T21:27:20.454Z,1381526840.454 [Default:Iridium](INFO): Completed Default:Iridium
2013-10-11T21:27:20.454Z,1381526840.454 [Default:Iridium] Stopped
2013-10-11T21:27:20.454Z,1381526840.454 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-10-11T21:27:20.455Z,1381526840.455 [Default:Iridium:A.SetSpeed] Stopped
2013-10-11T21:27:20.455Z,1381526840.455 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-10-11T21:27:20.695Z,1381526840.695 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-10-11T21:27:20.695Z,1381526840.695 [Default:CallIridium:B] Stopped
2013-10-11T21:27:20.695Z,1381526840.695 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-10-11T21:27:20.695Z,1381526840.695 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-10-11T21:27:20.696Z,1381526840.696 [Default:CallIridium] Stopped
2013-10-11T21:27:20.696Z,1381526840.696 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-10-11T21:28:18.652Z,1381526898.652 [NAL9602](IMPORTANT): GPS fix at: 1381526917.00
2013-10-11T21:28:18.673Z,1381526898.673 [Default:GPS:Read_GPS] Stopped
2013-10-11T21:28:18.673Z,1381526898.673 [Default:GPS:D] Running Loop=1
2013-10-11T21:28:19.087Z,1381526899.087 [Default:GPS:D] Stopped
2013-10-11T21:28:19.087Z,1381526899.087 [Default:GPS](INFO): Completed Default:GPS
2013-10-11T21:28:19.087Z,1381526899.087 [Default:GPS] Stopped
2013-10-11T21:28:19.087Z,1381526899.087 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-10-11T21:28:19.088Z,1381526899.088 [Default:GPS:A.SetSpeed] Stopped
2013-10-11T21:28:19.088Z,1381526899.088 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-10-11T21:28:39.487Z,1381526919.487 [NAL9602](INFO): Powering down
2013-10-11T21:32:19.542Z,1381527139.542 [Default:CallIridium] Running Loop=1
2013-10-11T21:32:19.542Z,1381527139.542 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-10-11T21:32:19.543Z,1381527139.543 [Default:CallIridium:A] Running Loop=1
2013-10-11T21:32:19.543Z,1381527139.543 [Default:CallIridium:A] Stopped
2013-10-11T21:32:19.543Z,1381527139.543 [Default:CallIridium:B] Running Loop=1
2013-10-11T21:32:19.543Z,1381527139.543 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-10-11T21:32:24.540Z,1381527144.540 [Default:Iridium] Running Loop=1
2013-10-11T21:32:24.540Z,1381527144.540 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-10-11T21:32:24.540Z,1381527144.540 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-10-11T21:32:24.540Z,1381527144.540 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-10-11T21:32:24.540Z,1381527144.540 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-10-11T21:32:24.540Z,1381527144.540 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-10-11T21:32:24.541Z,1381527144.541 [Default:Iridium:B.GoToSurface] Stopped
2013-10-11T21:32:24.541Z,1381527144.541 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-10-11T21:32:24.541Z,1381527144.541 [Default:Iridium:Read_Iridium] Running Loop=1
2013-10-11T21:32:24.542Z,1381527144.542 [Default:GPS] Running Loop=1
2013-10-11T21:32:24.542Z,1381527144.542 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-10-11T21:32:24.542Z,1381527144.542 [Default:GPS:A.SetSpeed] Running Loop=1
2013-10-11T21:32:24.542Z,1381527144.542 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-10-11T21:32:24.542Z,1381527144.542 [Default:GPS:B.GoToSurface] Running Loop=1
2013-10-11T21:32:24.542Z,1381527144.542 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-10-11T21:32:24.543Z,1381527144.543 [Default:GPS:B.GoToSurface] Stopped
2013-10-11T21:32:24.543Z,1381527144.543 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-10-11T21:32:24.543Z,1381527144.543 [Default:GPS:Read_GPS] Running Loop=1
2013-10-11T21:32:25.255Z,1381527145.255 [NAL9602](INFO): Powering up
2013-10-11T21:32:36.099Z,1381527156.099 [NAL9602](INFO): NAL9602 initialized
2013-10-11T21:36:48.645Z,1381527408.645 [NAL9602](INFO): SBD MO Status=2, MOMSN=20224, MT Status=2, MTMSN=0
2013-10-11T21:36:48.645Z,1381527408.645 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T21:37:10.043Z,1381527430.043 [NAL9602](INFO): SBD MO Status=1, MOMSN=20224, MT Status=0, MTMSN=0
2013-10-11T21:37:10.091Z,1381527430.091 [NAL9602](INFO): Sent 60 bytes from file Logs/20131011T203037/Courier0036.lzma
2013-10-11T21:37:10.092Z,1381527430.092 [NAL9602](INFO): Packets left to send: 0
2013-10-11T21:37:10.093Z,1381527430.093 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Courier0036.lzma.parts/0000.sbd
2013-10-11T21:37:22.990Z,1381527442.990 [NAL9602](INFO): SBD MO Status=2, MOMSN=20225, MT Status=2, MTMSN=0
2013-10-11T21:37:22.990Z,1381527442.990 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T21:37:53.469Z,1381527473.469 [NAL9602](INFO): SBD MO Status=2, MOMSN=20225, MT Status=2, MTMSN=0
2013-10-11T21:37:53.469Z,1381527473.469 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-10-11T21:38:15.192Z,1381527495.192 [NAL9602](INFO): SBD MO Status=1, MOMSN=20225, MT Status=0, MTMSN=0
2013-10-11T21:38:15.240Z,1381527495.240 [NAL9602](INFO): Sent 119 bytes from file Logs/20131011T203037/Express0037.lzma
2013-10-11T21:38:15.241Z,1381527495.241 [NAL9602](INFO): Packets left to send: 0
2013-10-11T21:38:15.242Z,1381527495.242 [NAL9602](INFO): Stored copy of sent data in Logs/20131011T203037/Express0037.lzma.parts/0000.sbd
2013-10-11T21:38:25.030Z,1381527505.030 [NAL9602](INFO): SBD MO Status=0, MOMSN=20226, MT Status=0, MTMSN=0
2013-10-11T21:38:28.704Z,1381527508.704 [Default:Iridium:Read_Iridium] Stopped
2013-10-11T21:38:28.705Z,1381527508.705 [Default:Iridium](INFO): Completed Default:Iridium
2013-10-11T21:38:28.705Z,1381527508.705 [Default:Iridium] Stopped
2013-10-11T21:38:28.705Z,1381527508.705 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-10-11T21:38:28.705Z,1381527508.705 [Default:Iridium:A.SetS