2013-05-24T15:53:22.328Z,1369410802.328 [CommandLine](IMPORTANT): got command restart logs
2013-05-24T15:53:40.759Z,1369410820.759 [NAL9602](INFO): SBD MO Status=1, MOMSN=13279, MT Status=0, MTMSN=0
2013-05-24T15:53:40.808Z,1369410820.808 [NAL9602](INFO): Sent 200 bytes from file Logs/20130524T151403/shore0005.lzma
2013-05-24T15:53:40.809Z,1369410820.809 [NAL9602](INFO): Packets left to send: 0
2013-05-24T15:53:40.810Z,1369410820.810 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T151403/shore0005.lzma.parts/0000.sbd
2013-05-24T15:53:50.311Z,1369410830.311 [NAL9602](INFO): SBD MO Status=0, MOMSN=13280, MT Status=0, MTMSN=0
2013-05-24T15:53:51.509Z,1369410831.509 [NAL9602](IMPORTANT): GPS fix at: 1369411060.00
2013-05-24T15:53:51.525Z,1369410831.525 [Default:GPS:Read_GPS] Stopped
2013-05-24T15:53:51.525Z,1369410831.525 [Default:GPS:D] Running Loop=1
2013-05-24T15:53:51.943Z,1369410831.943 [Default:GPS:D] Stopped
2013-05-24T15:53:51.943Z,1369410831.943 [Default:GPS](INFO): Completed Default:GPS
2013-05-24T15:53:51.943Z,1369410831.943 [Default:GPS] Stopped
2013-05-24T15:53:51.943Z,1369410831.944 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-05-24T15:53:51.944Z,1369410831.944 [Default:GPS:A.SetSpeed] Stopped
2013-05-24T15:53:51.944Z,1369410831.944 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T15:54:02.899Z,1369410842.899 [NAL9602](INFO): SBD MO Status=1, MOMSN=13281, MT Status=0, MTMSN=0
2013-05-24T15:54:02.948Z,1369410842.948 [NAL9602](INFO): Sent 332 bytes from file Logs/20130524T155322/shore0000.lzma
2013-05-24T15:54:02.949Z,1369410842.949 [NAL9602](INFO): Packets left to send: 2
2013-05-24T15:54:02.950Z,1369410842.950 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0000.lzma.parts/0002.sbd
2013-05-24T15:54:15.499Z,1369410855.499 [NAL9602](INFO): SBD MO Status=1, MOMSN=13282, MT Status=0, MTMSN=0
2013-05-24T15:54:15.548Z,1369410855.548 [NAL9602](INFO): Sent 332 bytes from file Logs/20130524T155322/shore0000.lzma
2013-05-24T15:54:15.549Z,1369410855.549 [NAL9602](INFO): Packets left to send: 1
2013-05-24T15:54:15.550Z,1369410855.550 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0000.lzma.parts/0001.sbd
2013-05-24T15:54:24.199Z,1369410864.199 [NAL9602](INFO): SBD MO Status=1, MOMSN=13283, MT Status=0, MTMSN=0
2013-05-24T15:54:24.248Z,1369410864.248 [NAL9602](INFO): Sent 46 bytes from file Logs/20130524T155322/shore0000.lzma
2013-05-24T15:54:24.249Z,1369410864.249 [NAL9602](INFO): Packets left to send: 0
2013-05-24T15:54:24.250Z,1369410864.250 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0000.lzma.parts/0000.sbd
2013-05-24T15:54:36.603Z,1369410876.603 [NAL9602](INFO): SBD MO Status=0, MOMSN=13284, MT Status=0, MTMSN=0
2013-05-24T15:54:40.195Z,1369410880.195 [Default:Iridium:Read_Iridium] Stopped
2013-05-24T15:54:40.196Z,1369410880.196 [Default:Iridium](INFO): Completed Default:Iridium
2013-05-24T15:54:40.196Z,1369410880.196 [Default:Iridium] Stopped
2013-05-24T15:54:40.196Z,1369410880.196 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-05-24T15:54:40.196Z,1369410880.196 [Default:Iridium:A.SetSpeed] Stopped
2013-05-24T15:54:40.196Z,1369410880.196 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T15:54:40.554Z,1369410880.555 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-05-24T15:54:40.555Z,1369410880.555 [Default:CallIridium:B] Stopped
2013-05-24T15:54:40.555Z,1369410880.555 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-05-24T15:54:40.555Z,1369410880.555 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-05-24T15:54:40.555Z,1369410880.555 [Default:CallIridium] Stopped
2013-05-24T15:54:40.555Z,1369410880.555 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-05-24T15:54:50.510Z,1369410890.510 [NAL9602](INFO): Powering down
2013-05-24T15:59:40.545Z,1369411180.545 [Default:CallIridium] Running Loop=1
2013-05-24T15:59:40.545Z,1369411180.545 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-05-24T15:59:40.545Z,1369411180.545 [Default:CallIridium:A] Running Loop=1
2013-05-24T15:59:40.546Z,1369411180.546 [Default:CallIridium:A] Stopped
2013-05-24T15:59:40.546Z,1369411180.546 [Default:CallIridium:B] Running Loop=1
2013-05-24T15:59:40.546Z,1369411180.546 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-05-24T15:59:45.558Z,1369411185.558 [Default:Iridium] Running Loop=1
2013-05-24T15:59:45.558Z,1369411185.558 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-05-24T15:59:45.558Z,1369411185.558 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-05-24T15:59:45.558Z,1369411185.558 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-05-24T15:59:45.558Z,1369411185.558 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-05-24T15:59:45.558Z,1369411185.558 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T15:59:45.559Z,1369411185.559 [Default:Iridium:B.GoToSurface] Stopped
2013-05-24T15:59:45.559Z,1369411185.559 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T15:59:45.559Z,1369411185.559 [Default:Iridium:Read_Iridium] Running Loop=1
2013-05-24T15:59:45.560Z,1369411185.560 [Default:GPS] Running Loop=1
2013-05-24T15:59:45.560Z,1369411185.560 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-05-24T15:59:45.560Z,1369411185.560 [Default:GPS:A.SetSpeed] Running Loop=1
2013-05-24T15:59:45.560Z,1369411185.560 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-05-24T15:59:45.560Z,1369411185.560 [Default:GPS:B.GoToSurface] Running Loop=1
2013-05-24T15:59:45.560Z,1369411185.560 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T15:59:45.561Z,1369411185.561 [Default:GPS:B.GoToSurface] Stopped
2013-05-24T15:59:45.561Z,1369411185.561 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T15:59:45.561Z,1369411185.561 [Default:GPS:Read_GPS] Running Loop=1
2013-05-24T15:59:46.185Z,1369411186.185 [NAL9602](INFO): Powering up
2013-05-24T15:59:57.020Z,1369411197.020 [NAL9602](INFO): NAL9602 initialized
2013-05-24T16:00:28.355Z,1369411228.355 [NAL9602](INFO): SBD MO Status=1, MOMSN=13285, MT Status=0, MTMSN=0
2013-05-24T16:00:28.404Z,1369411228.404 [NAL9602](INFO): Sent 240 bytes from file Logs/20130524T155322/shore0001.lzma
2013-05-24T16:00:28.405Z,1369411228.405 [NAL9602](INFO): Packets left to send: 0
2013-05-24T16:00:28.406Z,1369411228.406 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0001.lzma.parts/0000.sbd
2013-05-24T16:00:35.976Z,1369411235.976 [NAL9602](INFO): SBD MO Status=0, MOMSN=13286, MT Status=0, MTMSN=0
2013-05-24T16:00:39.698Z,1369411239.698 [Default:Iridium:Read_Iridium] Stopped
2013-05-24T16:00:39.699Z,1369411239.699 [Default:Iridium](INFO): Completed Default:Iridium
2013-05-24T16:00:39.699Z,1369411239.699 [Default:Iridium] Stopped
2013-05-24T16:00:39.699Z,1369411239.699 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-05-24T16:00:39.699Z,1369411239.699 [Default:Iridium:A.SetSpeed] Stopped
2013-05-24T16:00:39.699Z,1369411239.699 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:00:39.982Z,1369411239.982 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-05-24T16:00:39.982Z,1369411239.982 [Default:CallIridium:B] Stopped
2013-05-24T16:00:39.982Z,1369411239.982 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-05-24T16:00:39.982Z,1369411239.982 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-05-24T16:00:39.982Z,1369411239.982 [Default:CallIridium] Stopped
2013-05-24T16:00:39.983Z,1369411239.983 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-05-24T16:00:43.093Z,1369411243.092 [NAL9602](IMPORTANT): GPS fix at: 1369411472.00
2013-05-24T16:00:43.108Z,1369411243.108 [Default:GPS:Read_GPS] Stopped
2013-05-24T16:00:43.108Z,1369411243.108 [Default:GPS:D] Running Loop=1
2013-05-24T16:00:43.522Z,1369411243.522 [Default:GPS:D] Stopped
2013-05-24T16:00:43.522Z,1369411243.522 [Default:GPS](INFO): Completed Default:GPS
2013-05-24T16:00:43.522Z,1369411243.522 [Default:GPS] Stopped
2013-05-24T16:00:43.522Z,1369411243.522 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-05-24T16:00:43.522Z,1369411243.522 [Default:GPS:A.SetSpeed] Stopped
2013-05-24T16:00:43.522Z,1369411243.523 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:01:04.046Z,1369411264.046 [NAL9602](INFO): Powering down
2013-05-24T16:05:39.064Z,1369411539.064 [Default:CallIridium] Running Loop=1
2013-05-24T16:05:39.064Z,1369411539.064 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-05-24T16:05:39.064Z,1369411539.064 [Default:CallIridium:A] Running Loop=1
2013-05-24T16:05:39.064Z,1369411539.064 [Default:CallIridium:A] Stopped
2013-05-24T16:05:39.065Z,1369411539.065 [Default:CallIridium:B] Running Loop=1
2013-05-24T16:05:39.065Z,1369411539.065 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-05-24T16:05:44.022Z,1369411544.022 [Default:Iridium] Running Loop=1
2013-05-24T16:05:44.022Z,1369411544.022 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-05-24T16:05:44.022Z,1369411544.022 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-05-24T16:05:44.022Z,1369411544.022 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-05-24T16:05:44.022Z,1369411544.022 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-05-24T16:05:44.022Z,1369411544.022 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T16:05:44.023Z,1369411544.023 [Default:Iridium:B.GoToSurface] Stopped
2013-05-24T16:05:44.023Z,1369411544.023 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T16:05:44.023Z,1369411544.023 [Default:Iridium:Read_Iridium] Running Loop=1
2013-05-24T16:05:44.023Z,1369411544.023 [Default:GPS] Running Loop=1
2013-05-24T16:05:44.024Z,1369411544.024 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-05-24T16:05:44.024Z,1369411544.024 [Default:GPS:A.SetSpeed] Running Loop=1
2013-05-24T16:05:44.024Z,1369411544.024 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-05-24T16:05:44.024Z,1369411544.024 [Default:GPS:B.GoToSurface] Running Loop=1
2013-05-24T16:05:44.024Z,1369411544.024 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T16:05:44.025Z,1369411544.025 [Default:GPS:B.GoToSurface] Stopped
2013-05-24T16:05:44.025Z,1369411544.025 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T16:05:44.025Z,1369411544.025 [Default:GPS:Read_GPS] Running Loop=1
2013-05-24T16:05:44.689Z,1369411544.689 [NAL9602](INFO): Powering up
2013-05-24T16:05:55.520Z,1369411555.520 [NAL9602](INFO): NAL9602 initialized
2013-05-24T16:06:15.255Z,1369411575.255 [NAL9602](INFO): SBD MO Status=1, MOMSN=13287, MT Status=0, MTMSN=0
2013-05-24T16:06:15.304Z,1369411575.304 [NAL9602](INFO): Sent 210 bytes from file Logs/20130524T155322/shore0002.lzma
2013-05-24T16:06:15.305Z,1369411575.305 [NAL9602](INFO): Packets left to send: 0
2013-05-24T16:06:15.306Z,1369411575.306 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0002.lzma.parts/0000.sbd
2013-05-24T16:06:25.250Z,1369411585.250 [NAL9602](INFO): SBD MO Status=0, MOMSN=13288, MT Status=0, MTMSN=0
2013-05-24T16:06:28.916Z,1369411588.916 [Default:Iridium:Read_Iridium] Stopped
2013-05-24T16:06:28.917Z,1369411588.917 [Default:Iridium](INFO): Completed Default:Iridium
2013-05-24T16:06:28.917Z,1369411588.917 [Default:Iridium] Stopped
2013-05-24T16:06:28.917Z,1369411588.917 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-05-24T16:06:28.917Z,1369411588.917 [Default:Iridium:A.SetSpeed] Stopped
2013-05-24T16:06:28.917Z,1369411588.917 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:06:29.209Z,1369411589.209 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-05-24T16:06:29.209Z,1369411589.209 [Default:CallIridium:B] Stopped
2013-05-24T16:06:29.209Z,1369411589.210 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-05-24T16:06:29.210Z,1369411589.210 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-05-24T16:06:29.210Z,1369411589.210 [Default:CallIridium] Stopped
2013-05-24T16:06:29.210Z,1369411589.210 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-05-24T16:07:14.312Z,1369411634.312 [NAL9602](IMPORTANT): GPS fix at: 1369411864.00
2013-05-24T16:07:14.345Z,1369411634.345 [Default:GPS:Read_GPS] Stopped
2013-05-24T16:07:14.345Z,1369411634.345 [Default:GPS:D] Running Loop=1
2013-05-24T16:07:14.753Z,1369411634.753 [Default:GPS:D] Stopped
2013-05-24T16:07:14.754Z,1369411634.754 [Default:GPS](INFO): Completed Default:GPS
2013-05-24T16:07:14.754Z,1369411634.754 [Default:GPS] Stopped
2013-05-24T16:07:14.754Z,1369411634.754 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-05-24T16:07:14.754Z,1369411634.754 [Default:GPS:A.SetSpeed] Stopped
2013-05-24T16:07:14.754Z,1369411634.754 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:07:35.242Z,1369411655.242 [NAL9602](INFO): Powering down
2013-05-24T16:11:30.255Z,1369411890.255 [Default:CallIridium] Running Loop=1
2013-05-24T16:11:30.255Z,1369411890.256 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-05-24T16:11:30.256Z,1369411890.256 [Default:CallIridium:A] Running Loop=1
2013-05-24T16:11:30.256Z,1369411890.256 [Default:CallIridium:A] Stopped
2013-05-24T16:11:30.256Z,1369411890.256 [Default:CallIridium:B] Running Loop=1
2013-05-24T16:11:30.256Z,1369411890.256 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-05-24T16:11:35.273Z,1369411895.273 [Default:Iridium] Running Loop=1
2013-05-24T16:11:35.274Z,1369411895.274 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-05-24T16:11:35.274Z,1369411895.274 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-05-24T16:11:35.274Z,1369411895.274 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-05-24T16:11:35.274Z,1369411895.274 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-05-24T16:11:35.274Z,1369411895.274 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T16:11:35.275Z,1369411895.275 [Default:Iridium:B.GoToSurface] Stopped
2013-05-24T16:11:35.275Z,1369411895.275 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T16:11:35.275Z,1369411895.275 [Default:Iridium:Read_Iridium] Running Loop=1
2013-05-24T16:11:35.275Z,1369411895.276 [Default:GPS] Running Loop=1
2013-05-24T16:11:35.276Z,1369411895.276 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-05-24T16:11:35.276Z,1369411895.276 [Default:GPS:A.SetSpeed] Running Loop=1
2013-05-24T16:11:35.276Z,1369411895.276 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-05-24T16:11:35.276Z,1369411895.276 [Default:GPS:B.GoToSurface] Running Loop=1
2013-05-24T16:11:35.276Z,1369411895.276 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T16:11:35.277Z,1369411895.277 [Default:GPS:B.GoToSurface] Stopped
2013-05-24T16:11:35.277Z,1369411895.277 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T16:11:35.277Z,1369411895.277 [Default:GPS:Read_GPS] Running Loop=1
2013-05-24T16:11:35.917Z,1369411895.917 [NAL9602](INFO): Powering up
2013-05-24T16:11:46.744Z,1369411906.744 [NAL9602](INFO): NAL9602 initialized
2013-05-24T16:12:02.907Z,1369411922.907 [NAL9602](INFO): SBD MO Status=1, MOMSN=13289, MT Status=0, MTMSN=0
2013-05-24T16:12:02.956Z,1369411922.956 [NAL9602](INFO): Sent 211 bytes from file Logs/20130524T155322/shore0003.lzma
2013-05-24T16:12:02.957Z,1369411922.957 [NAL9602](INFO): Packets left to send: 0
2013-05-24T16:12:02.958Z,1369411922.958 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0003.lzma.parts/0000.sbd
2013-05-24T16:12:12.863Z,1369411932.863 [NAL9602](INFO): SBD MO Status=0, MOMSN=13290, MT Status=0, MTMSN=0
2013-05-24T16:12:16.470Z,1369411936.470 [Default:Iridium:Read_Iridium] Stopped
2013-05-24T16:12:16.470Z,1369411936.470 [Default:Iridium](INFO): Completed Default:Iridium
2013-05-24T16:12:16.470Z,1369411936.470 [Default:Iridium] Stopped
2013-05-24T16:12:16.470Z,1369411936.470 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-05-24T16:12:16.470Z,1369411936.470 [Default:Iridium:A.SetSpeed] Stopped
2013-05-24T16:12:16.470Z,1369411936.470 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:12:16.810Z,1369411936.810 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-05-24T16:12:16.810Z,1369411936.810 [Default:CallIridium:B] Stopped
2013-05-24T16:12:16.810Z,1369411936.810 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-05-24T16:12:16.811Z,1369411936.811 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-05-24T16:12:16.811Z,1369411936.811 [Default:CallIridium] Stopped
2013-05-24T16:12:16.811Z,1369411936.811 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-05-24T16:12:17.465Z,1369411937.464 [NAL9602](IMPORTANT): GPS fix at: 1369412167.00
2013-05-24T16:12:17.481Z,1369411937.481 [Default:GPS:Read_GPS] Stopped
2013-05-24T16:12:17.481Z,1369411937.481 [Default:GPS:D] Running Loop=1
2013-05-24T16:12:17.894Z,1369411937.894 [Default:GPS:D] Stopped
2013-05-24T16:12:17.894Z,1369411937.894 [Default:GPS](INFO): Completed Default:GPS
2013-05-24T16:12:17.894Z,1369411937.894 [Default:GPS] Stopped
2013-05-24T16:12:17.895Z,1369411937.895 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-05-24T16:12:17.895Z,1369411937.895 [Default:GPS:A.SetSpeed] Stopped
2013-05-24T16:12:17.895Z,1369411937.895 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:12:38.366Z,1369411958.366 [NAL9602](INFO): Powering down
2013-05-24T16:17:13.421Z,1369412233.421 [Default:CallIridium] Running Loop=1
2013-05-24T16:17:13.421Z,1369412233.421 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-05-24T16:17:13.422Z,1369412233.422 [Default:CallIridium:A] Running Loop=1
2013-05-24T16:17:13.422Z,1369412233.422 [Default:CallIridium:A] Stopped
2013-05-24T16:17:13.422Z,1369412233.422 [Default:CallIridium:B] Running Loop=1
2013-05-24T16:17:13.422Z,1369412233.422 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-05-24T16:17:18.397Z,1369412238.397 [Default:Iridium] Running Loop=1
2013-05-24T16:17:18.398Z,1369412238.398 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-05-24T16:17:18.398Z,1369412238.398 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-05-24T16:17:18.398Z,1369412238.398 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-05-24T16:17:18.398Z,1369412238.398 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-05-24T16:17:18.398Z,1369412238.398 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T16:17:18.399Z,1369412238.399 [Default:Iridium:B.GoToSurface] Stopped
2013-05-24T16:17:18.399Z,1369412238.399 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T16:17:18.399Z,1369412238.399 [Default:Iridium:Read_Iridium] Running Loop=1
2013-05-24T16:17:18.399Z,1369412238.399 [Default:GPS] Running Loop=1
2013-05-24T16:17:18.400Z,1369412238.399 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-05-24T16:17:18.400Z,1369412238.400 [Default:GPS:A.SetSpeed] Running Loop=1
2013-05-24T16:17:18.400Z,1369412238.400 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-05-24T16:17:18.400Z,1369412238.400 [Default:GPS:B.GoToSurface] Running Loop=1
2013-05-24T16:17:18.400Z,1369412238.400 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T16:17:18.401Z,1369412238.401 [Default:GPS:B.GoToSurface] Stopped
2013-05-24T16:17:18.401Z,1369412238.401 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T16:17:18.401Z,1369412238.401 [Default:GPS:Read_GPS] Running Loop=1
2013-05-24T16:17:19.093Z,1369412239.093 [NAL9602](INFO): Powering up
2013-05-24T16:17:29.496Z,1369412249.496 [NAL9602](INFO): NAL9602 initialized
2013-05-24T16:17:59.623Z,1369412279.623 [NAL9602](INFO): SBD MO Status=1, MOMSN=13291, MT Status=0, MTMSN=0
2013-05-24T16:17:59.672Z,1369412279.672 [NAL9602](INFO): Sent 212 bytes from file Logs/20130524T155322/shore0004.lzma
2013-05-24T16:17:59.673Z,1369412279.673 [NAL9602](INFO): Packets left to send: 0
2013-05-24T16:17:59.674Z,1369412279.674 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0004.lzma.parts/0000.sbd
2013-05-24T16:18:16.415Z,1369412296.415 [NAL9602](INFO): SBD MO Status=2, MOMSN=13292, MT Status=2, MTMSN=0
2013-05-24T16:18:16.415Z,1369412296.415 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-05-24T16:18:17.644Z,1369412297.644 [NAL9602](IMPORTANT): GPS fix at: 1369412528.00
2013-05-24T16:18:17.661Z,1369412297.661 [Default:GPS:Read_GPS] Stopped
2013-05-24T16:18:17.661Z,1369412297.661 [Default:GPS:D] Running Loop=1
2013-05-24T16:18:18.045Z,1369412298.046 [Default:GPS:D] Stopped
2013-05-24T16:18:18.046Z,1369412298.046 [Default:GPS](INFO): Completed Default:GPS
2013-05-24T16:18:18.046Z,1369412298.046 [Default:GPS] Stopped
2013-05-24T16:18:18.046Z,1369412298.046 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-05-24T16:18:18.046Z,1369412298.046 [Default:GPS:A.SetSpeed] Stopped
2013-05-24T16:18:18.046Z,1369412298.046 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:18:32.380Z,1369412312.380 [NAL9602](INFO): SBD MO Status=2, MOMSN=13292, MT Status=2, MTMSN=0
2013-05-24T16:18:32.380Z,1369412312.380 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-05-24T16:18:37.564Z,1369412317.564 [NAL9602](ERROR): Inadequate Iridium signal strength reported: 0
2013-05-24T16:18:44.620Z,1369412324.620 [CBIT](IMPORTANT): Beginning GF scan
2013-05-24T16:18:45.407Z,1369412325.407 [Radio_Freewave](INFO): Powering down
2013-05-24T16:18:46.198Z,1369412326.198 [Radio_Freewave](INFO): Powering up
2013-05-24T16:18:59.403Z,1369412339.403 [NAL9602](INFO): SBD MO Status=0, MOMSN=13292, MT Status=0, MTMSN=0
2013-05-24T16:19:03.012Z,1369412343.012 [Default:Iridium:Read_Iridium] Stopped
2013-05-24T16:19:03.012Z,1369412343.012 [Default:Iridium](INFO): Completed Default:Iridium
2013-05-24T16:19:03.013Z,1369412343.013 [Default:Iridium] Stopped
2013-05-24T16:19:03.013Z,1369412343.013 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-05-24T16:19:03.013Z,1369412343.013 [Default:Iridium:A.SetSpeed] Stopped
2013-05-24T16:19:03.013Z,1369412343.013 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:19:03.378Z,1369412343.378 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-05-24T16:19:03.378Z,1369412343.378 [Default:CallIridium:B] Stopped
2013-05-24T16:19:03.378Z,1369412343.378 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-05-24T16:19:03.379Z,1369412343.379 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-05-24T16:19:03.379Z,1369412343.379 [Default:CallIridium] Stopped
2013-05-24T16:19:03.379Z,1369412343.379 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-05-24T16:19:13.362Z,1369412353.362 [NAL9602](INFO): Powering down
2013-05-24T16:24:03.359Z,1369412643.359 [Default:CallIridium] Running Loop=1
2013-05-24T16:24:03.359Z,1369412643.359 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-05-24T16:24:03.359Z,1369412643.359 [Default:CallIridium:A] Running Loop=1
2013-05-24T16:24:03.359Z,1369412643.359 [Default:CallIridium:A] Stopped
2013-05-24T16:24:03.359Z,1369412643.359 [Default:CallIridium:B] Running Loop=1
2013-05-24T16:24:03.359Z,1369412643.359 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-05-24T16:24:08.322Z,1369412648.322 [Default:Iridium] Running Loop=1
2013-05-24T16:24:08.322Z,1369412648.322 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-05-24T16:24:08.322Z,1369412648.322 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-05-24T16:24:08.323Z,1369412648.323 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-05-24T16:24:08.323Z,1369412648.323 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-05-24T16:24:08.323Z,1369412648.323 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T16:24:08.324Z,1369412648.324 [Default:Iridium:B.GoToSurface] Stopped
2013-05-24T16:24:08.324Z,1369412648.324 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T16:24:08.324Z,1369412648.324 [Default:Iridium:Read_Iridium] Running Loop=1
2013-05-24T16:24:08.324Z,1369412648.325 [Default:GPS] Running Loop=1
2013-05-24T16:24:08.325Z,1369412648.325 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-05-24T16:24:08.325Z,1369412648.325 [Default:GPS:A.SetSpeed] Running Loop=1
2013-05-24T16:24:08.325Z,1369412648.325 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-05-24T16:24:08.325Z,1369412648.325 [Default:GPS:B.GoToSurface] Running Loop=1
2013-05-24T16:24:08.325Z,1369412648.325 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T16:24:08.326Z,1369412648.326 [Default:GPS:B.GoToSurface] Stopped
2013-05-24T16:24:08.326Z,1369412648.326 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T16:24:08.326Z,1369412648.326 [Default:GPS:Read_GPS] Running Loop=1
2013-05-24T16:24:09.000Z,1369412649.000 [NAL9602](INFO): Powering up
2013-05-24T16:24:19.440Z,1369412659.440 [NAL9602](INFO): NAL9602 initialized
2013-05-24T16:24:35.163Z,1369412675.163 [NAL9602](INFO): SBD MO Status=1, MOMSN=13293, MT Status=0, MTMSN=0
2013-05-24T16:24:35.212Z,1369412675.212 [NAL9602](INFO): Sent 267 bytes from file Logs/20130524T155322/shore0005.lzma
2013-05-24T16:24:35.213Z,1369412675.213 [NAL9602](INFO): Packets left to send: 0
2013-05-24T16:24:35.214Z,1369412675.214 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0005.lzma.parts/0000.sbd
2013-05-24T16:24:44.367Z,1369412684.367 [NAL9602](INFO): SBD MO Status=0, MOMSN=13294, MT Status=0, MTMSN=0
2013-05-24T16:24:48.039Z,1369412688.039 [Default:Iridium:Read_Iridium] Stopped
2013-05-24T16:24:48.040Z,1369412688.039 [Default:Iridium](INFO): Completed Default:Iridium
2013-05-24T16:24:48.040Z,1369412688.040 [Default:Iridium] Stopped
2013-05-24T16:24:48.040Z,1369412688.040 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-05-24T16:24:48.040Z,1369412688.040 [Default:Iridium:A.SetSpeed] Stopped
2013-05-24T16:24:48.040Z,1369412688.040 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:24:48.370Z,1369412688.370 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-05-24T16:24:48.370Z,1369412688.370 [Default:CallIridium:B] Stopped
2013-05-24T16:24:48.370Z,1369412688.370 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-05-24T16:24:48.370Z,1369412688.370 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-05-24T16:24:48.370Z,1369412688.370 [Default:CallIridium] Stopped
2013-05-24T16:24:48.370Z,1369412688.370 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-05-24T16:25:28.635Z,1369412728.635 [NAL9602](IMPORTANT): GPS fix at: 1369412960.00
2013-05-24T16:25:28.652Z,1369412728.652 [Default:GPS:Read_GPS] Stopped
2013-05-24T16:25:28.653Z,1369412728.653 [Default:GPS:D] Running Loop=1
2013-05-24T16:25:29.054Z,1369412729.054 [Default:GPS:D] Stopped
2013-05-24T16:25:29.054Z,1369412729.055 [Default:GPS](INFO): Completed Default:GPS
2013-05-24T16:25:29.055Z,1369412729.055 [Default:GPS] Stopped
2013-05-24T16:25:29.055Z,1369412729.055 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-05-24T16:25:29.055Z,1369412729.055 [Default:GPS:A.SetSpeed] Stopped
2013-05-24T16:25:29.055Z,1369412729.055 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:25:49.571Z,1369412749.571 [NAL9602](INFO): Powering down
2013-05-24T16:26:39.561Z,1369412799.560 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T16:26:44.557Z,1369412804.557 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T16:26:49.556Z,1369412809.556 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T16:26:54.554Z,1369412814.554 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T16:29:44.573Z,1369412984.573 [Default:CallIridium] Running Loop=1
2013-05-24T16:29:44.573Z,1369412984.573 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-05-24T16:29:44.573Z,1369412984.573 [Default:CallIridium:A] Running Loop=1
2013-05-24T16:29:44.574Z,1369412984.574 [Default:CallIridium:A] Stopped
2013-05-24T16:29:44.574Z,1369412984.574 [Default:CallIridium:B] Running Loop=1
2013-05-24T16:29:44.574Z,1369412984.574 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-05-24T16:29:49.597Z,1369412989.597 [Default:Iridium] Running Loop=1
2013-05-24T16:29:49.597Z,1369412989.597 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-05-24T16:29:49.597Z,1369412989.597 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-05-24T16:29:49.597Z,1369412989.597 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-05-24T16:29:49.598Z,1369412989.598 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-05-24T16:29:49.598Z,1369412989.598 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T16:29:49.598Z,1369412989.598 [Default:Iridium:B.GoToSurface] Stopped
2013-05-24T16:29:49.598Z,1369412989.598 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T16:29:49.599Z,1369412989.599 [Default:Iridium:Read_Iridium] Running Loop=1
2013-05-24T16:29:49.599Z,1369412989.599 [Default:GPS] Running Loop=1
2013-05-24T16:29:49.599Z,1369412989.599 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-05-24T16:29:49.599Z,1369412989.599 [Default:GPS:A.SetSpeed] Running Loop=1
2013-05-24T16:29:49.599Z,1369412989.599 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-05-24T16:29:49.599Z,1369412989.599 [Default:GPS:B.GoToSurface] Running Loop=1
2013-05-24T16:29:49.600Z,1369412989.599 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T16:29:49.600Z,1369412989.601 [Default:GPS:B.GoToSurface] Stopped
2013-05-24T16:29:49.601Z,1369412989.601 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T16:29:49.601Z,1369412989.601 [Default:GPS:Read_GPS] Running Loop=1
2013-05-24T16:29:50.224Z,1369412990.224 [NAL9602](INFO): Powering up
2013-05-24T16:30:00.668Z,1369413000.668 [NAL9602](INFO): NAL9602 initialized
2013-05-24T16:30:41.985Z,1369413041.985 [NAL9602](IMPORTANT): GPS fix at: 1369413273.00
2013-05-24T16:30:42.002Z,1369413042.001 [Default:GPS:Read_GPS] Stopped
2013-05-24T16:30:42.002Z,1369413042.002 [Default:GPS:D] Running Loop=1
2013-05-24T16:30:42.385Z,1369413042.385 [Default:GPS:D] Stopped
2013-05-24T16:30:42.386Z,1369413042.386 [Default:GPS](INFO): Completed Default:GPS
2013-05-24T16:30:42.386Z,1369413042.386 [Default:GPS] Stopped
2013-05-24T16:30:42.386Z,1369413042.386 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-05-24T16:30:42.386Z,1369413042.386 [Default:GPS:A.SetSpeed] Stopped
2013-05-24T16:30:42.386Z,1369413042.386 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:31:19.487Z,1369413079.487 [NAL9602](INFO): SBD MO Status=2, MOMSN=13295, MT Status=2, MTMSN=0
2013-05-24T16:31:19.487Z,1369413079.487 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-05-24T16:31:42.834Z,1369413102.834 [NAL9602](INFO): SBD MO Status=1, MOMSN=13295, MT Status=0, MTMSN=0
2013-05-24T16:31:42.884Z,1369413102.884 [NAL9602](INFO): Sent 202 bytes from file Logs/20130524T155322/shore0006.lzma
2013-05-24T16:31:42.885Z,1369413102.885 [NAL9602](INFO): Packets left to send: 0
2013-05-24T16:31:43.382Z,1369413103.382 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0006.lzma.parts/0000.sbd
2013-05-24T16:31:58.802Z,1369413118.802 [NAL9602](INFO): SBD MO Status=2, MOMSN=13296, MT Status=2, MTMSN=0
2013-05-24T16:31:58.802Z,1369413118.802 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-05-24T16:32:09.543Z,1369413129.543 [NAL9602](INFO): SBD MO Status=0, MOMSN=13296, MT Status=0, MTMSN=0
2013-05-24T16:32:13.157Z,1369413133.157 [Default:Iridium:Read_Iridium] Stopped
2013-05-24T16:32:13.158Z,1369413133.158 [Default:Iridium](INFO): Completed Default:Iridium
2013-05-24T16:32:13.158Z,1369413133.158 [Default:Iridium] Stopped
2013-05-24T16:32:13.158Z,1369413133.158 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-05-24T16:32:13.158Z,1369413133.158 [Default:Iridium:A.SetSpeed] Stopped
2013-05-24T16:32:13.158Z,1369413133.158 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:32:13.521Z,1369413133.522 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-05-24T16:32:13.522Z,1369413133.522 [Default:CallIridium:B] Stopped
2013-05-24T16:32:13.522Z,1369413133.522 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-05-24T16:32:13.522Z,1369413133.522 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-05-24T16:32:13.522Z,1369413133.522 [Default:CallIridium] Stopped
2013-05-24T16:32:13.522Z,1369413133.522 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-05-24T16:32:23.505Z,1369413143.505 [NAL9602](INFO): Powering down
2013-05-24T16:37:13.506Z,1369413433.506 [Default:CallIridium] Running Loop=1
2013-05-24T16:37:13.506Z,1369413433.506 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-05-24T16:37:13.506Z,1369413433.506 [Default:CallIridium:A] Running Loop=1
2013-05-24T16:37:13.507Z,1369413433.507 [Default:CallIridium:A] Stopped
2013-05-24T16:37:13.507Z,1369413433.507 [Default:CallIridium:B] Running Loop=1
2013-05-24T16:37:13.507Z,1369413433.507 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-05-24T16:37:18.477Z,1369413438.477 [Default:Iridium] Running Loop=1
2013-05-24T16:37:18.477Z,1369413438.477 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-05-24T16:37:18.477Z,1369413438.477 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-05-24T16:37:18.477Z,1369413438.477 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-05-24T16:37:18.477Z,1369413438.477 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-05-24T16:37:18.477Z,1369413438.477 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T16:37:18.478Z,1369413438.478 [Default:Iridium:B.GoToSurface] Stopped
2013-05-24T16:37:18.478Z,1369413438.478 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T16:37:18.478Z,1369413438.478 [Default:Iridium:Read_Iridium] Running Loop=1
2013-05-24T16:37:18.479Z,1369413438.478 [Default:GPS] Running Loop=1
2013-05-24T16:37:18.479Z,1369413438.479 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-05-24T16:37:18.479Z,1369413438.479 [Default:GPS:A.SetSpeed] Running Loop=1
2013-05-24T16:37:18.479Z,1369413438.479 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-05-24T16:37:18.479Z,1369413438.479 [Default:GPS:B.GoToSurface] Running Loop=1
2013-05-24T16:37:18.479Z,1369413438.479 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T16:37:18.480Z,1369413438.480 [Default:GPS:B.GoToSurface] Stopped
2013-05-24T16:37:18.480Z,1369413438.480 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T16:37:18.480Z,1369413438.480 [Default:GPS:Read_GPS] Running Loop=1
2013-05-24T16:37:19.174Z,1369413439.174 [NAL9602](INFO): Powering up
2013-05-24T16:37:30.024Z,1369413450.024 [NAL9602](INFO): NAL9602 initialized
2013-05-24T16:38:03.419Z,1369413483.419 [NAL9602](INFO): SBD MO Status=2, MOMSN=13297, MT Status=0, MTMSN=0
2013-05-24T16:38:03.419Z,1369413483.419 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-05-24T16:38:04.629Z,1369413484.629 [NAL9602](IMPORTANT): GPS fix at: 1369413717.00
2013-05-24T16:38:04.648Z,1369413484.648 [Default:GPS:Read_GPS] Stopped
2013-05-24T16:38:04.648Z,1369413484.648 [Default:GPS:D] Running Loop=1
2013-05-24T16:38:05.058Z,1369413485.058 [Default:GPS:D] Stopped
2013-05-24T16:38:05.058Z,1369413485.059 [Default:GPS](INFO): Completed Default:GPS
2013-05-24T16:38:05.059Z,1369413485.059 [Default:GPS] Stopped
2013-05-24T16:38:05.059Z,1369413485.059 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-05-24T16:38:05.059Z,1369413485.059 [Default:GPS:A.SetSpeed] Stopped
2013-05-24T16:38:05.059Z,1369413485.059 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:38:23.560Z,1369413503.560 [NAL9602](INFO): SBD MO Status=1, MOMSN=13297, MT Status=0, MTMSN=0
2013-05-24T16:38:23.612Z,1369413503.612 [NAL9602](INFO): Sent 212 bytes from file Logs/20130524T155322/shore0007.lzma
2013-05-24T16:38:23.613Z,1369413503.613 [NAL9602](INFO): Packets left to send: 0
2013-05-24T16:38:23.614Z,1369413503.614 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0007.lzma.parts/0000.sbd
2013-05-24T16:38:32.767Z,1369413512.767 [NAL9602](INFO): SBD MO Status=0, MOMSN=13298, MT Status=0, MTMSN=0
2013-05-24T16:38:36.368Z,1369413516.368 [Default:Iridium:Read_Iridium] Stopped
2013-05-24T16:38:36.368Z,1369413516.368 [Default:Iridium](INFO): Completed Default:Iridium
2013-05-24T16:38:36.369Z,1369413516.369 [Default:Iridium] Stopped
2013-05-24T16:38:36.369Z,1369413516.369 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-05-24T16:38:36.369Z,1369413516.369 [Default:Iridium:A.SetSpeed] Stopped
2013-05-24T16:38:36.369Z,1369413516.369 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:38:36.718Z,1369413516.718 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-05-24T16:38:36.718Z,1369413516.718 [Default:CallIridium:B] Stopped
2013-05-24T16:38:36.718Z,1369413516.718 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-05-24T16:38:36.718Z,1369413516.718 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-05-24T16:38:36.718Z,1369413516.718 [Default:CallIridium] Stopped
2013-05-24T16:38:36.719Z,1369413516.718 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-05-24T16:38:46.678Z,1369413526.678 [NAL9602](INFO): Powering down
2013-05-24T16:43:36.722Z,1369413816.722 [Default:CallIridium] Running Loop=1
2013-05-24T16:43:36.722Z,1369413816.722 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-05-24T16:43:36.722Z,1369413816.722 [Default:CallIridium:A] Running Loop=1
2013-05-24T16:43:36.723Z,1369413816.723 [Default:CallIridium:A] Stopped
2013-05-24T16:43:36.723Z,1369413816.723 [Default:CallIridium:B] Running Loop=1
2013-05-24T16:43:36.723Z,1369413816.723 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-05-24T16:43:41.712Z,1369413821.712 [Default:Iridium] Running Loop=1
2013-05-24T16:43:41.712Z,1369413821.712 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-05-24T16:43:41.712Z,1369413821.713 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-05-24T16:43:41.713Z,1369413821.713 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-05-24T16:43:41.713Z,1369413821.713 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-05-24T16:43:41.713Z,1369413821.713 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T16:43:41.714Z,1369413821.714 [Default:Iridium:B.GoToSurface] Stopped
2013-05-24T16:43:41.714Z,1369413821.714 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T16:43:41.714Z,1369413821.714 [Default:Iridium:Read_Iridium] Running Loop=1
2013-05-24T16:43:41.714Z,1369413821.714 [Default:GPS] Running Loop=1
2013-05-24T16:43:41.714Z,1369413821.714 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-05-24T16:43:41.715Z,1369413821.714 [Default:GPS:A.SetSpeed] Running Loop=1
2013-05-24T16:43:41.715Z,1369413821.714 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-05-24T16:43:41.715Z,1369413821.715 [Default:GPS:B.GoToSurface] Running Loop=1
2013-05-24T16:43:41.715Z,1369413821.715 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T16:43:41.715Z,1369413821.716 [Default:GPS:B.GoToSurface] Stopped
2013-05-24T16:43:41.716Z,1369413821.716 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T16:43:41.716Z,1369413821.716 [Default:GPS:Read_GPS] Running Loop=1
2013-05-24T16:43:42.370Z,1369413822.370 [NAL9602](INFO): Powering up
2013-05-24T16:43:53.236Z,1369413833.236 [NAL9602](INFO): NAL9602 initialized
2013-05-24T16:44:08.123Z,1369413848.123 [NAL9602](INFO): SBD MO Status=1, MOMSN=13299, MT Status=0, MTMSN=0
2013-05-24T16:44:08.172Z,1369413848.172 [NAL9602](INFO): Sent 201 bytes from file Logs/20130524T155322/shore0008.lzma
2013-05-24T16:44:08.173Z,1369413848.173 [NAL9602](INFO): Packets left to send: 0
2013-05-24T16:44:08.178Z,1369413848.178 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0008.lzma.parts/0000.sbd
2013-05-24T16:44:14.923Z,1369413854.923 [NAL9602](INFO): SBD MO Status=0, MOMSN=13300, MT Status=0, MTMSN=0
2013-05-24T16:44:18.600Z,1369413858.600 [Default:Iridium:Read_Iridium] Stopped
2013-05-24T16:44:18.601Z,1369413858.601 [Default:Iridium](INFO): Completed Default:Iridium
2013-05-24T16:44:18.601Z,1369413858.601 [Default:Iridium] Stopped
2013-05-24T16:44:18.601Z,1369413858.601 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-05-24T16:44:18.601Z,1369413858.601 [Default:Iridium:A.SetSpeed] Stopped
2013-05-24T16:44:18.601Z,1369413858.601 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:44:18.909Z,1369413858.909 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-05-24T16:44:18.909Z,1369413858.909 [Default:CallIridium:B] Stopped
2013-05-24T16:44:18.909Z,1369413858.909 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-05-24T16:44:18.910Z,1369413858.909 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-05-24T16:44:18.910Z,1369413858.910 [Default:CallIridium] Stopped
2013-05-24T16:44:18.910Z,1369413858.910 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-05-24T16:44:19.596Z,1369413859.596 [NAL9602](IMPORTANT): GPS fix at: 1369414092.00
2013-05-24T16:44:19.613Z,1369413859.612 [Default:GPS:Read_GPS] Stopped
2013-05-24T16:44:19.613Z,1369413859.613 [Default:GPS:D] Running Loop=1
2013-05-24T16:44:20.024Z,1369413860.024 [Default:GPS:D] Stopped
2013-05-24T16:44:20.025Z,1369413860.025 [Default:GPS](INFO): Completed Default:GPS
2013-05-24T16:44:20.025Z,1369413860.025 [Default:GPS] Stopped
2013-05-24T16:44:20.025Z,1369413860.025 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-05-24T16:44:20.025Z,1369413860.025 [Default:GPS:A.SetSpeed] Stopped
2013-05-24T16:44:20.025Z,1369413860.025 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:44:40.530Z,1369413880.530 [NAL9602](INFO): Powering down
2013-05-24T16:49:15.511Z,1369414155.511 [Default:CallIridium] Running Loop=1
2013-05-24T16:49:15.511Z,1369414155.511 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-05-24T16:49:15.511Z,1369414155.511 [Default:CallIridium:A] Running Loop=1
2013-05-24T16:49:15.511Z,1369414155.511 [Default:CallIridium:A] Stopped
2013-05-24T16:49:15.511Z,1369414155.511 [Default:CallIridium:B] Running Loop=1
2013-05-24T16:49:15.512Z,1369414155.511 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-05-24T16:49:20.537Z,1369414160.537 [Default:Iridium] Running Loop=1
2013-05-24T16:49:20.538Z,1369414160.537 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-05-24T16:49:20.538Z,1369414160.537 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-05-24T16:49:20.538Z,1369414160.538 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-05-24T16:49:20.538Z,1369414160.538 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-05-24T16:49:20.538Z,1369414160.538 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T16:49:20.539Z,1369414160.539 [Default:Iridium:B.GoToSurface] Stopped
2013-05-24T16:49:20.539Z,1369414160.539 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T16:49:20.539Z,1369414160.539 [Default:Iridium:Read_Iridium] Running Loop=1
2013-05-24T16:49:20.539Z,1369414160.539 [Default:GPS] Running Loop=1
2013-05-24T16:49:20.539Z,1369414160.539 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-05-24T16:49:20.539Z,1369414160.539 [Default:GPS:A.SetSpeed] Running Loop=1
2013-05-24T16:49:20.540Z,1369414160.540 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-05-24T16:49:20.540Z,1369414160.540 [Default:GPS:B.GoToSurface] Running Loop=1
2013-05-24T16:49:20.540Z,1369414160.540 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T16:49:20.541Z,1369414160.541 [Default:GPS:B.GoToSurface] Stopped
2013-05-24T16:49:20.541Z,1369414160.541 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T16:49:20.541Z,1369414160.541 [Default:GPS:Read_GPS] Running Loop=1
2013-05-24T16:49:21.188Z,1369414161.188 [NAL9602](INFO): Powering up
2013-05-24T16:49:31.624Z,1369414171.624 [NAL9602](INFO): NAL9602 initialized
2013-05-24T16:49:59.739Z,1369414199.739 [NAL9602](INFO): SBD MO Status=2, MOMSN=13301, MT Status=0, MTMSN=0
2013-05-24T16:49:59.739Z,1369414199.739 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-05-24T16:50:12.008Z,1369414212.008 [NAL9602](INFO): SBD MO Status=1, MOMSN=13301, MT Status=0, MTMSN=0
2013-05-24T16:50:12.056Z,1369414212.056 [NAL9602](INFO): Sent 202 bytes from file Logs/20130524T155322/shore0009.lzma
2013-05-24T16:50:12.057Z,1369414212.057 [NAL9602](INFO): Packets left to send: 0
2013-05-24T16:50:12.058Z,1369414212.058 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0009.lzma.parts/0000.sbd
2013-05-24T16:50:23.130Z,1369414223.129 [NAL9602](INFO): SBD MO Status=0, MOMSN=13302, MT Status=0, MTMSN=0
2013-05-24T16:50:26.713Z,1369414226.713 [Default:Iridium:Read_Iridium] Stopped
2013-05-24T16:50:26.714Z,1369414226.714 [Default:Iridium](INFO): Completed Default:Iridium
2013-05-24T16:50:26.714Z,1369414226.714 [Default:Iridium] Stopped
2013-05-24T16:50:26.714Z,1369414226.714 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-05-24T16:50:26.714Z,1369414226.714 [Default:Iridium:A.SetSpeed] Stopped
2013-05-24T16:50:26.714Z,1369414226.714 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:50:26.982Z,1369414226.982 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-05-24T16:50:26.982Z,1369414226.982 [Default:CallIridium:B] Stopped
2013-05-24T16:50:26.983Z,1369414226.983 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-05-24T16:50:26.983Z,1369414226.983 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-05-24T16:50:26.983Z,1369414226.983 [Default:CallIridium] Stopped
2013-05-24T16:50:26.983Z,1369414226.983 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-05-24T16:50:27.709Z,1369414227.708 [NAL9602](IMPORTANT): GPS fix at: 1369414461.00
2013-05-24T16:50:27.725Z,1369414227.725 [Default:GPS:Read_GPS] Stopped
2013-05-24T16:50:27.725Z,1369414227.725 [Default:GPS:D] Running Loop=1
2013-05-24T16:50:28.137Z,1369414228.137 [Default:GPS:D] Stopped
2013-05-24T16:50:28.138Z,1369414228.138 [Default:GPS](INFO): Completed Default:GPS
2013-05-24T16:50:28.138Z,1369414228.138 [Default:GPS] Stopped
2013-05-24T16:50:28.138Z,1369414228.138 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-05-24T16:50:28.138Z,1369414228.138 [Default:GPS:A.SetSpeed] Stopped
2013-05-24T16:50:28.138Z,1369414228.138 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:50:48.650Z,1369414248.650 [NAL9602](INFO): Powering down
2013-05-24T16:55:23.661Z,1369414523.661 [Default:CallIridium] Running Loop=1
2013-05-24T16:55:23.662Z,1369414523.662 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-05-24T16:55:23.662Z,1369414523.662 [Default:CallIridium:A] Running Loop=1
2013-05-24T16:55:23.662Z,1369414523.662 [Default:CallIridium:A] Stopped
2013-05-24T16:55:23.662Z,1369414523.662 [Default:CallIridium:B] Running Loop=1
2013-05-24T16:55:23.662Z,1369414523.662 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-05-24T16:55:28.607Z,1369414528.607 [Default:Iridium] Running Loop=1
2013-05-24T16:55:28.607Z,1369414528.607 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-05-24T16:55:28.607Z,1369414528.607 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-05-24T16:55:28.607Z,1369414528.607 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-05-24T16:55:28.607Z,1369414528.607 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-05-24T16:55:28.608Z,1369414528.608 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T16:55:28.609Z,1369414528.609 [Default:Iridium:B.GoToSurface] Stopped
2013-05-24T16:55:28.609Z,1369414528.609 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T16:55:28.609Z,1369414528.609 [Default:Iridium:Read_Iridium] Running Loop=1
2013-05-24T16:55:28.609Z,1369414528.609 [Default:GPS] Running Loop=1
2013-05-24T16:55:28.609Z,1369414528.609 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-05-24T16:55:28.609Z,1369414528.609 [Default:GPS:A.SetSpeed] Running Loop=1
2013-05-24T16:55:28.609Z,1369414528.609 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-05-24T16:55:28.610Z,1369414528.610 [Default:GPS:B.GoToSurface] Running Loop=1
2013-05-24T16:55:28.610Z,1369414528.610 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T16:55:28.610Z,1369414528.611 [Default:GPS:B.GoToSurface] Stopped
2013-05-24T16:55:28.611Z,1369414528.611 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T16:55:28.611Z,1369414528.611 [Default:GPS:Read_GPS] Running Loop=1
2013-05-24T16:55:29.305Z,1369414529.305 [NAL9602](INFO): Powering up
2013-05-24T16:55:40.140Z,1369414540.140 [NAL9602](INFO): NAL9602 initialized
2013-05-24T16:56:01.071Z,1369414561.071 [NAL9602](INFO): SBD MO Status=1, MOMSN=13303, MT Status=0, MTMSN=0
2013-05-24T16:56:01.124Z,1369414561.124 [NAL9602](INFO): Sent 212 bytes from file Logs/20130524T155322/shore0010.lzma
2013-05-24T16:56:01.125Z,1369414561.125 [NAL9602](INFO): Packets left to send: 0
2013-05-24T16:56:01.126Z,1369414561.126 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0010.lzma.parts/0000.sbd
2013-05-24T16:56:11.471Z,1369414571.471 [NAL9602](INFO): SBD MO Status=0, MOMSN=13304, MT Status=0, MTMSN=0
2013-05-24T16:56:15.126Z,1369414575.126 [Default:Iridium:Read_Iridium] Stopped
2013-05-24T16:56:15.126Z,1369414575.126 [Default:Iridium](INFO): Completed Default:Iridium
2013-05-24T16:56:15.127Z,1369414575.127 [Default:Iridium] Stopped
2013-05-24T16:56:15.127Z,1369414575.127 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-05-24T16:56:15.127Z,1369414575.127 [Default:Iridium:A.SetSpeed] Stopped
2013-05-24T16:56:15.127Z,1369414575.127 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:56:15.474Z,1369414575.474 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-05-24T16:56:15.474Z,1369414575.474 [Default:CallIridium:B] Stopped
2013-05-24T16:56:15.474Z,1369414575.474 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-05-24T16:56:15.474Z,1369414575.474 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-05-24T16:56:15.474Z,1369414575.474 [Default:CallIridium] Stopped
2013-05-24T16:56:15.474Z,1369414575.474 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-05-24T16:56:16.124Z,1369414576.124 [NAL9602](IMPORTANT): GPS fix at: 1369414810.00
2013-05-24T16:56:16.140Z,1369414576.140 [Default:GPS:Read_GPS] Stopped
2013-05-24T16:56:16.140Z,1369414576.141 [Default:GPS:D] Running Loop=1
2013-05-24T16:56:16.548Z,1369414576.548 [Default:GPS:D] Stopped
2013-05-24T16:56:16.549Z,1369414576.549 [Default:GPS](INFO): Completed Default:GPS
2013-05-24T16:56:16.549Z,1369414576.549 [Default:GPS] Stopped
2013-05-24T16:56:16.549Z,1369414576.549 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-05-24T16:56:16.549Z,1369414576.549 [Default:GPS:A.SetSpeed] Stopped
2013-05-24T16:56:16.549Z,1369414576.549 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T16:56:37.046Z,1369414597.046 [NAL9602](INFO): Powering down
2013-05-24T16:58:02.005Z,1369414682.005 [Radio_Freewave](FAULT): LCB fault:  Invalid Command. Hardware Overcurrent Shutdown. Current Limiter Activated.
2013-05-24T16:58:02.005Z,1369414682.005 [Radio_Freewave] Hardware Fault, FailCount= 1
2013-05-24T16:58:02.005Z,1369414682.005 [Radio_Freewave](ERROR): Hardware Fault
2013-05-24T16:58:02.024Z,1369414682.024 [CBIT](ERROR): Hardware Fault in component: Radio_Freewave
2013-05-24T16:58:07.118Z,1369414687.118 [Radio_Freewave](INFO): Powering down
2013-05-24T16:58:12.031Z,1369414692.031 [Radio_Freewave](FAULT): LCB fault:  Software Overcurrent.
2013-05-24T16:58:17.034Z,1369414697.034 [Radio_Freewave](INFO): Powering up
2013-05-24T16:58:17.056Z,1369414697.056 [CBIT](INFO): Clearing failed state for component Radio_Freewave
2013-05-24T16:58:17.056Z,1369414697.056 [Radio_Freewave] No Fault, FailCount= 1
2013-05-24T17:01:12.082Z,1369414872.082 [Default:CallIridium] Running Loop=1
2013-05-24T17:01:12.083Z,1369414872.082 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-05-24T17:01:12.083Z,1369414872.083 [Default:CallIridium:A] Running Loop=1
2013-05-24T17:01:12.083Z,1369414872.083 [Default:CallIridium:A] Stopped
2013-05-24T17:01:12.083Z,1369414872.083 [Default:CallIridium:B] Running Loop=1
2013-05-24T17:01:12.083Z,1369414872.083 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-05-24T17:01:17.055Z,1369414877.055 [Default:Iridium] Running Loop=1
2013-05-24T17:01:17.056Z,1369414877.056 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-05-24T17:01:17.056Z,1369414877.056 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-05-24T17:01:17.056Z,1369414877.056 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-05-24T17:01:17.056Z,1369414877.056 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-05-24T17:01:17.056Z,1369414877.056 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T17:01:17.057Z,1369414877.057 [Default:Iridium:B.GoToSurface] Stopped
2013-05-24T17:01:17.057Z,1369414877.057 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T17:01:17.057Z,1369414877.057 [Default:Iridium:Read_Iridium] Running Loop=1
2013-05-24T17:01:17.058Z,1369414877.057 [Default:GPS] Running Loop=1
2013-05-24T17:01:17.058Z,1369414877.058 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-05-24T17:01:17.058Z,1369414877.058 [Default:GPS:A.SetSpeed] Running Loop=1
2013-05-24T17:01:17.058Z,1369414877.058 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-05-24T17:01:17.058Z,1369414877.058 [Default:GPS:B.GoToSurface] Running Loop=1
2013-05-24T17:01:17.058Z,1369414877.058 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T17:01:17.059Z,1369414877.059 [Default:GPS:B.GoToSurface] Stopped
2013-05-24T17:01:17.059Z,1369414877.059 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T17:01:17.059Z,1369414877.059 [Default:GPS:Read_GPS] Running Loop=1
2013-05-24T17:01:17.749Z,1369414877.749 [NAL9602](INFO): Powering up
2013-05-24T17:01:28.548Z,1369414888.548 [NAL9602](INFO): NAL9602 initialized
2013-05-24T17:01:52.351Z,1369414912.351 [NAL9602](INFO): SBD MO Status=1, MOMSN=13305, MT Status=0, MTMSN=0
2013-05-24T17:01:52.400Z,1369414912.400 [NAL9602](INFO): Sent 332 bytes from file Logs/20130524T155322/shore0011.lzma
2013-05-24T17:01:52.401Z,1369414912.401 [NAL9602](INFO): Packets left to send: 1
2013-05-24T17:01:52.402Z,1369414912.402 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0011.lzma.parts/0001.sbd
2013-05-24T17:02:13.727Z,1369414933.727 [NAL9602](INFO): SBD MO Status=1, MOMSN=13306, MT Status=0, MTMSN=0
2013-05-24T17:02:13.776Z,1369414933.776 [NAL9602](INFO): Sent 7 bytes from file Logs/20130524T155322/shore0011.lzma
2013-05-24T17:02:13.777Z,1369414933.777 [NAL9602](INFO): Packets left to send: 0
2013-05-24T17:02:13.778Z,1369414933.778 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0011.lzma.parts/0000.sbd
2013-05-24T17:02:24.123Z,1369414944.123 [NAL9602](INFO): SBD MO Status=0, MOMSN=13307, MT Status=0, MTMSN=0
2013-05-24T17:02:27.908Z,1369414947.908 [Default:Iridium:Read_Iridium] Stopped
2013-05-24T17:02:27.909Z,1369414947.908 [Default:Iridium](INFO): Completed Default:Iridium
2013-05-24T17:02:27.909Z,1369414947.909 [Default:Iridium] Stopped
2013-05-24T17:02:27.909Z,1369414947.909 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-05-24T17:02:27.909Z,1369414947.909 [Default:Iridium:A.SetSpeed] Stopped
2013-05-24T17:02:27.909Z,1369414947.909 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T17:02:28.247Z,1369414948.247 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-05-24T17:02:28.247Z,1369414948.247 [Default:CallIridium:B] Stopped
2013-05-24T17:02:28.247Z,1369414948.247 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-05-24T17:02:28.248Z,1369414948.248 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-05-24T17:02:28.248Z,1369414948.248 [Default:CallIridium] Stopped
2013-05-24T17:02:28.248Z,1369414948.248 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-05-24T17:02:31.312Z,1369414951.312 [NAL9602](IMPORTANT): GPS fix at: 1369415186.00
2013-05-24T17:02:31.327Z,1369414951.327 [Default:GPS:Read_GPS] Stopped
2013-05-24T17:02:31.327Z,1369414951.327 [Default:GPS:D] Running Loop=1
2013-05-24T17:02:31.729Z,1369414951.730 [Default:GPS:D] Stopped
2013-05-24T17:02:31.730Z,1369414951.730 [Default:GPS](INFO): Completed Default:GPS
2013-05-24T17:02:31.730Z,1369414951.730 [Default:GPS] Stopped
2013-05-24T17:02:31.730Z,1369414951.730 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-05-24T17:02:31.730Z,1369414951.730 [Default:GPS:A.SetSpeed] Stopped
2013-05-24T17:02:31.730Z,1369414951.730 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T17:02:52.234Z,1369414972.234 [NAL9602](INFO): Powering down
2013-05-24T17:07:27.245Z,1369415247.245 [Default:CallIridium] Running Loop=1
2013-05-24T17:07:27.245Z,1369415247.246 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-05-24T17:07:27.246Z,1369415247.246 [Default:CallIridium:A] Running Loop=1
2013-05-24T17:07:27.246Z,1369415247.246 [Default:CallIridium:A] Stopped
2013-05-24T17:07:27.246Z,1369415247.246 [Default:CallIridium:B] Running Loop=1
2013-05-24T17:07:27.246Z,1369415247.246 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-05-24T17:07:32.255Z,1369415252.255 [Default:Iridium] Running Loop=1
2013-05-24T17:07:32.255Z,1369415252.255 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-05-24T17:07:32.255Z,1369415252.255 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-05-24T17:07:32.255Z,1369415252.255 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-05-24T17:07:32.255Z,1369415252.255 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-05-24T17:07:32.255Z,1369415252.256 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T17:07:32.257Z,1369415252.257 [Default:Iridium:B.GoToSurface] Stopped
2013-05-24T17:07:32.257Z,1369415252.257 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T17:07:32.257Z,1369415252.257 [Default:Iridium:Read_Iridium] Running Loop=1
2013-05-24T17:07:32.257Z,1369415252.257 [Default:GPS] Running Loop=1
2013-05-24T17:07:32.257Z,1369415252.257 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-05-24T17:07:32.257Z,1369415252.257 [Default:GPS:A.SetSpeed] Running Loop=1
2013-05-24T17:07:32.257Z,1369415252.257 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-05-24T17:07:32.258Z,1369415252.258 [Default:GPS:B.GoToSurface] Running Loop=1
2013-05-24T17:07:32.258Z,1369415252.258 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T17:07:32.259Z,1369415252.259 [Default:GPS:B.GoToSurface] Stopped
2013-05-24T17:07:32.259Z,1369415252.259 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T17:07:32.259Z,1369415252.259 [Default:GPS:Read_GPS] Running Loop=1
2013-05-24T17:07:32.900Z,1369415252.900 [NAL9602](INFO): Powering up
2013-05-24T17:07:43.336Z,1369415263.336 [NAL9602](INFO): NAL9602 initialized
2013-05-24T17:08:18.651Z,1369415298.651 [NAL9602](INFO): SBD MO Status=2, MOMSN=13308, MT Status=2, MTMSN=0
2013-05-24T17:08:18.651Z,1369415298.651 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-05-24T17:08:36.855Z,1369415316.855 [NAL9602](INFO): SBD MO Status=1, MOMSN=13308, MT Status=0, MTMSN=0
2013-05-24T17:08:36.905Z,1369415316.905 [NAL9602](INFO): Sent 208 bytes from file Logs/20130524T155322/shore0012.lzma
2013-05-24T17:08:36.905Z,1369415316.905 [NAL9602](INFO): Packets left to send: 0
2013-05-24T17:08:36.912Z,1369415316.912 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0012.lzma.parts/0000.sbd
2013-05-24T17:08:47.611Z,1369415327.611 [NAL9602](INFO): SBD MO Status=0, MOMSN=13309, MT Status=0, MTMSN=0
2013-05-24T17:08:51.255Z,1369415331.255 [Default:Iridium:Read_Iridium] Stopped
2013-05-24T17:08:51.255Z,1369415331.255 [Default:Iridium](INFO): Completed Default:Iridium
2013-05-24T17:08:51.255Z,1369415331.255 [Default:Iridium] Stopped
2013-05-24T17:08:51.256Z,1369415331.256 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-05-24T17:08:51.256Z,1369415331.256 [Default:Iridium:A.SetSpeed] Stopped
2013-05-24T17:08:51.256Z,1369415331.256 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T17:08:51.545Z,1369415331.545 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-05-24T17:08:51.545Z,1369415331.545 [Default:CallIridium:B] Stopped
2013-05-24T17:08:51.545Z,1369415331.546 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-05-24T17:08:51.546Z,1369415331.546 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-05-24T17:08:51.546Z,1369415331.546 [Default:CallIridium] Stopped
2013-05-24T17:08:51.546Z,1369415331.546 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-05-24T17:10:00.652Z,1369415400.652 [NAL9602](IMPORTANT): GPS fix at: 1369415637.00
2013-05-24T17:10:00.669Z,1369415400.669 [Default:GPS:Read_GPS] Stopped
2013-05-24T17:10:00.669Z,1369415400.669 [Default:GPS:D] Running Loop=1
2013-05-24T17:10:01.073Z,1369415401.073 [Default:GPS:D] Stopped
2013-05-24T17:10:01.073Z,1369415401.073 [Default:GPS](INFO): Completed Default:GPS
2013-05-24T17:10:01.073Z,1369415401.073 [Default:GPS] Stopped
2013-05-24T17:10:01.073Z,1369415401.073 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-05-24T17:10:01.074Z,1369415401.074 [Default:GPS:A.SetSpeed] Stopped
2013-05-24T17:10:01.074Z,1369415401.074 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T17:10:21.590Z,1369415421.590 [NAL9602](INFO): Powering down
2013-05-24T17:13:51.614Z,1369415631.614 [Default:CallIridium] Running Loop=1
2013-05-24T17:13:51.615Z,1369415631.615 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-05-24T17:13:51.615Z,1369415631.615 [Default:CallIridium:A] Running Loop=1
2013-05-24T17:13:51.615Z,1369415631.615 [Default:CallIridium:A] Stopped
2013-05-24T17:13:51.615Z,1369415631.615 [Default:CallIridium:B] Running Loop=1
2013-05-24T17:13:51.615Z,1369415631.615 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-05-24T17:13:56.616Z,1369415636.616 [Default:Iridium] Running Loop=1
2013-05-24T17:13:56.616Z,1369415636.616 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-05-24T17:13:56.617Z,1369415636.616 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-05-24T17:13:56.617Z,1369415636.616 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-05-24T17:13:56.617Z,1369415636.617 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-05-24T17:13:56.617Z,1369415636.617 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T17:13:56.618Z,1369415636.618 [Default:Iridium:B.GoToSurface] Stopped
2013-05-24T17:13:56.618Z,1369415636.618 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T17:13:56.618Z,1369415636.618 [Default:Iridium:Read_Iridium] Running Loop=1
2013-05-24T17:13:56.618Z,1369415636.618 [Default:GPS] Running Loop=1
2013-05-24T17:13:56.618Z,1369415636.618 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-05-24T17:13:56.618Z,1369415636.618 [Default:GPS:A.SetSpeed] Running Loop=1
2013-05-24T17:13:56.618Z,1369415636.618 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-05-24T17:13:56.619Z,1369415636.619 [Default:GPS:B.GoToSurface] Running Loop=1
2013-05-24T17:13:56.619Z,1369415636.619 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T17:13:56.619Z,1369415636.619 [Default:GPS:B.GoToSurface] Stopped
2013-05-24T17:13:56.620Z,1369415636.620 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T17:13:56.620Z,1369415636.620 [Default:GPS:Read_GPS] Running Loop=1
2013-05-24T17:13:57.249Z,1369415637.249 [NAL9602](INFO): Powering up
2013-05-24T17:14:08.080Z,1369415648.080 [NAL9602](INFO): NAL9602 initialized
2013-05-24T17:14:21.187Z,1369415661.187 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:14:23.591Z,1369415663.591 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:14:25.983Z,1369415665.983 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:14:28.307Z,1369415668.307 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:14:30.706Z,1369415670.706 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:14:33.109Z,1369415673.109 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:14:35.514Z,1369415675.514 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:14:37.832Z,1369415677.832 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:14:40.210Z,1369415680.210 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:14:43.264Z,1369415683.264 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:14:45.264Z,1369415685.263 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:14:47.602Z,1369415687.602 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:14:50.006Z,1369415690.006 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:14:52.405Z,1369415692.405 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:14:54.823Z,1369415694.823 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:14:57.206Z,1369415697.206 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:14:59.523Z,1369415699.523 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:15:01.927Z,1369415701.927 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:15:04.323Z,1369415704.323 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:15:06.679Z,1369415706.679 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:15:09.405Z,1369415709.405 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:15:11.405Z,1369415711.405 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:15:13.810Z,1369415713.810 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:15:16.206Z,1369415716.206 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:15:18.524Z,1369415718.524 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:15:20.820Z,1369415720.820 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:15:23.206Z,1369415723.206 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:15:25.605Z,1369415725.605 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:15:28.012Z,1369415728.012 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:15:30.401Z,1369415730.401 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:15:32.810Z,1369415732.810 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#8 STATUS: 65535
2013-05-24T17:15:34.397Z,1369415734.397 [NAL9602](INFO): SBD MO Status=1, MOMSN=13310, MT Status=0, MTMSN=0
2013-05-24T17:15:34.444Z,1369415734.444 [NAL9602](INFO): Sent 211 bytes from file Logs/20130524T155322/shore0013.lzma
2013-05-24T17:15:34.445Z,1369415734.445 [NAL9602](INFO): Packets left to send: 0
2013-05-24T17:15:34.446Z,1369415734.446 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0013.lzma.parts/0000.sbd
2013-05-24T17:15:44.397Z,1369415744.397 [NAL9602](INFO): SBD MO Status=0, MOMSN=13311, MT Status=0, MTMSN=0
2013-05-24T17:15:47.988Z,1369415747.988 [Default:Iridium:Read_Iridium] Stopped
2013-05-24T17:15:47.988Z,1369415747.988 [Default:Iridium](INFO): Completed Default:Iridium
2013-05-24T17:15:47.988Z,1369415747.989 [Default:Iridium] Stopped
2013-05-24T17:15:47.989Z,1369415747.989 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-05-24T17:15:47.989Z,1369415747.989 [Default:Iridium:A.SetSpeed] Stopped
2013-05-24T17:15:47.989Z,1369415747.989 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T17:15:48.350Z,1369415748.350 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-05-24T17:15:48.350Z,1369415748.350 [Default:CallIridium:B] Stopped
2013-05-24T17:15:48.350Z,1369415748.350 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-05-24T17:15:48.350Z,1369415748.350 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-05-24T17:15:48.350Z,1369415748.351 [Default:CallIridium] Stopped
2013-05-24T17:15:48.351Z,1369415748.351 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-05-24T17:15:49.004Z,1369415749.004 [NAL9602](IMPORTANT): GPS fix at: 1369415985.00
2013-05-24T17:15:49.021Z,1369415749.021 [Default:GPS:Read_GPS] Stopped
2013-05-24T17:15:49.021Z,1369415749.021 [Default:GPS:D] Running Loop=1
2013-05-24T17:15:49.424Z,1369415749.424 [Default:GPS:D] Stopped
2013-05-24T17:15:49.425Z,1369415749.425 [Default:GPS](INFO): Completed Default:GPS
2013-05-24T17:15:49.425Z,1369415749.425 [Default:GPS] Stopped
2013-05-24T17:15:49.425Z,1369415749.425 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-05-24T17:15:49.425Z,1369415749.425 [Default:GPS:A.SetSpeed] Stopped
2013-05-24T17:15:49.425Z,1369415749.425 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T17:16:09.930Z,1369415769.930 [NAL9602](INFO): Powering down
2013-05-24T17:20:44.969Z,1369416044.969 [Default:CallIridium] Running Loop=1
2013-05-24T17:20:44.970Z,1369416044.970 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-05-24T17:20:44.970Z,1369416044.970 [Default:CallIridium:A] Running Loop=1
2013-05-24T17:20:44.970Z,1369416044.970 [Default:CallIridium:A] Stopped
2013-05-24T17:20:44.970Z,1369416044.970 [Default:CallIridium:B] Running Loop=1
2013-05-24T17:20:44.970Z,1369416044.970 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-05-24T17:20:49.938Z,1369416049.938 [Default:Iridium] Running Loop=1
2013-05-24T17:20:49.938Z,1369416049.938 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-05-24T17:20:49.938Z,1369416049.938 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-05-24T17:20:49.938Z,1369416049.938 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-05-24T17:20:49.938Z,1369416049.938 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-05-24T17:20:49.938Z,1369416049.938 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T17:20:49.939Z,1369416049.939 [Default:Iridium:B.GoToSurface] Stopped
2013-05-24T17:20:49.939Z,1369416049.939 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T17:20:49.939Z,1369416049.939 [Default:Iridium:Read_Iridium] Running Loop=1
2013-05-24T17:20:49.940Z,1369416049.940 [Default:GPS] Running Loop=1
2013-05-24T17:20:49.940Z,1369416049.940 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-05-24T17:20:49.940Z,1369416049.940 [Default:GPS:A.SetSpeed] Running Loop=1
2013-05-24T17:20:49.940Z,1369416049.940 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-05-24T17:20:49.941Z,1369416049.941 [Default:GPS:B.GoToSurface] Running Loop=1
2013-05-24T17:20:49.941Z,1369416049.941 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T17:20:49.941Z,1369416049.941 [Default:GPS:B.GoToSurface] Stopped
2013-05-24T17:20:49.941Z,1369416049.941 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T17:20:49.942Z,1369416049.942 [Default:GPS:Read_GPS] Running Loop=1
2013-05-24T17:20:50.626Z,1369416050.626 [NAL9602](INFO): Powering up
2013-05-24T17:21:01.432Z,1369416061.432 [NAL9602](INFO): NAL9602 initialized
2013-05-24T17:21:47.315Z,1369416107.315 [NAL9602](INFO): SBD MO Status=2, MOMSN=13312, MT Status=2, MTMSN=0
2013-05-24T17:21:47.315Z,1369416107.315 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-05-24T17:21:48.512Z,1369416108.512 [NAL9602](IMPORTANT): GPS fix at: 1369416345.00
2013-05-24T17:21:48.529Z,1369416108.529 [Default:GPS:Read_GPS] Stopped
2013-05-24T17:21:48.529Z,1369416108.529 [Default:GPS:D] Running Loop=1
2013-05-24T17:21:48.946Z,1369416108.946 [Default:GPS:D] Stopped
2013-05-24T17:21:48.946Z,1369416108.946 [Default:GPS](INFO): Completed Default:GPS
2013-05-24T17:21:48.946Z,1369416108.946 [Default:GPS] Stopped
2013-05-24T17:21:48.946Z,1369416108.946 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-05-24T17:21:48.947Z,1369416108.947 [Default:GPS:A.SetSpeed] Stopped
2013-05-24T17:21:48.947Z,1369416108.947 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T17:22:16.971Z,1369416136.971 [NAL9602](INFO): SBD MO Status=1, MOMSN=13312, MT Status=0, MTMSN=0
2013-05-24T17:22:17.024Z,1369416137.024 [NAL9602](INFO): Sent 184 bytes from file Logs/20130524T155322/shore0014.lzma
2013-05-24T17:22:17.025Z,1369416137.025 [NAL9602](INFO): Packets left to send: 0
2013-05-24T17:22:17.026Z,1369416137.026 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0014.lzma.parts/0000.sbd
2013-05-24T17:22:27.371Z,1369416147.371 [NAL9602](INFO): SBD MO Status=0, MOMSN=13313, MT Status=0, MTMSN=0
2013-05-24T17:22:30.977Z,1369416150.977 [Default:Iridium:Read_Iridium] Stopped
2013-05-24T17:22:30.977Z,1369416150.977 [Default:Iridium](INFO): Completed Default:Iridium
2013-05-24T17:22:30.977Z,1369416150.977 [Default:Iridium] Stopped
2013-05-24T17:22:30.978Z,1369416150.977 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-05-24T17:22:30.978Z,1369416150.978 [Default:Iridium:A.SetSpeed] Stopped
2013-05-24T17:22:30.978Z,1369416150.978 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T17:22:31.323Z,1369416151.323 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-05-24T17:22:31.323Z,1369416151.323 [Default:CallIridium:B] Stopped
2013-05-24T17:22:31.323Z,1369416151.323 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-05-24T17:22:31.323Z,1369416151.323 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-05-24T17:22:31.323Z,1369416151.323 [Default:CallIridium] Stopped
2013-05-24T17:22:31.323Z,1369416151.323 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-05-24T17:22:41.326Z,1369416161.326 [NAL9602](INFO): Powering down
2013-05-24T17:27:31.285Z,1369416451.285 [Default:CallIridium] Running Loop=1
2013-05-24T17:27:31.285Z,1369416451.286 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-05-24T17:27:31.286Z,1369416451.286 [Default:CallIridium:A] Running Loop=1
2013-05-24T17:27:31.286Z,1369416451.286 [Default:CallIridium:A] Stopped
2013-05-24T17:27:31.286Z,1369416451.286 [Default:CallIridium:B] Running Loop=1
2013-05-24T17:27:31.286Z,1369416451.286 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-05-24T17:27:36.322Z,1369416456.322 [Default:Iridium] Running Loop=1
2013-05-24T17:27:36.322Z,1369416456.322 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-05-24T17:27:36.322Z,1369416456.322 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-05-24T17:27:36.322Z,1369416456.322 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-05-24T17:27:36.323Z,1369416456.323 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-05-24T17:27:36.323Z,1369416456.323 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T17:27:36.323Z,1369416456.323 [Default:Iridium:B.GoToSurface] Stopped
2013-05-24T17:27:36.324Z,1369416456.323 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T17:27:36.324Z,1369416456.324 [Default:Iridium:Read_Iridium] Running Loop=1
2013-05-24T17:27:36.324Z,1369416456.324 [Default:GPS] Running Loop=1
2013-05-24T17:27:36.324Z,1369416456.324 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-05-24T17:27:36.324Z,1369416456.325 [Default:GPS:A.SetSpeed] Running Loop=1
2013-05-24T17:27:36.325Z,1369416456.325 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-05-24T17:27:36.325Z,1369416456.325 [Default:GPS:B.GoToSurface] Running Loop=1
2013-05-24T17:27:36.325Z,1369416456.325 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T17:27:36.326Z,1369416456.326 [Default:GPS:B.GoToSurface] Stopped
2013-05-24T17:27:36.326Z,1369416456.326 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T17:27:36.326Z,1369416456.326 [Default:GPS:Read_GPS] Running Loop=1
2013-05-24T17:27:36.965Z,1369416456.966 [NAL9602](INFO): Powering up
2013-05-24T17:27:47.864Z,1369416467.864 [NAL9602](INFO): NAL9602 initialized
2013-05-24T17:28:24.867Z,1369416504.867 [NAL9602](INFO): SBD MO Status=2, MOMSN=13314, MT Status=2, MTMSN=0
2013-05-24T17:28:24.868Z,1369416504.868 [NAL9602](ERROR): Failed to initiate SBD session. Error code: 2
2013-05-24T17:35:36.048Z,1369416936.048 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T17:35:38.419Z,1369416938.419 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T17:35:40.764Z,1369416940.764 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T17:35:43.114Z,1369416943.114 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T17:35:45.828Z,1369416945.828 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T17:35:47.829Z,1369416947.829 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T17:35:50.203Z,1369416950.203 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T17:35:52.607Z,1369416952.607 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T17:35:54.923Z,1369416954.923 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T17:35:57.324Z,1369416957.325 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T17:36:00.041Z,1369416960.041 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T17:36:02.361Z,1369416962.361 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T17:36:04.753Z,1369416964.753 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T17:36:07.076Z,1369416967.076 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T17:36:09.530Z,1369416969.530 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T17:36:11.811Z,1369416971.811 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T17:36:14.204Z,1369416974.204 [Batt_Ocean_Server](INFO): Bus busy reported for battery bank#10 STATUS: 65535
2013-05-24T17:37:50.553Z,1369417070.553 [NAL9602](FAULT): GPS failed to acquire within timeout.
2013-05-24T17:37:50.554Z,1369417070.554 [NAL9602] Data Fault, FailCount= 1
2013-05-24T17:37:50.554Z,1369417070.554 [NAL9602](ERROR): Data Fault
2013-05-24T17:37:50.580Z,1369417070.580 [CBIT](ERROR): Data Fault in component: NAL9602
2013-05-24T17:37:50.925Z,1369417070.925 [NAL9602](INFO): Powering down
2013-05-24T17:37:51.746Z,1369417071.746 [CBIT](INFO): Clearing failed state for component NAL9602
2013-05-24T17:37:51.747Z,1369417071.747 [NAL9602] No Fault, FailCount= 1
2013-05-24T17:37:56.126Z,1369417076.126 [NAL9602](INFO): Powering up NAL9602
2013-05-24T17:38:07.044Z,1369417087.044 [NAL9602](INFO): NAL9602 initialized
2013-05-24T17:38:23.891Z,1369417103.891 [NAL9602](INFO): SBD MO Status=1, MOMSN=13314, MT Status=0, MTMSN=0
2013-05-24T17:38:23.940Z,1369417103.940 [NAL9602](INFO): Sent 182 bytes from file Logs/20130524T155322/shore0015.lzma
2013-05-24T17:38:23.941Z,1369417103.941 [NAL9602](INFO): Packets left to send: 0
2013-05-24T17:38:23.942Z,1369417103.942 [NAL9602](INFO): Stored copy of sent data in Logs/20130524T155322/shore0015.lzma.parts/0000.sbd
2013-05-24T17:38:35.091Z,1369417115.091 [NAL9602](INFO): SBD MO Status=0, MOMSN=13315, MT Status=0, MTMSN=0
2013-05-24T17:38:38.689Z,1369417118.689 [Default:Iridium:Read_Iridium] Stopped
2013-05-24T17:38:38.690Z,1369417118.690 [Default:Iridium](INFO): Completed Default:Iridium
2013-05-24T17:38:38.690Z,1369417118.690 [Default:Iridium] Stopped
2013-05-24T17:38:38.690Z,1369417118.690 [Default:Iridium](INFO): Aggregate::uninitialize Default:Iridium
2013-05-24T17:38:38.690Z,1369417118.690 [Default:Iridium:A.SetSpeed] Stopped
2013-05-24T17:38:38.690Z,1369417118.690 [Default:Iridium:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T17:38:39.052Z,1369417119.052 [Default:CallIridium:B](INFO): Completed Default:CallIridium:B
2013-05-24T17:38:39.052Z,1369417119.052 [Default:CallIridium:B] Stopped
2013-05-24T17:38:39.052Z,1369417119.052 [Default:CallIridium:B](INFO): Aggregate::uninitialize Default:CallIridium:B
2013-05-24T17:38:39.052Z,1369417119.053 [Default:CallIridium](INFO): Completed Default:CallIridium
2013-05-24T17:38:39.052Z,1369417119.053 [Default:CallIridium] Stopped
2013-05-24T17:38:39.053Z,1369417119.053 [Default:CallIridium](INFO): Aggregate::uninitialize Default:CallIridium
2013-05-24T17:40:09.782Z,1369417209.782 [NAL9602](IMPORTANT): GPS fix at: 1369417448.00
2013-05-24T17:40:09.820Z,1369417209.820 [Default:GPS:Read_GPS] Stopped
2013-05-24T17:40:09.820Z,1369417209.820 [Default:GPS:D] Running Loop=1
2013-05-24T17:40:10.128Z,1369417210.128 [Default:GPS:D] Stopped
2013-05-24T17:40:10.129Z,1369417210.129 [Default:GPS](INFO): Completed Default:GPS
2013-05-24T17:40:10.129Z,1369417210.129 [Default:GPS] Stopped
2013-05-24T17:40:10.129Z,1369417210.129 [Default:GPS](INFO): Aggregate::uninitialize Default:GPS
2013-05-24T17:40:10.129Z,1369417210.129 [Default:GPS:A.SetSpeed] Stopped
2013-05-24T17:40:10.129Z,1369417210.129 [Default:GPS:A.SetSpeed](DEBUG): Uninitialize.
2013-05-24T17:40:15.629Z,1369417215.629 [Depth_Keller](ERROR): Pressure reading out of range: 1830.551758 decibar
2013-05-24T17:40:25.649Z,1369417225.649 [Depth_Keller](ERROR): Pressure reading out of range: 1830.545654 decibar
2013-05-24T17:40:30.603Z,1369417230.603 [NAL9602](INFO): Powering down
2013-05-24T17:40:35.646Z,1369417235.645 [Depth_Keller](ERROR): Pressure reading out of range: 1830.557983 decibar
2013-05-24T17:40:45.646Z,1369417245.645 [Depth_Keller](ERROR): Pressure reading out of range: 1830.543945 decibar
2013-05-24T17:41:05.621Z,1369417265.621 [Depth_Keller](ERROR): Pressure reading out of range: 1830.521240 decibar
2013-05-24T17:41:15.625Z,1369417275.625 [Depth_Keller](ERROR): Pressure reading out of range: 1830.539673 decibar
2013-05-24T17:41:25.617Z,1369417285.617 [Depth_Keller](ERROR): Pressure reading out of range: 1830.541382 decibar
2013-05-24T17:41:45.622Z,1369417305.622 [Depth_Keller](ERROR): Pressure reading out of range: 1830.530029 decibar
2013-05-24T17:41:55.626Z,1369417315.625 [Depth_Keller](ERROR): Pressure reading out of range: 1830.550171 decibar
2013-05-24T17:42:05.622Z,1369417325.622 [Depth_Keller](ERROR): Pressure reading out of range: 1830.570068 decibar
2013-05-24T17:42:15.618Z,1369417335.618 [Depth_Keller](ERROR): Pressure reading out of range: 1830.575317 decibar
2013-05-24T17:42:25.626Z,1369417345.625 [Depth_Keller](ERROR): Pressure reading out of range: 1830.547485 decibar
2013-05-24T17:42:35.661Z,1369417355.661 [Depth_Keller](ERROR): Pressure reading out of range: 1830.547485 decibar
2013-05-24T17:42:45.637Z,1369417365.638 [Depth_Keller](ERROR): Pressure reading out of range: 1830.550903 decibar
2013-05-24T17:43:05.641Z,1369417385.641 [Depth_Keller](ERROR): Pressure reading out of range: 1830.539673 decibar
2013-05-24T17:43:15.646Z,1369417395.645 [Depth_Keller](ERROR): Pressure reading out of range: 1830.588501 decibar
2013-05-24T17:43:25.637Z,1369417405.638 [Depth_Keller](ERROR): Pressure reading out of range: 1830.518677 decibar
2013-05-24T17:43:35.637Z,1369417415.638 [Depth_Keller](ERROR): Pressure reading out of range: 1830.581421 decibar
2013-05-24T17:43:35.654Z,1369417415.654 [Default:CallIridium] Running Loop=1
2013-05-24T17:43:35.654Z,1369417415.654 [Default:CallIridium](INFO): Aggregate::initialize Default:CallIridium
2013-05-24T17:43:35.654Z,1369417415.654 [Default:CallIridium:A] Running Loop=1
2013-05-24T17:43:35.654Z,1369417415.654 [Default:CallIridium:A] Stopped
2013-05-24T17:43:35.655Z,1369417415.655 [Default:CallIridium:B] Running Loop=1
2013-05-24T17:43:35.655Z,1369417415.655 [Default:CallIridium:B](INFO): Aggregate::initialize Default:CallIridium:B
2013-05-24T17:43:40.666Z,1369417420.666 [Default:Iridium] Running Loop=1
2013-05-24T17:43:40.666Z,1369417420.666 [Default:Iridium](INFO): Aggregate::initialize Default:Iridium
2013-05-24T17:43:40.666Z,1369417420.666 [Default:Iridium:A.SetSpeed] Running Loop=1
2013-05-24T17:43:40.666Z,1369417420.666 [Default:Iridium:A.SetSpeed](DEBUG): Initialize.
2013-05-24T17:43:40.666Z,1369417420.666 [Default:Iridium:B.GoToSurface] Running Loop=1
2013-05-24T17:43:40.666Z,1369417420.666 [Default:Iridium:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T17:43:40.667Z,1369417420.667 [Default:Iridium:B.GoToSurface] Stopped
2013-05-24T17:43:40.667Z,1369417420.667 [Default:Iridium:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T17:43:40.667Z,1369417420.667 [Default:Iridium:Read_Iridium] Running Loop=1
2013-05-24T17:43:40.668Z,1369417420.668 [Default:GPS] Running Loop=1
2013-05-24T17:43:40.668Z,1369417420.668 [Default:GPS](INFO): Aggregate::initialize Default:GPS
2013-05-24T17:43:40.668Z,1369417420.668 [Default:GPS:A.SetSpeed] Running Loop=1
2013-05-24T17:43:40.668Z,1369417420.668 [Default:GPS:A.SetSpeed](DEBUG): Initialize.
2013-05-24T17:43:40.668Z,1369417420.668 [Default:GPS:B.GoToSurface] Running Loop=1
2013-05-24T17:43:40.669Z,1369417420.668 [Default:GPS:B.GoToSurface](DEBUG): Initialize GoToSurfaceComponent.
2013-05-24T17:43:40.669Z,1369417420.669 [Default:GPS:B.GoToSurface] Stopped
2013-05-24T17:43:40.669Z,1369417420.669 [Default:GPS:B.GoToSurface](DEBUG): Uninitialize GoToSurfaceComponent.
2013-05-24T17:43:40.669Z,1369417420.670 [Default:GPS:Read_GPS] Running Loop=1
2013-05-24T17:43:41.295Z,1369417421.295 [NAL9602](INFO): Powering up
2013-05-24T17:43:51.736Z,1369417431.736 [NAL9602](INFO): NAL9602 initialized
2013-05-24T17:53:54.564Z,1369418034.564 [NAL9602](FAULT): GPS failed to acquire within timeout.
2013-05-24T17:53:54.564Z,1369418034.564 [NAL9602] Data Fault, FailCount= 2
2013-05-24T17:53:54.564Z,1369418034.564 [NAL9602](ERROR): Data Fault
2013-05-24T17:53:54.591Z,1369418034.591 [CBIT](ERROR): Data Fault in component: NAL9602
2013-05-24T17:53:54.591Z,1369418034.592 [CBIT](CRITICAL): Data Fault in component: NAL9602
2013-05-24T17:53:54.966Z,1369418034.966 [NAL9602](INFO): Powering down
2013-05-24T17:53:55.364Z,1369418035.364 [NAL9602](FAULT): LCB fault:  Software Overcurrent.
2013-05-24T17:53:55.364Z,1369418035.365 [NAL9602] Hardware Fault, FailCount= 2
2013-05-24T17:53:55.365Z,1369418035.365 [NAL9602](ERROR): Hardware Fault
2013-05-24T17:55:54.589Z,1369418154.589 [CBIT](INFO): Clearing failed count for component NAL9602
2013-05-24T17:55:54.589Z,1369418154.589 [NAL9602] No Fault, FailCount= 2
2013-05-24T17:55:54.970Z,1369418154.970 [NAL9602](INFO): Powering up NAL9602
2013-05-24T17:56:05.400Z,1369418165.400 [NAL9602](INFO): NAL9602 initialized
2013-05-24T18:06:08.588Z,1369418768.588 [NAL9602](FAULT): GPS failed to acquire within timeout.
2013-05-24T18:06:08.589Z,1369418768.589 [NAL9602] Data Fault, FailCount= 1
2013-05-24T18:06:08.589Z,1369418768.589 [NAL9602](ERROR): Data Fault
2013-05-24T18:06:08.636Z,1369418768.636 [CBIT](ERROR): Data Fault in component: NAL9602
2013-05-24T18:06:08.989Z,1369418768.989 [NAL9602](INFO): Powering down
2013-05-24T18:06:09.821Z,1369418769.821 [CBIT](INFO): Clearing failed state for component NAL9602
2013-05-24T18:06:09.821Z,1369418769.821 [NAL9602] No Fault, FailCount= 1
2013-05-24T18:06:14.185Z,1369418774.185 [NAL9602](INFO): Powering up NAL9602
2013-05-24T18:06:24.660Z,1369418784.660 [NAL9602](INFO): NAL9602 initialized